{"level":"warn","ts":"2026-03-04T02:26:51.928575Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-04T02:26:51.928698Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.216: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.216:2380","--initial-cluster=instance=https://199.19.213.216:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.216:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.216:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-03-04T02:26:51.928779Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-04T02:26:51.92879Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.216:2380"]} {"level":"info","ts":"2026-03-04T02:26:51.928814Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-03-04T02:26:51.929513Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.216:2379"]} {"level":"info","ts":"2026-03-04T02:26:51.929596Z","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.216:2380"],"listen-peer-urls":["https://199.19.213.216:2380"],"advertise-client-urls":["https://199.19.213.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.216:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-03-04T02:26:51.933309Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.501991ms"} {"level":"info","ts":"2026-03-04T02:26:51.939682Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"58fa9386873601ed","cluster-id":"b3ae27d84cfabdf7"} {"level":"info","ts":"2026-03-04T02:26:51.939838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed switched to configuration voters=()"} {"level":"info","ts":"2026-03-04T02:26:51.939902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became follower at term 0"} {"level":"info","ts":"2026-03-04T02:26:51.939929Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 58fa9386873601ed [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-04T02:26:51.939947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became follower at term 1"} {"level":"info","ts":"2026-03-04T02:26:51.940023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed switched to configuration voters=(6411599225518686701)"} {"level":"warn","ts":"2026-03-04T02:26:51.951252Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-04T02:26:51.955218Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-04T02:26:51.956614Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-03-04T02:26:51.958807Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"58fa9386873601ed","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-04T02:26:51.959005Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"58fa9386873601ed","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-04T02:26:51.959079Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-04T02:26:51.959271Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-04T02:26:51.959308Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-04T02:26:51.962531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed switched to configuration voters=(6411599225518686701)"} {"level":"info","ts":"2026-03-04T02:26:51.962698Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b3ae27d84cfabdf7","local-member-id":"58fa9386873601ed","added-peer-id":"58fa9386873601ed","added-peer-peer-urls":["https://199.19.213.216:2380"]} {"level":"info","ts":"2026-03-04T02:26:51.964481Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-03-04T02:26:51.964551Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.216:2380"} {"level":"info","ts":"2026-03-04T02:26:51.964592Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.216:2380"} {"level":"info","ts":"2026-03-04T02:26:51.964805Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"58fa9386873601ed","initial-advertise-peer-urls":["https://199.19.213.216:2380"],"listen-peer-urls":["https://199.19.213.216:2380"],"advertise-client-urls":["https://199.19.213.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-04T02:26:51.965593Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-04T02:26:52.540676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed is starting a new election at term 1"} {"level":"info","ts":"2026-03-04T02:26:52.540799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became pre-candidate at term 1"} {"level":"info","ts":"2026-03-04T02:26:52.540841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed received MsgPreVoteResp from 58fa9386873601ed at term 1"} {"level":"info","ts":"2026-03-04T02:26:52.540873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became candidate at term 2"} {"level":"info","ts":"2026-03-04T02:26:52.540885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed received MsgVoteResp from 58fa9386873601ed at term 2"} {"level":"info","ts":"2026-03-04T02:26:52.540903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became leader at term 2"} {"level":"info","ts":"2026-03-04T02:26:52.540919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 58fa9386873601ed elected leader 58fa9386873601ed at term 2"} {"level":"info","ts":"2026-03-04T02:26:52.542991Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-04T02:26:52.54395Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-04T02:26:52.543954Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"58fa9386873601ed","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.216:2379]}","request-path":"/0/members/58fa9386873601ed/attributes","cluster-id":"b3ae27d84cfabdf7","publish-timeout":"7s"} {"level":"info","ts":"2026-03-04T02:26:52.544031Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-04T02:26:52.544236Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b3ae27d84cfabdf7","local-member-id":"58fa9386873601ed","cluster-version":"3.5"} {"level":"info","ts":"2026-03-04T02:26:52.544345Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-04T02:26:52.544384Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-04T02:26:52.544388Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-04T02:26:52.544439Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-04T02:26:52.551874Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.216:2379"} {"level":"info","ts":"2026-03-04T02:26:52.55322Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-04T02:27:05.499316Z","caller":"traceutil/trace.go:171","msg":"trace[1242894993] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"213.971599ms","start":"2026-03-04T02:27:05.285308Z","end":"2026-03-04T02:27:05.499279Z","steps":["trace[1242894993] 'process raft request' (duration: 213.760655ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:27:05.499595Z","caller":"traceutil/trace.go:171","msg":"trace[1923177157] linearizableReadLoop","detail":"{readStateIndex:414; appliedIndex:413; }","duration":"105.51965ms","start":"2026-03-04T02:27:05.394056Z","end":"2026-03-04T02:27:05.499576Z","steps":["trace[1923177157] 'read index received' (duration: 104.827796ms)","trace[1923177157] 'applied index is now lower than readState.Index' (duration: 359.677µs)"],"step_count":2} {"level":"warn","ts":"2026-03-04T02:27:05.499552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.429478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-04T02:27:05.49974Z","caller":"traceutil/trace.go:171","msg":"trace[17794882] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:401; }","duration":"105.714984ms","start":"2026-03-04T02:27:05.393998Z","end":"2026-03-04T02:27:05.499713Z","steps":["trace[17794882] 'agreement among raft nodes before linearized reading' (duration: 105.376377ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:27:32.646403Z","caller":"traceutil/trace.go:171","msg":"trace[2131084713] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"101.113897ms","start":"2026-03-04T02:27:32.545234Z","end":"2026-03-04T02:27:32.646348Z","steps":["trace[2131084713] 'process raft request' (duration: 100.582467ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:27:33.126366Z","caller":"traceutil/trace.go:171","msg":"trace[1102491089] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"232.310829ms","start":"2026-03-04T02:27:32.894025Z","end":"2026-03-04T02:27:33.126336Z","steps":["trace[1102491089] 'process raft request' (duration: 232.090984ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T02:28:02.355441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.637973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-04T02:28:02.355505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.663683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-04T02:28:02.35553Z","caller":"traceutil/trace.go:171","msg":"trace[1929925499] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:962; }","duration":"191.769625ms","start":"2026-03-04T02:28:02.163735Z","end":"2026-03-04T02:28:02.355504Z","steps":["trace[1929925499] 'range keys from in-memory index tree' (duration: 191.550781ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:28:02.355551Z","caller":"traceutil/trace.go:171","msg":"trace[374149899] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:962; }","duration":"191.746925ms","start":"2026-03-04T02:28:02.163787Z","end":"2026-03-04T02:28:02.355534Z","steps":["trace[374149899] 'count revisions from in-memory index tree' (duration: 191.580472ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T02:28:02.355407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.219476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-04T02:28:02.355895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.33263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-04T02:28:02.356058Z","caller":"traceutil/trace.go:171","msg":"trace[685453309] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:962; }","duration":"191.678864ms","start":"2026-03-04T02:28:02.164122Z","end":"2026-03-04T02:28:02.355801Z","steps":["trace[685453309] 'range keys from in-memory index tree' (duration: 191.137794ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:28:02.3561Z","caller":"traceutil/trace.go:171","msg":"trace[1231857216] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:962; }","duration":"156.635375ms","start":"2026-03-04T02:28:02.199447Z","end":"2026-03-04T02:28:02.356082Z","steps":["trace[1231857216] 'count revisions from in-memory index tree' (duration: 156.212418ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T02:29:00.593153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.112407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-03-04T02:29:00.593204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.008665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c194d164-4f07-4bdf-8266-606b85d6a709\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-03-04T02:29:00.593274Z","caller":"traceutil/trace.go:171","msg":"trace[1133337710] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1655; }","duration":"261.27271ms","start":"2026-03-04T02:29:00.331976Z","end":"2026-03-04T02:29:00.593249Z","steps":["trace[1133337710] 'range keys from in-memory index tree' (duration: 260.918563ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:29:00.593305Z","caller":"traceutil/trace.go:171","msg":"trace[1238752999] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c194d164-4f07-4bdf-8266-606b85d6a709; range_end:; response_count:1; response_revision:1655; }","duration":"221.142297ms","start":"2026-03-04T02:29:00.372141Z","end":"2026-03-04T02:29:00.593283Z","steps":["trace[1238752999] 'range keys from in-memory index tree' (duration: 220.859732ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T02:29:00.593081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.386998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-04T02:29:00.593416Z","caller":"traceutil/trace.go:171","msg":"trace[1375958968] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1655; }","duration":"229.822236ms","start":"2026-03-04T02:29:00.363571Z","end":"2026-03-04T02:29:00.593394Z","steps":["trace[1375958968] 'count revisions from in-memory index tree' (duration: 229.241346ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:29:00.607446Z","caller":"traceutil/trace.go:171","msg":"trace[809520838] transaction","detail":"{read_only:false; response_revision:1656; number_of_response:1; }","duration":"234.65825ms","start":"2026-03-04T02:29:00.37277Z","end":"2026-03-04T02:29:00.607428Z","steps":["trace[809520838] 'process raft request' (duration: 234.508107ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:29:00.641934Z","caller":"traceutil/trace.go:171","msg":"trace[1196709955] transaction","detail":"{read_only:false; response_revision:1657; number_of_response:1; }","duration":"187.506841ms","start":"2026-03-04T02:29:00.4544Z","end":"2026-03-04T02:29:00.641907Z","steps":["trace[1196709955] 'process raft request' (duration: 187.331438ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:29:00.642428Z","caller":"traceutil/trace.go:171","msg":"trace[76233488] transaction","detail":"{read_only:false; response_revision:1658; number_of_response:1; }","duration":"146.505639ms","start":"2026-03-04T02:29:00.495896Z","end":"2026-03-04T02:29:00.642401Z","steps":["trace[76233488] 'process raft request' (duration: 145.966659ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T02:29:51.404548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.821816ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-03-04T02:29:57.079206Z","caller":"traceutil/trace.go:171","msg":"trace[1424098022] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"100.121963ms","start":"2026-03-04T02:29:56.979041Z","end":"2026-03-04T02:29:57.079163Z","steps":["trace[1424098022] 'process raft request' (duration: 94.476298ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:30:47.469761Z","caller":"traceutil/trace.go:171","msg":"trace[879719651] transaction","detail":"{read_only:false; response_revision:2409; number_of_response:1; }","duration":"128.3009ms","start":"2026-03-04T02:30:47.341422Z","end":"2026-03-04T02:30:47.469723Z","steps":["trace[879719651] 'process raft request' (duration: 128.118406ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:31:20.705421Z","caller":"traceutil/trace.go:171","msg":"trace[983736010] transaction","detail":"{read_only:false; response_revision:2595; number_of_response:1; }","duration":"132.877254ms","start":"2026-03-04T02:31:20.572502Z","end":"2026-03-04T02:31:20.705379Z","steps":["trace[983736010] 'process raft request' (duration: 132.637299ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:35:49.791954Z","caller":"traceutil/trace.go:171","msg":"trace[1722208306] transaction","detail":"{read_only:false; response_revision:4969; number_of_response:1; }","duration":"136.800628ms","start":"2026-03-04T02:35:49.655096Z","end":"2026-03-04T02:35:49.791897Z","steps":["trace[1722208306] 'process raft request' (duration: 97.124849ms)","trace[1722208306] 'compare' (duration: 39.275593ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T02:35:50.273957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.071794ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-04T02:35:50.274164Z","caller":"traceutil/trace.go:171","msg":"trace[1103161822] linearizableReadLoop","detail":"{readStateIndex:5172; appliedIndex:5170; }","duration":"347.569492ms","start":"2026-03-04T02:35:49.926577Z","end":"2026-03-04T02:35:50.274146Z","steps":["trace[1103161822] 'read index received' (duration: 91.929569ms)","trace[1103161822] 'applied index is now lower than readState.Index' (duration: 255.638813ms)"],"step_count":2} {"level":"info","ts":"2026-03-04T02:35:50.274261Z","caller":"traceutil/trace.go:171","msg":"trace[2106459951] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"401.52819ms","start":"2026-03-04T02:35:49.872645Z","end":"2026-03-04T02:35:50.274174Z","steps":["trace[2106459951] 'process raft request' (duration: 401.424108ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:35:50.274336Z","caller":"traceutil/trace.go:171","msg":"trace[57879022] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"476.347661ms","start":"2026-03-04T02:35:49.797909Z","end":"2026-03-04T02:35:50.274257Z","steps":["trace[57879022] 'process raft request' (duration: 220.562325ms)","trace[57879022] 'compare' (duration: 254.3332ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T02:35:50.274441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.847007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-03-04T02:35:50.274526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T02:35:49.797878Z","time spent":"476.557834ms","remote":"127.0.0.1:56698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":687,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-04T02:35:50.274583Z","caller":"traceutil/trace.go:171","msg":"trace[1878211423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4974; }","duration":"348.04054ms","start":"2026-03-04T02:35:49.92652Z","end":"2026-03-04T02:35:50.274561Z","steps":["trace[1878211423] 'agreement among raft nodes before linearized reading' (duration: 347.712075ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T02:35:50.274641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T02:35:49.926495Z","time spent":"348.130021ms","remote":"127.0.0.1:56776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-04T02:35:50.274742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T02:35:49.8726Z","time spent":"401.775874ms","remote":"127.0.0.1:56776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-04T02:35:58.922278Z","caller":"traceutil/trace.go:171","msg":"trace[95070580] transaction","detail":"{read_only:false; response_revision:5110; number_of_response:1; }","duration":"106.891418ms","start":"2026-03-04T02:35:58.81533Z","end":"2026-03-04T02:35:58.922222Z","steps":["trace[95070580] 'process raft request' (duration: 106.677084ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:36:15.006005Z","caller":"traceutil/trace.go:171","msg":"trace[934052211] linearizableReadLoop","detail":"{readStateIndex:5511; appliedIndex:5510; }","duration":"103.115766ms","start":"2026-03-04T02:36:14.90285Z","end":"2026-03-04T02:36:15.005966Z","steps":["trace[934052211] 'read index received' (duration: 102.986024ms)","trace[934052211] 'applied index is now lower than readState.Index' (duration: 128.242µs)"],"step_count":2} {"level":"info","ts":"2026-03-04T02:36:15.006218Z","caller":"traceutil/trace.go:171","msg":"trace[100843785] transaction","detail":"{read_only:false; response_revision:5305; number_of_response:1; }","duration":"150.062466ms","start":"2026-03-04T02:36:14.856096Z","end":"2026-03-04T02:36:15.006158Z","steps":["trace[100843785] 'process raft request' (duration: 149.667749ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T02:36:15.006383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.513264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-03-04T02:36:15.006449Z","caller":"traceutil/trace.go:171","msg":"trace[1177759663] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5305; }","duration":"103.643347ms","start":"2026-03-04T02:36:14.902786Z","end":"2026-03-04T02:36:15.006429Z","steps":["trace[1177759663] 'agreement among raft nodes before linearized reading' (duration: 103.33486ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:36:15.11913Z","caller":"traceutil/trace.go:171","msg":"trace[841947189] transaction","detail":"{read_only:false; response_revision:5308; number_of_response:1; }","duration":"104.073665ms","start":"2026-03-04T02:36:15.015024Z","end":"2026-03-04T02:36:15.119098Z","steps":["trace[841947189] 'process raft request' (duration: 103.675727ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:36:15.119832Z","caller":"traceutil/trace.go:171","msg":"trace[1685446471] transaction","detail":"{read_only:false; response_revision:5309; number_of_response:1; }","duration":"104.817918ms","start":"2026-03-04T02:36:15.01499Z","end":"2026-03-04T02:36:15.119808Z","steps":["trace[1685446471] 'process raft request' (duration: 104.025484ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:36:15.119833Z","caller":"traceutil/trace.go:171","msg":"trace[485372207] transaction","detail":"{read_only:false; response_revision:5310; number_of_response:1; }","duration":"104.517173ms","start":"2026-03-04T02:36:15.015187Z","end":"2026-03-04T02:36:15.119704Z","steps":["trace[485372207] 'process raft request' (duration: 104.157516ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:36:52.57702Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2754} {"level":"info","ts":"2026-03-04T02:36:52.639452Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2754,"took":"60.436746ms","hash":3636268628,"current-db-size-bytes":40476672,"current-db-size":"40 MB","current-db-size-in-use-bytes":30195712,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-03-04T02:36:52.639544Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3636268628,"revision":2754,"compact-revision":-1} {"level":"info","ts":"2026-03-04T02:41:52.583962Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5623} {"level":"info","ts":"2026-03-04T02:41:52.66556Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5623,"took":"79.285915ms","hash":820003653,"current-db-size-bytes":40476672,"current-db-size":"40 MB","current-db-size-in-use-bytes":21762048,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-03-04T02:41:52.66563Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":820003653,"revision":5623,"compact-revision":2754} {"level":"info","ts":"2026-03-04T02:42:21.917316Z","caller":"traceutil/trace.go:171","msg":"trace[122314310] transaction","detail":"{read_only:false; response_revision:7866; number_of_response:1; }","duration":"136.327019ms","start":"2026-03-04T02:42:21.780953Z","end":"2026-03-04T02:42:21.91728Z","steps":["trace[122314310] 'process raft request' (duration: 136.270698ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:42:21.91735Z","caller":"traceutil/trace.go:171","msg":"trace[1157928424] transaction","detail":"{read_only:false; response_revision:7865; number_of_response:1; }","duration":"183.776088ms","start":"2026-03-04T02:42:21.733548Z","end":"2026-03-04T02:42:21.917324Z","steps":["trace[1157928424] 'process raft request' (duration: 177.223668ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:42:21.917575Z","caller":"traceutil/trace.go:171","msg":"trace[1986054525] linearizableReadLoop","detail":"{readStateIndex:8162; appliedIndex:8161; }","duration":"153.21952ms","start":"2026-03-04T02:42:21.764338Z","end":"2026-03-04T02:42:21.917557Z","steps":["trace[1986054525] 'read index received' (duration: 15.484774ms)","trace[1986054525] 'applied index is now lower than readState.Index' (duration: 137.732166ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T02:42:21.917851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.401183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-04T02:42:21.917911Z","caller":"traceutil/trace.go:171","msg":"trace[363606844] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:7866; }","duration":"153.597986ms","start":"2026-03-04T02:42:21.764294Z","end":"2026-03-04T02:42:21.917892Z","steps":["trace[363606844] 'agreement among raft nodes before linearized reading' (duration: 153.399052ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:42:34.017199Z","caller":"traceutil/trace.go:171","msg":"trace[787722024] linearizableReadLoop","detail":"{readStateIndex:8219; appliedIndex:8218; }","duration":"125.101924ms","start":"2026-03-04T02:42:33.89207Z","end":"2026-03-04T02:42:34.017172Z","steps":["trace[787722024] 'read index received' (duration: 124.90341ms)","trace[787722024] 'applied index is now lower than readState.Index' (duration: 197.524µs)"],"step_count":2} {"level":"info","ts":"2026-03-04T02:42:34.017257Z","caller":"traceutil/trace.go:171","msg":"trace[1774775486] transaction","detail":"{read_only:false; response_revision:7920; number_of_response:1; }","duration":"179.527282ms","start":"2026-03-04T02:42:33.837699Z","end":"2026-03-04T02:42:34.017226Z","steps":["trace[1774775486] 'process raft request' (duration: 179.308398ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T02:42:34.017385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.285897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-04T02:42:34.017434Z","caller":"traceutil/trace.go:171","msg":"trace[69585141] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:7920; }","duration":"125.386599ms","start":"2026-03-04T02:42:33.892035Z","end":"2026-03-04T02:42:34.017422Z","steps":["trace[69585141] 'agreement among raft nodes before linearized reading' (duration: 125.285177ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:42:34.096857Z","caller":"traceutil/trace.go:171","msg":"trace[1720834232] transaction","detail":"{read_only:false; response_revision:7921; number_of_response:1; }","duration":"135.503703ms","start":"2026-03-04T02:42:33.961311Z","end":"2026-03-04T02:42:34.096815Z","steps":["trace[1720834232] 'process raft request' (duration: 135.249689ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T02:42:34.097223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.346936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-03-04T02:42:34.097288Z","caller":"traceutil/trace.go:171","msg":"trace[1054877552] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7922; }","duration":"126.493969ms","start":"2026-03-04T02:42:33.970783Z","end":"2026-03-04T02:42:34.097277Z","steps":["trace[1054877552] 'agreement among raft nodes before linearized reading' (duration: 126.244384ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T02:42:34.097454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.35463ms","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-03-04T02:42:34.09756Z","caller":"traceutil/trace.go:171","msg":"trace[1812035789] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7922; }","duration":"118.527412ms","start":"2026-03-04T02:42:33.979005Z","end":"2026-03-04T02:42:34.097532Z","steps":["trace[1812035789] 'agreement among raft nodes before linearized reading' (duration: 118.165566ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:43:15.986436Z","caller":"traceutil/trace.go:171","msg":"trace[948009423] linearizableReadLoop","detail":"{readStateIndex:8532; appliedIndex:8531; }","duration":"134.20688ms","start":"2026-03-04T02:43:15.8522Z","end":"2026-03-04T02:43:15.986407Z","steps":["trace[948009423] 'read index received' (duration: 61.962955ms)","trace[948009423] 'applied index is now lower than readState.Index' (duration: 72.242525ms)"],"step_count":2} {"level":"info","ts":"2026-03-04T02:43:15.986519Z","caller":"traceutil/trace.go:171","msg":"trace[1941466831] transaction","detail":"{read_only:false; response_revision:8220; number_of_response:1; }","duration":"135.404003ms","start":"2026-03-04T02:43:15.851067Z","end":"2026-03-04T02:43:15.986471Z","steps":["trace[1941466831] 'process raft request' (duration: 63.195599ms)","trace[1941466831] 'compare' (duration: 72.00615ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T02:43:15.986937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.70142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-b4g2v\" ","response":"range_response_count:1 size:2804"} {"level":"info","ts":"2026-03-04T02:43:15.987066Z","caller":"traceutil/trace.go:171","msg":"trace[815094773] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-b4g2v; range_end:; response_count:1; response_revision:8220; }","duration":"134.850462ms","start":"2026-03-04T02:43:15.85219Z","end":"2026-03-04T02:43:15.98704Z","steps":["trace[815094773] 'agreement among raft nodes before linearized reading' (duration: 134.333573ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:43:16.728687Z","caller":"traceutil/trace.go:171","msg":"trace[513229518] transaction","detail":"{read_only:false; response_revision:8230; number_of_response:1; }","duration":"194.369863ms","start":"2026-03-04T02:43:16.534283Z","end":"2026-03-04T02:43:16.728653Z","steps":["trace[513229518] 'process raft request' (duration: 194.165679ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:43:16.814013Z","caller":"traceutil/trace.go:171","msg":"trace[692199670] transaction","detail":"{read_only:false; response_revision:8232; number_of_response:1; }","duration":"115.557488ms","start":"2026-03-04T02:43:16.698417Z","end":"2026-03-04T02:43:16.813975Z","steps":["trace[692199670] 'process raft request' (duration: 115.504667ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:43:16.814101Z","caller":"traceutil/trace.go:171","msg":"trace[658985675] transaction","detail":"{read_only:false; response_revision:8231; number_of_response:1; }","duration":"127.232192ms","start":"2026-03-04T02:43:16.686826Z","end":"2026-03-04T02:43:16.814059Z","steps":["trace[658985675] 'process raft request' (duration: 126.913576ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:46:19.289301Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"58fa9386873601ed","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-04T02:46:19.293848Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-04T02:46:19.293933Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-04T02:46:52.592382Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7549} {"level":"info","ts":"2026-03-04T02:46:52.659079Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7549,"took":"63.605818ms","hash":2755145992,"current-db-size-bytes":40476672,"current-db-size":"40 MB","current-db-size-in-use-bytes":25526272,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-03-04T02:46:52.659164Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2755145992,"revision":7549,"compact-revision":5623} {"level":"info","ts":"2026-03-04T02:51:52.60008Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9934} {"level":"info","ts":"2026-03-04T02:51:52.679591Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9934,"took":"76.896589ms","hash":1226226103,"current-db-size-bytes":40476672,"current-db-size":"40 MB","current-db-size-in-use-bytes":23605248,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-03-04T02:51:52.679831Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1226226103,"revision":9934,"compact-revision":7549} {"level":"info","ts":"2026-03-04T02:54:02.906018Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000033f5.wal"} {"level":"info","ts":"2026-03-04T02:54:33.186801Z","caller":"traceutil/trace.go:171","msg":"trace[13533842] transaction","detail":"{read_only:false; response_revision:13031; number_of_response:1; }","duration":"110.455927ms","start":"2026-03-04T02:54:33.076299Z","end":"2026-03-04T02:54:33.186755Z","steps":["trace[13533842] 'process raft request' (duration: 110.198182ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:54:33.194168Z","caller":"traceutil/trace.go:171","msg":"trace[1367610549] transaction","detail":"{read_only:false; response_revision:13032; number_of_response:1; }","duration":"105.883413ms","start":"2026-03-04T02:54:33.088244Z","end":"2026-03-04T02:54:33.194128Z","steps":["trace[1367610549] 'process raft request' (duration: 105.272802ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:54:39.342952Z","caller":"traceutil/trace.go:171","msg":"trace[420527606] transaction","detail":"{read_only:false; response_revision:13066; number_of_response:1; }","duration":"127.852687ms","start":"2026-03-04T02:54:39.215073Z","end":"2026-03-04T02:54:39.342926Z","steps":["trace[420527606] 'process raft request' (duration: 127.702734ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T02:54:56.36329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.604335ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-03-04T02:54:56.363484Z","caller":"traceutil/trace.go:171","msg":"trace[1903766183] linearizableReadLoop","detail":"{readStateIndex:13641; appliedIndex:13640; }","duration":"260.947818ms","start":"2026-03-04T02:54:56.102508Z","end":"2026-03-04T02:54:56.363456Z","steps":["trace[1903766183] 'read index received' (duration: 141.048618ms)","trace[1903766183] 'applied index is now lower than readState.Index' (duration: 119.89689ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T02:54:56.363496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-04T02:54:55.993035Z","time spent":"370.451809ms","remote":"127.0.0.1:56560","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-03-04T02:54:56.363722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.208833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-03-04T02:54:56.363778Z","caller":"traceutil/trace.go:171","msg":"trace[1741670607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:13159; }","duration":"261.316165ms","start":"2026-03-04T02:54:56.102446Z","end":"2026-03-04T02:54:56.363762Z","steps":["trace[1741670607] 'agreement among raft nodes before linearized reading' (duration: 261.086651ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:55:01.307767Z","caller":"traceutil/trace.go:171","msg":"trace[373938000] linearizableReadLoop","detail":"{readStateIndex:13686; appliedIndex:13685; }","duration":"144.584195ms","start":"2026-03-04T02:55:01.163142Z","end":"2026-03-04T02:55:01.307726Z","steps":["trace[373938000] 'read index received' (duration: 144.339ms)","trace[373938000] 'applied index is now lower than readState.Index' (duration: 243.154µs)"],"step_count":2} {"level":"info","ts":"2026-03-04T02:55:01.307933Z","caller":"traceutil/trace.go:171","msg":"trace[1916020848] transaction","detail":"{read_only:false; response_revision:13203; number_of_response:1; }","duration":"175.039912ms","start":"2026-03-04T02:55:01.13285Z","end":"2026-03-04T02:55:01.30789Z","steps":["trace[1916020848] 'process raft request' (duration: 174.652315ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T02:55:01.308067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.88127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-03-04T02:55:01.308121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.071291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-j5j46\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-03-04T02:55:01.30817Z","caller":"traceutil/trace.go:171","msg":"trace[1368721122] range","detail":"{range_begin:/registry/pods/openstack/keepalived-j5j46; range_end:; response_count:1; response_revision:13203; }","duration":"122.196973ms","start":"2026-03-04T02:55:01.18596Z","end":"2026-03-04T02:55:01.308157Z","steps":["trace[1368721122] 'agreement among raft nodes before linearized reading' (duration: 121.962869ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:55:01.308181Z","caller":"traceutil/trace.go:171","msg":"trace[2049613727] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:13203; }","duration":"145.068913ms","start":"2026-03-04T02:55:01.163087Z","end":"2026-03-04T02:55:01.308156Z","steps":["trace[2049613727] 'agreement among raft nodes before linearized reading' (duration: 144.800428ms)"],"step_count":1} {"level":"warn","ts":"2026-03-04T02:55:06.228445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.252945ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-04T02:55:06.228604Z","caller":"traceutil/trace.go:171","msg":"trace[1208949512] linearizableReadLoop","detail":"{readStateIndex:13818; appliedIndex:13817; }","duration":"164.091431ms","start":"2026-03-04T02:55:06.06449Z","end":"2026-03-04T02:55:06.228581Z","steps":["trace[1208949512] 'read index received' (duration: 32.921µs)","trace[1208949512] 'applied index is now lower than readState.Index' (duration: 164.05663ms)"],"step_count":2} {"level":"info","ts":"2026-03-04T02:55:06.228653Z","caller":"traceutil/trace.go:171","msg":"trace[69114757] transaction","detail":"{read_only:false; response_revision:13333; number_of_response:1; }","duration":"204.089995ms","start":"2026-03-04T02:55:06.024492Z","end":"2026-03-04T02:55:06.228582Z","steps":["trace[69114757] 'process raft request' (duration: 39.575795ms)","trace[69114757] 'compare' (duration: 164.078752ms)"],"step_count":2} {"level":"warn","ts":"2026-03-04T02:55:06.228835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.333755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/ovn-northd-fc978744-kfhtb\" ","response":"range_response_count:1 size:7032"} {"level":"info","ts":"2026-03-04T02:55:06.22888Z","caller":"traceutil/trace.go:171","msg":"trace[1963478289] range","detail":"{range_begin:/registry/pods/openstack/ovn-northd-fc978744-kfhtb; range_end:; response_count:1; response_revision:13333; }","duration":"164.406706ms","start":"2026-03-04T02:55:06.064463Z","end":"2026-03-04T02:55:06.22887Z","steps":["trace[1963478289] 'agreement among raft nodes before linearized reading' (duration: 164.175152ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:56:46.276823Z","caller":"traceutil/trace.go:171","msg":"trace[1369704638] transaction","detail":"{read_only:false; response_revision:14374; number_of_response:1; }","duration":"102.112205ms","start":"2026-03-04T02:56:46.174682Z","end":"2026-03-04T02:56:46.276795Z","steps":["trace[1369704638] 'process raft request' (duration: 101.921761ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T02:56:52.606437Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":11945} {"level":"info","ts":"2026-03-04T02:56:52.683034Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":11945,"took":"73.821515ms","hash":1463286896,"current-db-size-bytes":40476672,"current-db-size":"40 MB","current-db-size-in-use-bytes":27316224,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-03-04T02:56:52.683119Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1463286896,"revision":11945,"compact-revision":9934} {"level":"info","ts":"2026-03-04T03:01:52.61433Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14402} {"level":"info","ts":"2026-03-04T03:01:52.716422Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14402,"took":"98.722732ms","hash":3678617692,"current-db-size-bytes":42782720,"current-db-size":"43 MB","current-db-size-in-use-bytes":28643328,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-03-04T03:01:52.716489Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3678617692,"revision":14402,"compact-revision":11945} {"level":"info","ts":"2026-03-04T03:02:31.079836Z","caller":"traceutil/trace.go:171","msg":"trace[431297841] transaction","detail":"{read_only:false; response_revision:16777; number_of_response:1; }","duration":"101.951781ms","start":"2026-03-04T03:02:30.977849Z","end":"2026-03-04T03:02:31.079801Z","steps":["trace[431297841] 'process raft request' (duration: 101.160497ms)"],"step_count":1} {"level":"info","ts":"2026-03-04T03:06:52.62047Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16524} {"level":"info","ts":"2026-03-04T03:06:52.711893Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16524,"took":"88.18114ms","hash":4220239608,"current-db-size-bytes":42782720,"current-db-size":"43 MB","current-db-size-in-use-bytes":24555520,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-03-04T03:06:52.711946Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4220239608,"revision":16524,"compact-revision":14402}