{"level":"warn","ts":"2026-10-26T19:24:05.267557Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-26T19:24:05.267656Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.102: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://162.253.55.102:2380","--initial-cluster=instance=https://162.253.55.102:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.102:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.102: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-10-26T19:24:05.267869Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-26T19:24:05.267891Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.102:2380"]} {"level":"info","ts":"2026-10-26T19:24:05.267912Z","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-10-26T19:24:05.268858Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.102:2379"]} {"level":"info","ts":"2026-10-26T19:24:05.268994Z","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://162.253.55.102:2380"],"listen-peer-urls":["https://162.253.55.102:2380"],"advertise-client-urls":["https://162.253.55.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.102: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-10-26T19:24:05.272018Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.688738ms"} {"level":"info","ts":"2026-10-26T19:24:05.277891Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e2af340d70e332c3","cluster-id":"da2a6dcf93591a68"} {"level":"info","ts":"2026-10-26T19:24:05.277986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 switched to configuration voters=()"} {"level":"info","ts":"2026-10-26T19:24:05.278058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 became follower at term 0"} {"level":"info","ts":"2026-10-26T19:24:05.278078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e2af340d70e332c3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-26T19:24:05.278136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 became follower at term 1"} {"level":"info","ts":"2026-10-26T19:24:05.278225Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 switched to configuration voters=(16334331605829235395)"} {"level":"warn","ts":"2026-10-26T19:24:05.283226Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-26T19:24:05.285271Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-26T19:24:05.286969Z","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-10-26T19:24:05.290776Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e2af340d70e332c3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-26T19:24:05.2913Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e2af340d70e332c3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-26T19:24:05.29127Z","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-10-26T19:24:05.29199Z","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-10-26T19:24:05.292077Z","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-10-26T19:24:05.292956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 switched to configuration voters=(16334331605829235395)"} {"level":"info","ts":"2026-10-26T19:24:05.293857Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"da2a6dcf93591a68","local-member-id":"e2af340d70e332c3","added-peer-id":"e2af340d70e332c3","added-peer-peer-urls":["https://162.253.55.102:2380"]} {"level":"info","ts":"2026-10-26T19:24:05.30508Z","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-10-26T19:24:05.305448Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e2af340d70e332c3","initial-advertise-peer-urls":["https://162.253.55.102:2380"],"listen-peer-urls":["https://162.253.55.102:2380"],"advertise-client-urls":["https://162.253.55.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-26T19:24:05.305495Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-26T19:24:05.306288Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.102:2380"} {"level":"info","ts":"2026-10-26T19:24:05.306319Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.102:2380"} {"level":"info","ts":"2026-10-26T19:24:05.479551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 is starting a new election at term 1"} {"level":"info","ts":"2026-10-26T19:24:05.479623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-26T19:24:05.479662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 received MsgPreVoteResp from e2af340d70e332c3 at term 1"} {"level":"info","ts":"2026-10-26T19:24:05.479772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 became candidate at term 2"} {"level":"info","ts":"2026-10-26T19:24:05.479851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 received MsgVoteResp from e2af340d70e332c3 at term 2"} {"level":"info","ts":"2026-10-26T19:24:05.479871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2af340d70e332c3 became leader at term 2"} {"level":"info","ts":"2026-10-26T19:24:05.479925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e2af340d70e332c3 elected leader e2af340d70e332c3 at term 2"} {"level":"info","ts":"2026-10-26T19:24:05.581268Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T19:24:05.582397Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e2af340d70e332c3","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.102:2379]}","request-path":"/0/members/e2af340d70e332c3/attributes","cluster-id":"da2a6dcf93591a68","publish-timeout":"7s"} {"level":"info","ts":"2026-10-26T19:24:05.582513Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-26T19:24:05.582581Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-26T19:24:05.582985Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-26T19:24:05.583135Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-26T19:24:05.583362Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"da2a6dcf93591a68","local-member-id":"e2af340d70e332c3","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T19:24:05.583579Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T19:24:05.583639Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T19:24:05.586953Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.102:2379"} {"level":"info","ts":"2026-10-26T19:24:05.587084Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-26T19:24:17.444978Z","caller":"traceutil/trace.go:171","msg":"trace[1371454640] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"180.483434ms","start":"2026-10-26T19:24:17.264455Z","end":"2026-10-26T19:24:17.444939Z","steps":["trace[1371454640] 'process raft request' (duration: 180.151398ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:24:17.711744Z","caller":"traceutil/trace.go:171","msg":"trace[1709244159] linearizableReadLoop","detail":"{readStateIndex:406; appliedIndex:405; }","duration":"222.291102ms","start":"2026-10-26T19:24:17.489419Z","end":"2026-10-26T19:24:17.71171Z","steps":["trace[1709244159] 'read index received' (duration: 192.868109ms)","trace[1709244159] 'applied index is now lower than readState.Index' (duration: 29.421513ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:24:17.711952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.499385ms","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-10-26T19:24:17.712017Z","caller":"traceutil/trace.go:171","msg":"trace[793986505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:395; }","duration":"222.650448ms","start":"2026-10-26T19:24:17.489354Z","end":"2026-10-26T19:24:17.712005Z","steps":["trace[793986505] 'agreement among raft nodes before linearized reading' (duration: 222.505715ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:24:17.712394Z","caller":"traceutil/trace.go:171","msg":"trace[404600460] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"253.567829ms","start":"2026-10-26T19:24:17.458651Z","end":"2026-10-26T19:24:17.712219Z","steps":["trace[404600460] 'process raft request' (duration: 223.641507ms)","trace[404600460] 'compare' (duration: 29.164008ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:24:57.529936Z","caller":"traceutil/trace.go:171","msg":"trace[264851292] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"102.266803ms","start":"2026-10-26T19:24:57.427639Z","end":"2026-10-26T19:24:57.529906Z","steps":["trace[264851292] 'process raft request' (duration: 101.645281ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:24:57.837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.555705ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-26T19:24:57.837105Z","caller":"traceutil/trace.go:171","msg":"trace[968631409] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"234.326509ms","start":"2026-10-26T19:24:57.60276Z","end":"2026-10-26T19:24:57.837086Z","steps":["trace[968631409] 'process raft request' (duration: 73.165334ms)","trace[968631409] 'compare' (duration: 160.422791ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:24:58.298031Z","caller":"traceutil/trace.go:171","msg":"trace[644591084] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:672; }","duration":"344.375359ms","start":"2026-10-26T19:24:57.953623Z","end":"2026-10-26T19:24:58.297998Z","steps":["trace[644591084] 'read index received' (duration: 338.12874ms)","trace[644591084] 'applied index is now lower than readState.Index' (duration: 6.245269ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:24:58.298034Z","caller":"traceutil/trace.go:171","msg":"trace[249501846] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"358.411584ms","start":"2026-10-26T19:24:57.939591Z","end":"2026-10-26T19:24:58.298003Z","steps":["trace[249501846] 'process raft request' (duration: 352.100624ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:24:58.298382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.629934ms","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-10-26T19:24:58.298431Z","caller":"traceutil/trace.go:171","msg":"trace[1414344603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:649; }","duration":"344.816227ms","start":"2026-10-26T19:24:57.9536Z","end":"2026-10-26T19:24:58.298416Z","steps":["trace[1414344603] 'agreement among raft nodes before linearized reading' (duration: 344.531301ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:24:58.298511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:24:57.95359Z","time spent":"344.866259ms","remote":"127.0.0.1:43374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-26T19:24:58.298595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:24:57.939574Z","time spent":"358.629808ms","remote":"127.0.0.1:43374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T19:24:58.310458Z","caller":"traceutil/trace.go:171","msg":"trace[190453753] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"138.728751ms","start":"2026-10-26T19:24:58.171702Z","end":"2026-10-26T19:24:58.310431Z","steps":["trace[190453753] 'process raft request' (duration: 138.374895ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:24:58.311017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.94899ms","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-10-26T19:24:58.311077Z","caller":"traceutil/trace.go:171","msg":"trace[1213168091] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:651; }","duration":"262.041702ms","start":"2026-10-26T19:24:58.049019Z","end":"2026-10-26T19:24:58.311061Z","steps":["trace[1213168091] 'agreement among raft nodes before linearized reading' (duration: 261.91735ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:24:58.311102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.594169ms","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-10-26T19:24:58.311175Z","caller":"traceutil/trace.go:171","msg":"trace[2082869015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:651; }","duration":"139.69738ms","start":"2026-10-26T19:24:58.171456Z","end":"2026-10-26T19:24:58.311153Z","steps":["trace[2082869015] 'agreement among raft nodes before linearized reading' (duration: 139.548867ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:24:59.759477Z","caller":"traceutil/trace.go:171","msg":"trace[1146523629] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"200.406028ms","start":"2026-10-26T19:24:59.559046Z","end":"2026-10-26T19:24:59.759452Z","steps":["trace[1146523629] 'process raft request' (duration: 200.300536ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:24:59.759509Z","caller":"traceutil/trace.go:171","msg":"trace[1681946711] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"200.612133ms","start":"2026-10-26T19:24:59.558857Z","end":"2026-10-26T19:24:59.759469Z","steps":["trace[1681946711] 'process raft request' (duration: 200.443989ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:24:59.759446Z","caller":"traceutil/trace.go:171","msg":"trace[1610020115] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"201.420706ms","start":"2026-10-26T19:24:59.557995Z","end":"2026-10-26T19:24:59.759415Z","steps":["trace[1610020115] 'process raft request' (duration: 199.710594ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:26:36.005088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.815093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-26T19:26:36.005241Z","caller":"traceutil/trace.go:171","msg":"trace[494701133] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1903; }","duration":"103.046157ms","start":"2026-10-26T19:26:35.902163Z","end":"2026-10-26T19:26:36.005209Z","steps":["trace[494701133] 'range keys from in-memory index tree' (duration: 102.514067ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:26:36.426443Z","caller":"traceutil/trace.go:171","msg":"trace[1020115604] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"232.574243ms","start":"2026-10-26T19:26:36.193836Z","end":"2026-10-26T19:26:36.42641Z","steps":["trace[1020115604] 'process raft request' (duration: 228.17454ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:26:36.426763Z","caller":"traceutil/trace.go:171","msg":"trace[309782872] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"232.39262ms","start":"2026-10-26T19:26:36.194327Z","end":"2026-10-26T19:26:36.426719Z","steps":["trace[309782872] 'process raft request' (duration: 232.013312ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:26:36.426835Z","caller":"traceutil/trace.go:171","msg":"trace[570309401] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"151.964761ms","start":"2026-10-26T19:26:36.274817Z","end":"2026-10-26T19:26:36.426782Z","steps":["trace[570309401] 'process raft request' (duration: 151.683155ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:26:36.426873Z","caller":"traceutil/trace.go:171","msg":"trace[1816874014] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"232.816188ms","start":"2026-10-26T19:26:36.193956Z","end":"2026-10-26T19:26:36.426772Z","steps":["trace[1816874014] 'process raft request' (duration: 232.275437ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:26:42.648367Z","caller":"traceutil/trace.go:171","msg":"trace[1021747860] transaction","detail":"{read_only:false; response_revision:1967; number_of_response:1; }","duration":"137.692971ms","start":"2026-10-26T19:26:42.510626Z","end":"2026-10-26T19:26:42.648318Z","steps":["trace[1021747860] 'process raft request' (duration: 105.572284ms)","trace[1021747860] 'compare' (duration: 31.289811ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:26:53.089885Z","caller":"traceutil/trace.go:171","msg":"trace[1796032899] transaction","detail":"{read_only:false; response_revision:2046; number_of_response:1; }","duration":"100.552269ms","start":"2026-10-26T19:26:52.989295Z","end":"2026-10-26T19:26:53.089847Z","steps":["trace[1796032899] 'process raft request' (duration: 100.308454ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:27:31.51133Z","caller":"traceutil/trace.go:171","msg":"trace[1613190524] transaction","detail":"{read_only:false; response_revision:2257; number_of_response:1; }","duration":"177.972526ms","start":"2026-10-26T19:27:31.333312Z","end":"2026-10-26T19:27:31.511284Z","steps":["trace[1613190524] 'process raft request' (duration: 177.878044ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:27:31.511334Z","caller":"traceutil/trace.go:171","msg":"trace[862477459] transaction","detail":"{read_only:false; response_revision:2256; number_of_response:1; }","duration":"177.973505ms","start":"2026-10-26T19:27:31.333282Z","end":"2026-10-26T19:27:31.511256Z","steps":["trace[862477459] 'process raft request' (duration: 104.527388ms)","trace[862477459] 'compare' (duration: 73.240123ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:27:31.511408Z","caller":"traceutil/trace.go:171","msg":"trace[1484682497] transaction","detail":"{read_only:false; response_revision:2258; number_of_response:1; }","duration":"177.664679ms","start":"2026-10-26T19:27:31.333637Z","end":"2026-10-26T19:27:31.511302Z","steps":["trace[1484682497] 'process raft request' (duration: 177.591698ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:28:15.385173Z","caller":"traceutil/trace.go:171","msg":"trace[1742238561] transaction","detail":"{read_only:false; response_revision:2666; number_of_response:1; }","duration":"142.183256ms","start":"2026-10-26T19:28:15.24295Z","end":"2026-10-26T19:28:15.385133Z","steps":["trace[1742238561] 'process raft request' (duration: 141.976282ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:28:49.780404Z","caller":"traceutil/trace.go:171","msg":"trace[1244689478] linearizableReadLoop","detail":"{readStateIndex:2982; appliedIndex:2981; }","duration":"109.787503ms","start":"2026-10-26T19:28:49.670585Z","end":"2026-10-26T19:28:49.780372Z","steps":["trace[1244689478] 'read index received' (duration: 109.709391ms)","trace[1244689478] 'applied index is now lower than readState.Index' (duration: 76.412µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:28:49.780524Z","caller":"traceutil/trace.go:171","msg":"trace[996405607] transaction","detail":"{read_only:false; response_revision:2872; number_of_response:1; }","duration":"133.06957ms","start":"2026-10-26T19:28:49.647403Z","end":"2026-10-26T19:28:49.780472Z","steps":["trace[996405607] 'process raft request' (duration: 132.800065ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:28:49.780632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.033167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-26T19:28:49.780696Z","caller":"traceutil/trace.go:171","msg":"trace[943510235] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2872; }","duration":"110.1684ms","start":"2026-10-26T19:28:49.670516Z","end":"2026-10-26T19:28:49.780684Z","steps":["trace[943510235] 'agreement among raft nodes before linearized reading' (duration: 109.974116ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:33:41.324241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.750895ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-26T19:33:41.32443Z","caller":"traceutil/trace.go:171","msg":"trace[1711965727] linearizableReadLoop","detail":"{readStateIndex:5540; appliedIndex:5538; }","duration":"141.952778ms","start":"2026-10-26T19:33:41.182458Z","end":"2026-10-26T19:33:41.324411Z","steps":["trace[1711965727] 'read index received' (duration: 139.902468ms)","trace[1711965727] 'applied index is now lower than readState.Index' (duration: 2.04914ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:33:41.324576Z","caller":"traceutil/trace.go:171","msg":"trace[1739720811] transaction","detail":"{read_only:false; response_revision:5334; number_of_response:1; }","duration":"297.85016ms","start":"2026-10-26T19:33:41.026686Z","end":"2026-10-26T19:33:41.324536Z","steps":["trace[1739720811] 'process raft request' (duration: 123.735648ms)","trace[1739720811] 'compare' (duration: 173.623203ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:33:41.32482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.341875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-eebb7c4e-be1e-4969-853a-15aa28c50687\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-26T19:33:41.324906Z","caller":"traceutil/trace.go:171","msg":"trace[424252258] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-eebb7c4e-be1e-4969-853a-15aa28c50687; range_end:; response_count:1; response_revision:5335; }","duration":"142.493428ms","start":"2026-10-26T19:33:41.182397Z","end":"2026-10-26T19:33:41.32489Z","steps":["trace[424252258] 'agreement among raft nodes before linearized reading' (duration: 142.107191ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:33:41.325306Z","caller":"traceutil/trace.go:171","msg":"trace[5068771] transaction","detail":"{read_only:false; response_revision:5335; number_of_response:1; }","duration":"203.693059ms","start":"2026-10-26T19:33:41.120736Z","end":"2026-10-26T19:33:41.324429Z","steps":["trace[5068771] 'process raft request' (duration: 203.606858ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:33:41.812001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.381055ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T19:33:41.812247Z","caller":"traceutil/trace.go:171","msg":"trace[1659625523] transaction","detail":"{read_only:false; response_revision:5345; number_of_response:1; }","duration":"322.787396ms","start":"2026-10-26T19:33:41.489432Z","end":"2026-10-26T19:33:41.81222Z","steps":["trace[1659625523] 'process raft request' (duration: 87.066336ms)","trace[1659625523] 'compare' (duration: 234.983297ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:33:41.812403Z","caller":"traceutil/trace.go:171","msg":"trace[863465991] transaction","detail":"{read_only:false; response_revision:5347; number_of_response:1; }","duration":"288.160394ms","start":"2026-10-26T19:33:41.524214Z","end":"2026-10-26T19:33:41.812374Z","steps":["trace[863465991] 'process raft request' (duration: 288.093623ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:33:41.812455Z","caller":"traceutil/trace.go:171","msg":"trace[461362743] linearizableReadLoop","detail":"{readStateIndex:5551; appliedIndex:5549; }","duration":"300.408178ms","start":"2026-10-26T19:33:41.512009Z","end":"2026-10-26T19:33:41.812417Z","steps":["trace[461362743] 'read index received' (duration: 1.326335ms)","trace[461362743] 'applied index is now lower than readState.Index' (duration: 299.076143ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:33:41.8124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:33:41.489416Z","time spent":"322.901928ms","remote":"127.0.0.1:46312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4934,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T19:33:41.81265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.625892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-26T19:33:41.812692Z","caller":"traceutil/trace.go:171","msg":"trace[199019456] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5347; }","duration":"300.747004ms","start":"2026-10-26T19:33:41.511935Z","end":"2026-10-26T19:33:41.812682Z","steps":["trace[199019456] 'agreement among raft nodes before linearized reading' (duration: 300.592791ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:33:41.81272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:33:41.51192Z","time spent":"300.793666ms","remote":"127.0.0.1:43374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-26T19:33:41.812806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.243886ms","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-10-26T19:33:41.812852Z","caller":"traceutil/trace.go:171","msg":"trace[240656318] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5347; }","duration":"288.315948ms","start":"2026-10-26T19:33:41.524524Z","end":"2026-10-26T19:33:41.81284Z","steps":["trace[240656318] 'agreement among raft nodes before linearized reading' (duration: 288.062113ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:33:41.812818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.748686ms","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-10-26T19:33:41.812926Z","caller":"traceutil/trace.go:171","msg":"trace[435420145] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5347; }","duration":"205.88325ms","start":"2026-10-26T19:33:41.607017Z","end":"2026-10-26T19:33:41.8129Z","steps":["trace[435420145] 'agreement among raft nodes before linearized reading' (duration: 205.637145ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:33:41.812938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.721066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-26T19:33:41.812985Z","caller":"traceutil/trace.go:171","msg":"trace[838407606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5347; }","duration":"218.804977ms","start":"2026-10-26T19:33:41.594166Z","end":"2026-10-26T19:33:41.812971Z","steps":["trace[838407606] 'agreement among raft nodes before linearized reading' (duration: 218.692895ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:33:41.813098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.724081ms","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-10-26T19:33:41.813166Z","caller":"traceutil/trace.go:171","msg":"trace[1016667507] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5347; }","duration":"212.814563ms","start":"2026-10-26T19:33:41.600332Z","end":"2026-10-26T19:33:41.813147Z","steps":["trace[1016667507] 'agreement among raft nodes before linearized reading' (duration: 212.609349ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:33:41.81335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.899371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:787156"} {"level":"info","ts":"2026-10-26T19:33:41.813393Z","caller":"traceutil/trace.go:171","msg":"trace[1927099754] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5347; }","duration":"285.955843ms","start":"2026-10-26T19:33:41.527426Z","end":"2026-10-26T19:33:41.813382Z","steps":["trace[1927099754] 'agreement among raft nodes before linearized reading' (duration: 285.545835ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:33:41.813451Z","caller":"traceutil/trace.go:171","msg":"trace[2073119807] transaction","detail":"{read_only:false; response_revision:5346; number_of_response:1; }","duration":"321.081775ms","start":"2026-10-26T19:33:41.492272Z","end":"2026-10-26T19:33:41.813353Z","steps":["trace[2073119807] 'process raft request' (duration: 319.874892ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:33:41.813583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:33:41.492251Z","time spent":"321.258508ms","remote":"127.0.0.1:43592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5068,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T19:33:55.501335Z","caller":"traceutil/trace.go:171","msg":"trace[1460352377] transaction","detail":"{read_only:false; response_revision:5619; number_of_response:1; }","duration":"104.333727ms","start":"2026-10-26T19:33:55.396949Z","end":"2026-10-26T19:33:55.501283Z","steps":["trace[1460352377] 'process raft request' (duration: 56.235726ms)","trace[1460352377] 'compare' (duration: 47.484969ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:33:56.161882Z","caller":"traceutil/trace.go:171","msg":"trace[2025212141] linearizableReadLoop","detail":"{readStateIndex:5844; appliedIndex:5843; }","duration":"265.039593ms","start":"2026-10-26T19:33:55.896823Z","end":"2026-10-26T19:33:56.161862Z","steps":["trace[2025212141] 'read index received' (duration: 264.840009ms)","trace[2025212141] 'applied index is now lower than readState.Index' (duration: 198.414µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:33:56.161974Z","caller":"traceutil/trace.go:171","msg":"trace[1297809661] transaction","detail":"{read_only:false; response_revision:5628; number_of_response:1; }","duration":"343.583306ms","start":"2026-10-26T19:33:55.818384Z","end":"2026-10-26T19:33:56.161967Z","steps":["trace[1297809661] 'process raft request' (duration: 343.341522ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:33:56.162086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:33:55.818358Z","time spent":"343.634467ms","remote":"127.0.0.1:46312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11655,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T19:33:56.162262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.444001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-26T19:33:56.162292Z","caller":"traceutil/trace.go:171","msg":"trace[122350930] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5628; }","duration":"265.500792ms","start":"2026-10-26T19:33:55.896784Z","end":"2026-10-26T19:33:56.162285Z","steps":["trace[122350930] 'agreement among raft nodes before linearized reading' (duration: 265.40315ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:33:56.162335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.388922ms","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-10-26T19:33:56.162393Z","caller":"traceutil/trace.go:171","msg":"trace[1723417416] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5628; }","duration":"261.464954ms","start":"2026-10-26T19:33:55.900912Z","end":"2026-10-26T19:33:56.162377Z","steps":["trace[1723417416] 'agreement among raft nodes before linearized reading' (duration: 261.323042ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:33:56.162493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.043743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-26T19:33:56.162505Z","caller":"traceutil/trace.go:171","msg":"trace[1136705993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5628; }","duration":"254.065613ms","start":"2026-10-26T19:33:55.908435Z","end":"2026-10-26T19:33:56.162501Z","steps":["trace[1136705993] 'agreement among raft nodes before linearized reading' (duration: 254.021402ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:33:56.162667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.203373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-10-26T19:33:56.162624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.997393ms","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-10-26T19:33:56.162728Z","caller":"traceutil/trace.go:171","msg":"trace[706270809] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5628; }","duration":"255.306235ms","start":"2026-10-26T19:33:55.907404Z","end":"2026-10-26T19:33:56.162711Z","steps":["trace[706270809] 'agreement among raft nodes before linearized reading' (duration: 255.118902ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:33:56.162756Z","caller":"traceutil/trace.go:171","msg":"trace[1653831721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5628; }","duration":"251.171846ms","start":"2026-10-26T19:33:55.911556Z","end":"2026-10-26T19:33:56.162728Z","steps":["trace[1653831721] 'agreement among raft nodes before linearized reading' (duration: 250.874511ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:33:56.163136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.901188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225408"} {"level":"info","ts":"2026-10-26T19:33:56.163161Z","caller":"traceutil/trace.go:171","msg":"trace[24552561] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5628; }","duration":"126.967879ms","start":"2026-10-26T19:33:56.036187Z","end":"2026-10-26T19:33:56.163155Z","steps":["trace[24552561] 'agreement among raft nodes before linearized reading' (duration: 126.412589ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:34:05.649988Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2959} {"level":"info","ts":"2026-10-26T19:34:05.740368Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2959,"took":"88.687947ms","hash":1546477957,"current-db-size-bytes":56172544,"current-db-size":"56 MB","current-db-size-in-use-bytes":31576064,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-26T19:34:05.740486Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1546477957,"revision":2959,"compact-revision":-1} {"level":"info","ts":"2026-10-26T19:37:55.731772Z","caller":"traceutil/trace.go:171","msg":"trace[1708417713] transaction","detail":"{read_only:false; response_revision:7473; number_of_response:1; }","duration":"104.089821ms","start":"2026-10-26T19:37:55.627642Z","end":"2026-10-26T19:37:55.731731Z","steps":["trace[1708417713] 'process raft request' (duration: 98.596977ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:39:05.65847Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5736} {"level":"info","ts":"2026-10-26T19:39:05.750783Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5736,"took":"90.215097ms","hash":142920311,"current-db-size-bytes":56172544,"current-db-size":"56 MB","current-db-size-in-use-bytes":26730496,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-26T19:39:05.750856Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":142920311,"revision":5736,"compact-revision":2959} {"level":"info","ts":"2026-10-26T19:40:19.453439Z","caller":"traceutil/trace.go:171","msg":"trace[960866972] linearizableReadLoop","detail":"{readStateIndex:8949; appliedIndex:8948; }","duration":"296.871223ms","start":"2026-10-26T19:40:19.15654Z","end":"2026-10-26T19:40:19.453411Z","steps":["trace[960866972] 'read index received' (duration: 296.70429ms)","trace[960866972] 'applied index is now lower than readState.Index' (duration: 165.853µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:40:19.453498Z","caller":"traceutil/trace.go:171","msg":"trace[851700065] transaction","detail":"{read_only:false; response_revision:8644; number_of_response:1; }","duration":"336.743298ms","start":"2026-10-26T19:40:19.116732Z","end":"2026-10-26T19:40:19.453475Z","steps":["trace[851700065] 'process raft request' (duration: 336.529583ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:40:19.453607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.059478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-26T19:40:19.453623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:40:19.116681Z","time spent":"336.86584ms","remote":"127.0.0.1:43374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T19:40:19.453647Z","caller":"traceutil/trace.go:171","msg":"trace[616759633] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8644; }","duration":"297.133209ms","start":"2026-10-26T19:40:19.156503Z","end":"2026-10-26T19:40:19.453636Z","steps":["trace[616759633] 'agreement among raft nodes before linearized reading' (duration: 297.056997ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:40:19.453805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.477687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T19:40:19.4539Z","caller":"traceutil/trace.go:171","msg":"trace[1282352767] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:8644; }","duration":"270.65079ms","start":"2026-10-26T19:40:19.183227Z","end":"2026-10-26T19:40:19.453878Z","steps":["trace[1282352767] 'agreement among raft nodes before linearized reading' (duration: 270.425736ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:40:19.45478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.516019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.102\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-26T19:40:19.454833Z","caller":"traceutil/trace.go:171","msg":"trace[1545715185] range","detail":"{range_begin:/registry/masterleases/162.253.55.102; range_end:; response_count:1; response_revision:8644; }","duration":"293.633011ms","start":"2026-10-26T19:40:19.161187Z","end":"2026-10-26T19:40:19.45482Z","steps":["trace[1545715185] 'agreement among raft nodes before linearized reading' (duration: 292.414287ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:40:30.651612Z","caller":"traceutil/trace.go:171","msg":"trace[1381386575] linearizableReadLoop","detail":"{readStateIndex:9009; appliedIndex:9008; }","duration":"235.112469ms","start":"2026-10-26T19:40:30.416478Z","end":"2026-10-26T19:40:30.651591Z","steps":["trace[1381386575] 'read index received' (duration: 235.046877ms)","trace[1381386575] 'applied index is now lower than readState.Index' (duration: 64.252µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:40:30.651902Z","caller":"traceutil/trace.go:171","msg":"trace[131827772] transaction","detail":"{read_only:false; response_revision:8700; number_of_response:1; }","duration":"249.231701ms","start":"2026-10-26T19:40:30.402658Z","end":"2026-10-26T19:40:30.65189Z","steps":["trace[131827772] 'process raft request' (duration: 248.797682ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:40:30.652158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.67744ms","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-10-26T19:40:30.652199Z","caller":"traceutil/trace.go:171","msg":"trace[175462951] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8700; }","duration":"235.772632ms","start":"2026-10-26T19:40:30.416418Z","end":"2026-10-26T19:40:30.65219Z","steps":["trace[175462951] 'agreement among raft nodes before linearized reading' (duration: 235.64608ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:40:30.70074Z","caller":"traceutil/trace.go:171","msg":"trace[632403020] transaction","detail":"{read_only:false; response_revision:8701; number_of_response:1; }","duration":"254.697094ms","start":"2026-10-26T19:40:30.445983Z","end":"2026-10-26T19:40:30.70068Z","steps":["trace[632403020] 'process raft request' (duration: 222.68953ms)","trace[632403020] 'compare' (duration: 31.79377ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:40:30.700914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.964727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T19:40:30.700968Z","caller":"traceutil/trace.go:171","msg":"trace[871721247] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8702; }","duration":"221.06484ms","start":"2026-10-26T19:40:30.479886Z","end":"2026-10-26T19:40:30.700951Z","steps":["trace[871721247] 'agreement among raft nodes before linearized reading' (duration: 220.788564ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:40:30.700975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.184825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-26T19:40:30.701026Z","caller":"traceutil/trace.go:171","msg":"trace[1020077723] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8702; }","duration":"279.269117ms","start":"2026-10-26T19:40:30.421744Z","end":"2026-10-26T19:40:30.701013Z","steps":["trace[1020077723] 'agreement among raft nodes before linearized reading' (duration: 278.90757ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:40:30.701099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.177503ms","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-10-26T19:40:30.701135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.319057ms","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-10-26T19:40:30.701186Z","caller":"traceutil/trace.go:171","msg":"trace[1009860794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8702; }","duration":"171.309816ms","start":"2026-10-26T19:40:30.529855Z","end":"2026-10-26T19:40:30.701165Z","steps":["trace[1009860794] 'agreement among raft nodes before linearized reading' (duration: 170.810426ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:40:30.701233Z","caller":"traceutil/trace.go:171","msg":"trace[813939610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8702; }","duration":"266.460391ms","start":"2026-10-26T19:40:30.434749Z","end":"2026-10-26T19:40:30.701209Z","steps":["trace[813939610] 'agreement among raft nodes before linearized reading' (duration: 265.960661ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:40:57.863641Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023ff.wal"} {"level":"info","ts":"2026-10-26T19:41:00.298124Z","caller":"traceutil/trace.go:171","msg":"trace[1034845744] transaction","detail":"{read_only:false; response_revision:8914; number_of_response:1; }","duration":"152.717878ms","start":"2026-10-26T19:41:00.145381Z","end":"2026-10-26T19:41:00.298099Z","steps":["trace[1034845744] 'process raft request' (duration: 152.532056ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:41:11.557131Z","caller":"traceutil/trace.go:171","msg":"trace[574107665] linearizableReadLoop","detail":"{readStateIndex:9294; appliedIndex:9293; }","duration":"141.086837ms","start":"2026-10-26T19:41:11.416011Z","end":"2026-10-26T19:41:11.557097Z","steps":["trace[574107665] 'read index received' (duration: 140.847342ms)","trace[574107665] 'applied index is now lower than readState.Index' (duration: 238.155µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:41:11.55725Z","caller":"traceutil/trace.go:171","msg":"trace[2097448973] transaction","detail":"{read_only:false; response_revision:8975; number_of_response:1; }","duration":"276.786598ms","start":"2026-10-26T19:41:11.280423Z","end":"2026-10-26T19:41:11.55721Z","steps":["trace[2097448973] 'process raft request' (duration: 276.499682ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:41:11.557452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.399053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T19:41:11.557551Z","caller":"traceutil/trace.go:171","msg":"trace[853517847] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:8975; }","duration":"141.526585ms","start":"2026-10-26T19:41:11.416003Z","end":"2026-10-26T19:41:11.55753Z","steps":["trace[853517847] 'agreement among raft nodes before linearized reading' (duration: 141.26826ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:41:12.462235Z","caller":"traceutil/trace.go:171","msg":"trace[157568109] transaction","detail":"{read_only:false; response_revision:8978; number_of_response:1; }","duration":"123.360296ms","start":"2026-10-26T19:41:12.338846Z","end":"2026-10-26T19:41:12.462207Z","steps":["trace[157568109] 'process raft request' (duration: 123.190392ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:41:14.848316Z","caller":"traceutil/trace.go:171","msg":"trace[1058514501] linearizableReadLoop","detail":"{readStateIndex:9318; appliedIndex:9317; }","duration":"310.28437ms","start":"2026-10-26T19:41:14.537994Z","end":"2026-10-26T19:41:14.848278Z","steps":["trace[1058514501] 'read index received' (duration: 242.249415ms)","trace[1058514501] 'applied index is now lower than readState.Index' (duration: 68.033445ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:41:14.84835Z","caller":"traceutil/trace.go:171","msg":"trace[100165379] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8999; }","duration":"312.408241ms","start":"2026-10-26T19:41:14.535905Z","end":"2026-10-26T19:41:14.848313Z","steps":["trace[100165379] 'process raft request' (duration: 244.323825ms)","trace[100165379] 'compare' (duration: 67.866582ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:41:14.848546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.528215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/rook-ceph-detect-version\" ","response":"range_response_count:1 size:3138"} {"level":"warn","ts":"2026-10-26T19:41:14.848587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:41:14.535893Z","time spent":"312.536833ms","remote":"127.0.0.1:46240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59,"response count":0,"response size":42,"request content":"compare: success: > failure: >"} {"level":"info","ts":"2026-10-26T19:41:14.848623Z","caller":"traceutil/trace.go:171","msg":"trace[354471173] range","detail":"{range_begin:/registry/jobs/openstack/rook-ceph-detect-version; range_end:; response_count:1; response_revision:8999; }","duration":"310.633058ms","start":"2026-10-26T19:41:14.537972Z","end":"2026-10-26T19:41:14.848605Z","steps":["trace[354471173] 'agreement among raft nodes before linearized reading' (duration: 310.403463ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:41:14.848665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:41:14.537964Z","time spent":"310.691099ms","remote":"127.0.0.1:43348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":3162,"request content":"key:\"/registry/jobs/openstack/rook-ceph-detect-version\" "} {"level":"info","ts":"2026-10-26T19:41:14.954982Z","caller":"traceutil/trace.go:171","msg":"trace[2142628930] linearizableReadLoop","detail":"{readStateIndex:9319; appliedIndex:9318; }","duration":"102.169019ms","start":"2026-10-26T19:41:14.852781Z","end":"2026-10-26T19:41:14.95495Z","steps":["trace[2142628930] 'read index received' (duration: 72.625603ms)","trace[2142628930] 'applied index is now lower than readState.Index' (duration: 29.540416ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:41:15.001305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.485337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-fr64h\" ","response":"range_response_count:1 size:4737"} {"level":"info","ts":"2026-10-26T19:41:15.001762Z","caller":"traceutil/trace.go:171","msg":"trace[74004589] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-fr64h; range_end:; response_count:1; response_revision:9000; }","duration":"148.783393ms","start":"2026-10-26T19:41:14.852743Z","end":"2026-10-26T19:41:15.001526Z","steps":["trace[74004589] 'agreement among raft nodes before linearized reading' (duration: 102.303722ms)","trace[74004589] 'range keys from in-memory index tree' (duration: 46.043574ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:42:17.11198Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e2af340d70e332c3","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-26T19:42:17.119008Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-26T19:42:17.119098Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-26T19:42:27.533895Z","caller":"traceutil/trace.go:171","msg":"trace[1429801174] linearizableReadLoop","detail":"{readStateIndex:10101; appliedIndex:10099; }","duration":"116.934593ms","start":"2026-10-26T19:42:27.416935Z","end":"2026-10-26T19:42:27.53387Z","steps":["trace[1429801174] 'read index received' (duration: 38.189483ms)","trace[1429801174] 'applied index is now lower than readState.Index' (duration: 78.74412ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:42:27.534028Z","caller":"traceutil/trace.go:171","msg":"trace[2008846142] transaction","detail":"{read_only:false; response_revision:9756; number_of_response:1; }","duration":"118.660836ms","start":"2026-10-26T19:42:27.415353Z","end":"2026-10-26T19:42:27.534014Z","steps":["trace[2008846142] 'process raft request' (duration: 39.718142ms)","trace[2008846142] 'compare' (duration: 78.603898ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:42:27.534149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.195158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19530"} {"level":"info","ts":"2026-10-26T19:42:27.534229Z","caller":"traceutil/trace.go:171","msg":"trace[1336820120] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:9757; }","duration":"117.30787ms","start":"2026-10-26T19:42:27.416903Z","end":"2026-10-26T19:42:27.534211Z","steps":["trace[1336820120] 'agreement among raft nodes before linearized reading' (duration: 117.112626ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:42:27.534766Z","caller":"traceutil/trace.go:171","msg":"trace[249967703] transaction","detail":"{read_only:false; response_revision:9757; number_of_response:1; }","duration":"118.816889ms","start":"2026-10-26T19:42:27.415573Z","end":"2026-10-26T19:42:27.53439Z","steps":["trace[249967703] 'process raft request' (duration: 118.252938ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:44:05.66625Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8022} {"level":"info","ts":"2026-10-26T19:44:05.756955Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8022,"took":"87.455898ms","hash":2931093087,"current-db-size-bytes":56172544,"current-db-size":"56 MB","current-db-size-in-use-bytes":24956928,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-10-26T19:44:05.757052Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2931093087,"revision":8022,"compact-revision":5736} {"level":"info","ts":"2026-10-26T19:46:28.881959Z","caller":"traceutil/trace.go:171","msg":"trace[424850354] transaction","detail":"{read_only:false; response_revision:11707; number_of_response:1; }","duration":"109.787726ms","start":"2026-10-26T19:46:28.772145Z","end":"2026-10-26T19:46:28.881933Z","steps":["trace[424850354] 'process raft request' (duration: 109.356607ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:49:05.673378Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10417} {"level":"info","ts":"2026-10-26T19:49:05.766097Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10417,"took":"89.378626ms","hash":1653150165,"current-db-size-bytes":56172544,"current-db-size":"56 MB","current-db-size-in-use-bytes":27848704,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-26T19:49:05.766194Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1653150165,"revision":10417,"compact-revision":8022} {"level":"info","ts":"2026-10-26T19:52:18.95609Z","caller":"traceutil/trace.go:171","msg":"trace[1130774533] transaction","detail":"{read_only:false; response_revision:14100; number_of_response:1; }","duration":"142.049458ms","start":"2026-10-26T19:52:18.814012Z","end":"2026-10-26T19:52:18.956061Z","steps":["trace[1130774533] 'process raft request' (duration: 141.807493ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:52:18.957177Z","caller":"traceutil/trace.go:171","msg":"trace[1801734027] transaction","detail":"{read_only:false; response_revision:14102; number_of_response:1; }","duration":"142.345222ms","start":"2026-10-26T19:52:18.814802Z","end":"2026-10-26T19:52:18.957147Z","steps":["trace[1801734027] 'process raft request' (duration: 142.296091ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:52:18.957556Z","caller":"traceutil/trace.go:171","msg":"trace[890822935] transaction","detail":"{read_only:false; response_revision:14101; number_of_response:1; }","duration":"143.324561ms","start":"2026-10-26T19:52:18.814221Z","end":"2026-10-26T19:52:18.957545Z","steps":["trace[890822935] 'process raft request' (duration: 142.73894ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:52:40.94288Z","caller":"traceutil/trace.go:171","msg":"trace[1907172255] transaction","detail":"{read_only:false; response_revision:14221; number_of_response:1; }","duration":"153.65719ms","start":"2026-10-26T19:52:40.789128Z","end":"2026-10-26T19:52:40.942785Z","steps":["trace[1907172255] 'process raft request' (duration: 147.94698ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:53:01.242662Z","caller":"traceutil/trace.go:171","msg":"trace[807200850] linearizableReadLoop","detail":"{readStateIndex:14832; appliedIndex:14831; }","duration":"191.032797ms","start":"2026-10-26T19:53:01.0516Z","end":"2026-10-26T19:53:01.242633Z","steps":["trace[807200850] 'read index received' (duration: 190.842283ms)","trace[807200850] 'applied index is now lower than readState.Index' (duration: 189.264µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:53:01.242697Z","caller":"traceutil/trace.go:171","msg":"trace[2009671665] transaction","detail":"{read_only:false; response_revision:14337; number_of_response:1; }","duration":"194.663877ms","start":"2026-10-26T19:53:01.048007Z","end":"2026-10-26T19:53:01.24267Z","steps":["trace[2009671665] 'process raft request' (duration: 194.438762ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:53:01.242875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.200627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T19:53:01.24292Z","caller":"traceutil/trace.go:171","msg":"trace[669484230] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:14337; }","duration":"183.332549ms","start":"2026-10-26T19:53:01.059573Z","end":"2026-10-26T19:53:01.242905Z","steps":["trace[669484230] 'agreement among raft nodes before linearized reading' (duration: 183.222507ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:53:01.243082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.246313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T19:53:01.243122Z","caller":"traceutil/trace.go:171","msg":"trace[1370876555] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:14337; }","duration":"164.322024ms","start":"2026-10-26T19:53:01.078787Z","end":"2026-10-26T19:53:01.243109Z","steps":["trace[1370876555] 'agreement among raft nodes before linearized reading' (duration: 164.231363ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:53:01.243254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.924184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-zsw9q\" ","response":"range_response_count:1 size:12364"} {"level":"info","ts":"2026-10-26T19:53:01.243283Z","caller":"traceutil/trace.go:171","msg":"trace[187722256] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-zsw9q; range_end:; response_count:1; response_revision:14337; }","duration":"177.976166ms","start":"2026-10-26T19:53:01.065298Z","end":"2026-10-26T19:53:01.243274Z","steps":["trace[187722256] 'agreement among raft nodes before linearized reading' (duration: 177.857814ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:53:01.243464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.830571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T19:53:01.243532Z","caller":"traceutil/trace.go:171","msg":"trace[21110073] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:14337; }","duration":"191.966914ms","start":"2026-10-26T19:53:01.051548Z","end":"2026-10-26T19:53:01.243515Z","steps":["trace[21110073] 'agreement among raft nodes before linearized reading' (duration: 191.838512ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:53:01.380005Z","caller":"traceutil/trace.go:171","msg":"trace[271875650] transaction","detail":"{read_only:false; response_revision:14338; number_of_response:1; }","duration":"132.078355ms","start":"2026-10-26T19:53:01.247878Z","end":"2026-10-26T19:53:01.379957Z","steps":["trace[271875650] 'process raft request' (duration: 131.344931ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:53:01.392001Z","caller":"traceutil/trace.go:171","msg":"trace[492563929] transaction","detail":"{read_only:false; response_revision:14339; number_of_response:1; }","duration":"143.753319ms","start":"2026-10-26T19:53:01.248218Z","end":"2026-10-26T19:53:01.391971Z","steps":["trace[492563929] 'process raft request' (duration: 143.514924ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:53:01.392147Z","caller":"traceutil/trace.go:171","msg":"trace[517270907] linearizableReadLoop","detail":"{readStateIndex:14835; appliedIndex:14832; }","duration":"128.770472ms","start":"2026-10-26T19:53:01.263352Z","end":"2026-10-26T19:53:01.392123Z","steps":["trace[517270907] 'read index received' (duration: 115.888225ms)","trace[517270907] 'applied index is now lower than readState.Index' (duration: 12.879907ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:53:01.392357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.994546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-26T19:53:01.39237Z","caller":"traceutil/trace.go:171","msg":"trace[2140562919] transaction","detail":"{read_only:false; response_revision:14340; number_of_response:1; }","duration":"134.826738ms","start":"2026-10-26T19:53:01.25752Z","end":"2026-10-26T19:53:01.392347Z","steps":["trace[2140562919] 'process raft request' (duration: 134.38439ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:53:01.392397Z","caller":"traceutil/trace.go:171","msg":"trace[1612733133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14340; }","duration":"129.093818ms","start":"2026-10-26T19:53:01.26329Z","end":"2026-10-26T19:53:01.392383Z","steps":["trace[1612733133] 'agreement among raft nodes before linearized reading' (duration: 128.921585ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:53:24.784436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.099577ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-26T19:53:24.840195Z","caller":"traceutil/trace.go:171","msg":"trace[723598094] transaction","detail":"{read_only:false; response_revision:14656; number_of_response:1; }","duration":"214.923636ms","start":"2026-10-26T19:53:24.625242Z","end":"2026-10-26T19:53:24.840166Z","steps":["trace[723598094] 'process raft request' (duration: 214.749632ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:54:05.680438Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12754} {"level":"info","ts":"2026-10-26T19:54:05.774358Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12754,"took":"91.243903ms","hash":2329530673,"current-db-size-bytes":56172544,"current-db-size":"56 MB","current-db-size-in-use-bytes":30978048,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-26T19:54:05.774432Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2329530673,"revision":12754,"compact-revision":10417} {"level":"info","ts":"2026-10-26T19:54:41.93756Z","caller":"traceutil/trace.go:171","msg":"trace[1354082793] transaction","detail":"{read_only:false; response_revision:15422; number_of_response:1; }","duration":"117.553826ms","start":"2026-10-26T19:54:41.819982Z","end":"2026-10-26T19:54:41.937535Z","steps":["trace[1354082793] 'process raft request' (duration: 117.381483ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:54:41.946243Z","caller":"traceutil/trace.go:171","msg":"trace[1041219348] transaction","detail":"{read_only:false; response_revision:15423; number_of_response:1; }","duration":"117.860943ms","start":"2026-10-26T19:54:41.828356Z","end":"2026-10-26T19:54:41.946217Z","steps":["trace[1041219348] 'process raft request' (duration: 117.654559ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:54:42.177425Z","caller":"traceutil/trace.go:171","msg":"trace[918705738] transaction","detail":"{read_only:false; response_revision:15424; number_of_response:1; }","duration":"171.088903ms","start":"2026-10-26T19:54:42.006255Z","end":"2026-10-26T19:54:42.177344Z","steps":["trace[918705738] 'process raft request' (duration: 170.722226ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:54:42.181777Z","caller":"traceutil/trace.go:171","msg":"trace[1639802204] transaction","detail":"{read_only:false; response_revision:15425; number_of_response:1; }","duration":"174.167803ms","start":"2026-10-26T19:54:42.007588Z","end":"2026-10-26T19:54:42.181756Z","steps":["trace[1639802204] 'process raft request' (duration: 173.697103ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:54:42.181974Z","caller":"traceutil/trace.go:171","msg":"trace[981323168] transaction","detail":"{read_only:false; response_revision:15426; number_of_response:1; }","duration":"173.50491ms","start":"2026-10-26T19:54:42.00846Z","end":"2026-10-26T19:54:42.181965Z","steps":["trace[981323168] 'process raft request' (duration: 172.937949ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:59:05.690081Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15192} {"level":"info","ts":"2026-10-26T19:59:05.789132Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15192,"took":"95.714225ms","hash":2396780816,"current-db-size-bytes":56172544,"current-db-size":"56 MB","current-db-size-in-use-bytes":31633408,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-26T19:59:05.789197Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2396780816,"revision":15192,"compact-revision":12754} {"level":"info","ts":"2026-10-26T20:00:46.610906Z","caller":"traceutil/trace.go:171","msg":"trace[1367280834] linearizableReadLoop","detail":"{readStateIndex:18759; appliedIndex:18758; }","duration":"129.869813ms","start":"2026-10-26T20:00:46.480994Z","end":"2026-10-26T20:00:46.610864Z","steps":["trace[1367280834] 'read index received' (duration: 63.534229ms)","trace[1367280834] 'applied index is now lower than readState.Index' (duration: 66.333944ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:00:46.611118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.102707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T20:00:46.611155Z","caller":"traceutil/trace.go:171","msg":"trace[233379394] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18140; }","duration":"130.210169ms","start":"2026-10-26T20:00:46.480932Z","end":"2026-10-26T20:00:46.611142Z","steps":["trace[233379394] 'agreement among raft nodes before linearized reading' (duration: 130.109767ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:00:46.611137Z","caller":"traceutil/trace.go:171","msg":"trace[1019955740] transaction","detail":"{read_only:false; response_revision:18140; number_of_response:1; }","duration":"188.08713ms","start":"2026-10-26T20:00:46.423016Z","end":"2026-10-26T20:00:46.611103Z","steps":["trace[1019955740] 'process raft request' (duration: 121.496502ms)","trace[1019955740] 'compare' (duration: 65.997017ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:00:53.446744Z","caller":"traceutil/trace.go:171","msg":"trace[1988051563] transaction","detail":"{read_only:false; response_revision:18177; number_of_response:1; }","duration":"118.648496ms","start":"2026-10-26T20:00:53.328066Z","end":"2026-10-26T20:00:53.446714Z","steps":["trace[1988051563] 'process raft request' (duration: 25.934668ms)","trace[1988051563] 'compare' (duration: 92.427084ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:00:53.44709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.532605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-26T20:00:53.447155Z","caller":"traceutil/trace.go:171","msg":"trace[409360431] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18177; }","duration":"105.652538ms","start":"2026-10-26T20:00:53.341489Z","end":"2026-10-26T20:00:53.447141Z","steps":["trace[409360431] 'agreement among raft nodes before linearized reading' (duration: 105.363942ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:00:53.446667Z","caller":"traceutil/trace.go:171","msg":"trace[319816234] linearizableReadLoop","detail":"{readStateIndex:18797; appliedIndex:18796; }","duration":"105.110038ms","start":"2026-10-26T20:00:53.34152Z","end":"2026-10-26T20:00:53.44663Z","steps":["trace[319816234] 'read index received' (duration: 12.374128ms)","trace[319816234] 'applied index is now lower than readState.Index' (duration: 92.73441ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:00:53.580485Z","caller":"traceutil/trace.go:171","msg":"trace[2024938362] linearizableReadLoop","detail":"{readStateIndex:18799; appliedIndex:18797; }","duration":"107.484803ms","start":"2026-10-26T20:00:53.472972Z","end":"2026-10-26T20:00:53.580457Z","steps":["trace[2024938362] 'read index received' (duration: 54.382674ms)","trace[2024938362] 'applied index is now lower than readState.Index' (duration: 53.100719ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:00:53.580611Z","caller":"traceutil/trace.go:171","msg":"trace[125526848] transaction","detail":"{read_only:false; response_revision:18179; number_of_response:1; }","duration":"124.980539ms","start":"2026-10-26T20:00:53.455577Z","end":"2026-10-26T20:00:53.580558Z","steps":["trace[125526848] 'process raft request' (duration: 107.459193ms)","trace[125526848] 'compare' (duration: 17.283022ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:00:53.580825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.82295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-26T20:00:53.580874Z","caller":"traceutil/trace.go:171","msg":"trace[1646938514] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:18179; }","duration":"107.915161ms","start":"2026-10-26T20:00:53.472945Z","end":"2026-10-26T20:00:53.58086Z","steps":["trace[1646938514] 'agreement among raft nodes before linearized reading' (duration: 107.637046ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:00:53.594494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.386222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T20:00:53.594617Z","caller":"traceutil/trace.go:171","msg":"trace[2048912824] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18180; }","duration":"106.505385ms","start":"2026-10-26T20:00:53.488076Z","end":"2026-10-26T20:00:53.594581Z","steps":["trace[2048912824] 'agreement among raft nodes before linearized reading' (duration: 106.353162ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:00:53.816164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.221592ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:18"} {"level":"info","ts":"2026-10-26T20:00:53.816507Z","caller":"traceutil/trace.go:171","msg":"trace[502449283] transaction","detail":"{read_only:false; response_revision:18187; number_of_response:1; }","duration":"153.856724ms","start":"2026-10-26T20:00:53.662609Z","end":"2026-10-26T20:00:53.816466Z","steps":["trace[502449283] 'process raft request' (duration: 153.67888ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:00:53.81658Z","caller":"traceutil/trace.go:171","msg":"trace[1040694922] transaction","detail":"{read_only:false; response_revision:18190; number_of_response:1; }","duration":"123.773396ms","start":"2026-10-26T20:00:53.692786Z","end":"2026-10-26T20:00:53.816559Z","steps":["trace[1040694922] 'process raft request' (duration: 123.706414ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:00:53.816952Z","caller":"traceutil/trace.go:171","msg":"trace[2065781566] transaction","detail":"{read_only:false; response_revision:18188; number_of_response:1; }","duration":"154.033536ms","start":"2026-10-26T20:00:53.662873Z","end":"2026-10-26T20:00:53.816907Z","steps":["trace[2065781566] 'process raft request' (duration: 153.509266ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:00:53.817252Z","caller":"traceutil/trace.go:171","msg":"trace[1925964589] transaction","detail":"{read_only:false; response_revision:18189; number_of_response:1; }","duration":"153.865584ms","start":"2026-10-26T20:00:53.663367Z","end":"2026-10-26T20:00:53.817233Z","steps":["trace[1925964589] 'process raft request' (duration: 153.067338ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:00:53.817505Z","caller":"traceutil/trace.go:171","msg":"trace[882308975] transaction","detail":"{read_only:false; response_revision:18186; number_of_response:1; }","duration":"155.384272ms","start":"2026-10-26T20:00:53.6621Z","end":"2026-10-26T20:00:53.817484Z","steps":["trace[882308975] 'process raft request' (duration: 37.751514ms)","trace[882308975] 'compare' (duration: 115.64796ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:00:53.970802Z","caller":"traceutil/trace.go:171","msg":"trace[1562764803] transaction","detail":"{read_only:false; response_revision:18193; number_of_response:1; }","duration":"108.922011ms","start":"2026-10-26T20:00:53.861853Z","end":"2026-10-26T20:00:53.970775Z","steps":["trace[1562764803] 'process raft request' (duration: 108.552883ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:00:54.018047Z","caller":"traceutil/trace.go:171","msg":"trace[1586867073] transaction","detail":"{read_only:false; response_revision:18194; number_of_response:1; }","duration":"130.644787ms","start":"2026-10-26T20:00:53.887379Z","end":"2026-10-26T20:00:54.018024Z","steps":["trace[1586867073] 'process raft request' (duration: 130.481044ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:00:54.018646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.266299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1344"} {"level":"info","ts":"2026-10-26T20:00:54.018702Z","caller":"traceutil/trace.go:171","msg":"trace[269305871] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:18194; }","duration":"131.339ms","start":"2026-10-26T20:00:53.887347Z","end":"2026-10-26T20:00:54.018686Z","steps":["trace[269305871] 'agreement among raft nodes before linearized reading' (duration: 131.166107ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:00:54.459367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.376215ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:18"} {"level":"info","ts":"2026-10-26T20:00:54.459703Z","caller":"traceutil/trace.go:171","msg":"trace[1167113199] transaction","detail":"{read_only:false; response_revision:18196; number_of_response:1; }","duration":"435.359868ms","start":"2026-10-26T20:00:54.024323Z","end":"2026-10-26T20:00:54.459683Z","steps":["trace[1167113199] 'process raft request' (duration: 435.256776ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:00:54.459965Z","caller":"traceutil/trace.go:171","msg":"trace[719674046] linearizableReadLoop","detail":"{readStateIndex:18815; appliedIndex:18814; }","duration":"441.71879ms","start":"2026-10-26T20:00:54.018177Z","end":"2026-10-26T20:00:54.459896Z","steps":["trace[719674046] 'read index received' (duration: 212.766184ms)","trace[719674046] 'applied index is now lower than readState.Index' (duration: 228.949266ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:00:54.460104Z","caller":"traceutil/trace.go:171","msg":"trace[841354026] transaction","detail":"{read_only:false; response_revision:18195; number_of_response:1; }","duration":"482.623655ms","start":"2026-10-26T20:00:53.977463Z","end":"2026-10-26T20:00:54.460087Z","steps":["trace[841354026] 'process raft request' (duration: 253.442555ms)","trace[841354026] 'compare' (duration: 228.18012ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:00:54.460218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:00:53.977436Z","time spent":"482.712865ms","remote":"127.0.0.1:46240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1331,"response count":0,"response size":42,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-26T20:00:54.460542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.51836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-26T20:00:54.460578Z","caller":"traceutil/trace.go:171","msg":"trace[1339734505] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18196; }","duration":"484.594212ms","start":"2026-10-26T20:00:53.97597Z","end":"2026-10-26T20:00:54.460564Z","steps":["trace[1339734505] 'agreement among raft nodes before linearized reading' (duration: 484.439659ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:00:54.460605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:00:53.975936Z","time spent":"484.661873ms","remote":"127.0.0.1:43374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-26T20:00:54.460605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.010875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12433"} {"level":"info","ts":"2026-10-26T20:00:54.460675Z","caller":"traceutil/trace.go:171","msg":"trace[319319513] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18196; }","duration":"477.111398ms","start":"2026-10-26T20:00:53.983543Z","end":"2026-10-26T20:00:54.460654Z","steps":["trace[319319513] 'agreement among raft nodes before linearized reading' (duration: 476.881773ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:00:54.460715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:00:53.983526Z","time spent":"477.180759ms","remote":"127.0.0.1:46312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12457,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-10-26T20:00:54.460834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.707753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1344"} {"level":"warn","ts":"2026-10-26T20:00:54.460864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.13676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-26T20:00:54.460962Z","caller":"traceutil/trace.go:171","msg":"trace[1577455840] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:18196; }","duration":"435.854746ms","start":"2026-10-26T20:00:54.025058Z","end":"2026-10-26T20:00:54.460913Z","steps":["trace[1577455840] 'agreement among raft nodes before linearized reading' (duration: 435.510219ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:00:54.460999Z","caller":"traceutil/trace.go:171","msg":"trace[313494509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18196; }","duration":"129.361944ms","start":"2026-10-26T20:00:54.33161Z","end":"2026-10-26T20:00:54.460972Z","steps":["trace[313494509] 'agreement among raft nodes before linearized reading' (duration: 128.963146ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:00:54.461023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:00:54.025044Z","time spent":"435.965028ms","remote":"127.0.0.1:46234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":1,"response size":1368,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" "} {"level":"warn","ts":"2026-10-26T20:00:54.460961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.632227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-tvw7l\" ","response":"range_response_count:1 size:22132"} {"level":"info","ts":"2026-10-26T20:00:54.461126Z","caller":"traceutil/trace.go:171","msg":"trace[1123493042] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-tvw7l; range_end:; response_count:1; response_revision:18196; }","duration":"130.875612ms","start":"2026-10-26T20:00:54.330205Z","end":"2026-10-26T20:00:54.461081Z","steps":["trace[1123493042] 'agreement among raft nodes before linearized reading' (duration: 130.413493ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:00:54.460853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.29161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-10-26T20:00:54.461176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.458309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-10-26T20:00:54.461235Z","caller":"traceutil/trace.go:171","msg":"trace[31828477] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18196; }","duration":"131.694378ms","start":"2026-10-26T20:00:54.32952Z","end":"2026-10-26T20:00:54.461214Z","steps":["trace[31828477] 'agreement among raft nodes before linearized reading' (duration: 131.206378ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:00:54.461257Z","caller":"traceutil/trace.go:171","msg":"trace[1154482811] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:18196; }","duration":"161.554631ms","start":"2026-10-26T20:00:54.299679Z","end":"2026-10-26T20:00:54.461234Z","steps":["trace[1154482811] 'agreement among raft nodes before linearized reading' (duration: 161.347357ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:00:54.461874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.680698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-c78b8\" ","response":"range_response_count:1 size:20909"} {"level":"warn","ts":"2026-10-26T20:00:54.461951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.288985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225409"} {"level":"info","ts":"2026-10-26T20:00:54.461961Z","caller":"traceutil/trace.go:171","msg":"trace[171576538] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-c78b8; range_end:; response_count:1; response_revision:18196; }","duration":"477.76883ms","start":"2026-10-26T20:00:53.984172Z","end":"2026-10-26T20:00:54.461941Z","steps":["trace[171576538] 'agreement among raft nodes before linearized reading' (duration: 476.22452ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:00:54.462011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:00:53.984127Z","time spent":"477.871972ms","remote":"127.0.0.1:46312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20933,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-c78b8\" "} {"level":"info","ts":"2026-10-26T20:00:54.462003Z","caller":"traceutil/trace.go:171","msg":"trace[712320260] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:18196; }","duration":"188.378117ms","start":"2026-10-26T20:00:54.27361Z","end":"2026-10-26T20:00:54.461988Z","steps":["trace[712320260] 'agreement among raft nodes before linearized reading' (duration: 187.433158ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:00:54.462221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.696664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:96 size:965373"} {"level":"info","ts":"2026-10-26T20:00:54.462276Z","caller":"traceutil/trace.go:171","msg":"trace[758949402] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:96; response_revision:18196; }","duration":"484.797566ms","start":"2026-10-26T20:00:53.977462Z","end":"2026-10-26T20:00:54.46226Z","steps":["trace[758949402] 'agreement among raft nodes before linearized reading' (duration: 482.824057ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:00:54.462345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:00:53.977441Z","time spent":"484.890487ms","remote":"127.0.0.1:46312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":96,"response size":965397,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"warn","ts":"2026-10-26T20:00:54.459771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:00:54.024297Z","time spent":"435.443209ms","remote":"127.0.0.1:46218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":725,"response count":0,"response size":42,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-26T20:00:54.593215Z","caller":"traceutil/trace.go:171","msg":"trace[200307400] transaction","detail":"{read_only:false; response_revision:18199; number_of_response:1; }","duration":"116.1537ms","start":"2026-10-26T20:00:54.477031Z","end":"2026-10-26T20:00:54.593185Z","steps":["trace[200307400] 'process raft request' (duration: 115.952046ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:00:54.59334Z","caller":"traceutil/trace.go:171","msg":"trace[1586295196] transaction","detail":"{read_only:false; response_revision:18201; number_of_response:1; }","duration":"116.228421ms","start":"2026-10-26T20:00:54.477098Z","end":"2026-10-26T20:00:54.593327Z","steps":["trace[1586295196] 'process raft request' (duration: 115.992897ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:00:54.593234Z","caller":"traceutil/trace.go:171","msg":"trace[285582339] transaction","detail":"{read_only:false; response_revision:18198; number_of_response:1; }","duration":"116.405204ms","start":"2026-10-26T20:00:54.476795Z","end":"2026-10-26T20:00:54.5932Z","steps":["trace[285582339] 'process raft request' (duration: 115.981506ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:00:54.593543Z","caller":"traceutil/trace.go:171","msg":"trace[2109217815] transaction","detail":"{read_only:false; response_revision:18202; number_of_response:1; }","duration":"116.404245ms","start":"2026-10-26T20:00:54.477098Z","end":"2026-10-26T20:00:54.593503Z","steps":["trace[2109217815] 'process raft request' (duration: 116.035548ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:00:54.593633Z","caller":"traceutil/trace.go:171","msg":"trace[866277755] transaction","detail":"{read_only:false; response_revision:18203; number_of_response:1; }","duration":"116.470876ms","start":"2026-10-26T20:00:54.477145Z","end":"2026-10-26T20:00:54.593616Z","steps":["trace[866277755] 'process raft request' (duration: 116.297683ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:00:54.593237Z","caller":"traceutil/trace.go:171","msg":"trace[1479215064] transaction","detail":"{read_only:false; response_revision:18200; number_of_response:1; }","duration":"116.114599ms","start":"2026-10-26T20:00:54.477094Z","end":"2026-10-26T20:00:54.593208Z","steps":["trace[1479215064] 'process raft request' (duration: 115.955506ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:00:54.593847Z","caller":"traceutil/trace.go:171","msg":"trace[1596473303] transaction","detail":"{read_only:false; response_revision:18204; number_of_response:1; }","duration":"100.59527ms","start":"2026-10-26T20:00:54.493231Z","end":"2026-10-26T20:00:54.593826Z","steps":["trace[1596473303] 'process raft request' (duration: 100.356355ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:00:54.600387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.154857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T20:00:54.600455Z","caller":"traceutil/trace.go:171","msg":"trace[1155993664] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18204; }","duration":"118.255858ms","start":"2026-10-26T20:00:54.482185Z","end":"2026-10-26T20:00:54.60044Z","steps":["trace[1155993664] 'agreement among raft nodes before linearized reading' (duration: 118.122866ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:00:54.600758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.991869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:651"} {"level":"info","ts":"2026-10-26T20:00:54.600817Z","caller":"traceutil/trace.go:171","msg":"trace[291808573] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:18204; }","duration":"124.105381ms","start":"2026-10-26T20:00:54.476689Z","end":"2026-10-26T20:00:54.600794Z","steps":["trace[291808573] 'agreement among raft nodes before linearized reading' (duration: 123.936548ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:00:54.60202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.150341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:96 size:965505"} {"level":"info","ts":"2026-10-26T20:00:54.602106Z","caller":"traceutil/trace.go:171","msg":"trace[1865217465] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:96; response_revision:18204; }","duration":"125.288995ms","start":"2026-10-26T20:00:54.476798Z","end":"2026-10-26T20:00:54.602087Z","steps":["trace[1865217465] 'agreement among raft nodes before linearized reading' (duration: 123.53286ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:02:57.345793Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e2af340d70e332c3","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-26T20:02:57.351367Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-26T20:02:57.351595Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-26T20:04:05.700437Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17397} {"level":"info","ts":"2026-10-26T20:04:05.807352Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17397,"took":"103.102158ms","hash":30791513,"current-db-size-bytes":56172544,"current-db-size":"56 MB","current-db-size-in-use-bytes":34689024,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-10-26T20:04:05.807407Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":30791513,"revision":17397,"compact-revision":15192} {"level":"info","ts":"2026-10-26T20:06:19.196255Z","caller":"traceutil/trace.go:171","msg":"trace[1143415746] transaction","detail":"{read_only:false; response_revision:20800; number_of_response:1; }","duration":"107.062216ms","start":"2026-10-26T20:06:19.089164Z","end":"2026-10-26T20:06:19.196226Z","steps":["trace[1143415746] 'process raft request' (duration: 106.884802ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:06:19.584139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.431013ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-26T20:06:19.584455Z","caller":"traceutil/trace.go:171","msg":"trace[293830651] linearizableReadLoop","detail":"{readStateIndex:21509; appliedIndex:21506; }","duration":"102.944436ms","start":"2026-10-26T20:06:19.481493Z","end":"2026-10-26T20:06:19.584437Z","steps":["trace[293830651] 'read index received' (duration: 33.601µs)","trace[293830651] 'applied index is now lower than readState.Index' (duration: 102.909665ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:06:19.584495Z","caller":"traceutil/trace.go:171","msg":"trace[1450976559] transaction","detail":"{read_only:false; response_revision:20802; number_of_response:1; }","duration":"256.32857ms","start":"2026-10-26T20:06:19.328129Z","end":"2026-10-26T20:06:19.584457Z","steps":["trace[1450976559] 'process raft request' (duration: 256.151908ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:06:19.584711Z","caller":"traceutil/trace.go:171","msg":"trace[1081103148] transaction","detail":"{read_only:false; response_revision:20803; number_of_response:1; }","duration":"174.869526ms","start":"2026-10-26T20:06:19.409829Z","end":"2026-10-26T20:06:19.584698Z","steps":["trace[1081103148] 'process raft request' (duration: 174.56721ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:06:19.584728Z","caller":"traceutil/trace.go:171","msg":"trace[729826833] transaction","detail":"{read_only:false; response_revision:20801; number_of_response:1; }","duration":"266.535515ms","start":"2026-10-26T20:06:19.318163Z","end":"2026-10-26T20:06:19.584698Z","steps":["trace[729826833] 'process raft request' (duration: 122.44508ms)","trace[729826833] 'compare' (duration: 143.112527ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:06:19.584861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.364714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T20:06:19.584895Z","caller":"traceutil/trace.go:171","msg":"trace[1993591939] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20803; }","duration":"103.450406ms","start":"2026-10-26T20:06:19.481435Z","end":"2026-10-26T20:06:19.584885Z","steps":["trace[1993591939] 'agreement among raft nodes before linearized reading' (duration: 103.394574ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:06:35.380028Z","caller":"traceutil/trace.go:171","msg":"trace[1384248374] transaction","detail":"{read_only:false; response_revision:20882; number_of_response:1; }","duration":"108.044924ms","start":"2026-10-26T20:06:35.271929Z","end":"2026-10-26T20:06:35.379974Z","steps":["trace[1384248374] 'process raft request' (duration: 107.879841ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:06:36.15805Z","caller":"traceutil/trace.go:171","msg":"trace[1135493688] transaction","detail":"{read_only:false; response_revision:20884; number_of_response:1; }","duration":"122.254876ms","start":"2026-10-26T20:06:36.035767Z","end":"2026-10-26T20:06:36.158022Z","steps":["trace[1135493688] 'process raft request' (duration: 122.064902ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:06:36.742003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.278641ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-26T20:06:36.742226Z","caller":"traceutil/trace.go:171","msg":"trace[1438481037] transaction","detail":"{read_only:false; response_revision:20886; number_of_response:1; }","duration":"221.345699ms","start":"2026-10-26T20:06:36.520855Z","end":"2026-10-26T20:06:36.742201Z","steps":["trace[1438481037] 'process raft request' (duration: 65.753462ms)","trace[1438481037] 'compare' (duration: 155.158289ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:06:36.749373Z","caller":"traceutil/trace.go:171","msg":"trace[808584458] linearizableReadLoop","detail":"{readStateIndex:21596; appliedIndex:21594; }","duration":"216.831722ms","start":"2026-10-26T20:06:36.532518Z","end":"2026-10-26T20:06:36.749349Z","steps":["trace[808584458] 'read index received' (duration: 54.104108ms)","trace[808584458] 'applied index is now lower than readState.Index' (duration: 162.726784ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:06:36.749466Z","caller":"traceutil/trace.go:171","msg":"trace[25738257] transaction","detail":"{read_only:false; response_revision:20887; number_of_response:1; }","duration":"228.22331ms","start":"2026-10-26T20:06:36.521214Z","end":"2026-10-26T20:06:36.749437Z","steps":["trace[25738257] 'process raft request' (duration: 228.008066ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:06:36.74961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.431892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-26T20:06:36.74965Z","caller":"traceutil/trace.go:171","msg":"trace[437058333] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20887; }","duration":"207.507534ms","start":"2026-10-26T20:06:36.542132Z","end":"2026-10-26T20:06:36.749639Z","steps":["trace[437058333] 'agreement among raft nodes before linearized reading' (duration: 207.34389ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:06:36.749715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.175438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-26T20:06:36.749809Z","caller":"traceutil/trace.go:171","msg":"trace[1473746787] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20887; }","duration":"217.309941ms","start":"2026-10-26T20:06:36.532477Z","end":"2026-10-26T20:06:36.749787Z","steps":["trace[1473746787] 'agreement among raft nodes before linearized reading' (duration: 216.988764ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:09:05.70723Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19766} {"level":"info","ts":"2026-10-26T20:09:05.83053Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19766,"took":"118.456184ms","hash":2401977550,"current-db-size-bytes":56172544,"current-db-size":"56 MB","current-db-size-in-use-bytes":30531584,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-26T20:09:05.830607Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2401977550,"revision":19766,"compact-revision":17397} {"level":"info","ts":"2026-10-26T20:10:31.11963Z","caller":"traceutil/trace.go:171","msg":"trace[1423013948] transaction","detail":"{read_only:false; response_revision:23350; number_of_response:1; }","duration":"129.163639ms","start":"2026-10-26T20:10:30.990443Z","end":"2026-10-26T20:10:31.119607Z","steps":["trace[1423013948] 'process raft request' (duration: 128.959865ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:10:31.431005Z","caller":"traceutil/trace.go:171","msg":"trace[842403494] transaction","detail":"{read_only:false; response_revision:23353; number_of_response:1; }","duration":"111.428009ms","start":"2026-10-26T20:10:31.319546Z","end":"2026-10-26T20:10:31.430974Z","steps":["trace[842403494] 'process raft request' (duration: 101.921727ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:05.488832Z","caller":"traceutil/trace.go:171","msg":"trace[1114380439] linearizableReadLoop","detail":"{readStateIndex:26251; appliedIndex:26249; }","duration":"157.407968ms","start":"2026-10-26T20:14:05.331396Z","end":"2026-10-26T20:14:05.488804Z","steps":["trace[1114380439] 'read index received' (duration: 15.362604ms)","trace[1114380439] 'applied index is now lower than readState.Index' (duration: 142.044074ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:14:05.489144Z","caller":"traceutil/trace.go:171","msg":"trace[917701916] transaction","detail":"{read_only:false; response_revision:25417; number_of_response:1; }","duration":"207.368035ms","start":"2026-10-26T20:14:05.281762Z","end":"2026-10-26T20:14:05.489131Z","steps":["trace[917701916] 'process raft request' (duration: 206.867086ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:05.48973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.653117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-26T20:14:05.489784Z","caller":"traceutil/trace.go:171","msg":"trace[994448675] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25417; }","duration":"102.757259ms","start":"2026-10-26T20:14:05.387012Z","end":"2026-10-26T20:14:05.489769Z","steps":["trace[994448675] 'agreement among raft nodes before linearized reading' (duration: 102.632237ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:14:05.489879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.023818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-26T20:14:05.48991Z","caller":"traceutil/trace.go:171","msg":"trace[220911429] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25417; }","duration":"158.558039ms","start":"2026-10-26T20:14:05.331342Z","end":"2026-10-26T20:14:05.4899Z","steps":["trace[220911429] 'agreement among raft nodes before linearized reading' (duration: 157.983158ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:14:05.783861Z","caller":"traceutil/trace.go:171","msg":"trace[1050010978] transaction","detail":"{read_only:false; response_revision:25422; number_of_response:1; }","duration":"180.870037ms","start":"2026-10-26T20:14:05.602961Z","end":"2026-10-26T20:14:05.783831Z","steps":["trace[1050010978] 'process raft request' (duration: 121.323335ms)","trace[1050010978] 'compare' (duration: 59.206045ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:14:05.807513Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22045} {"level":"info","ts":"2026-10-26T20:14:06.229751Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22045,"took":"416.242758ms","hash":325986478,"current-db-size-bytes":59437056,"current-db-size":"59 MB","current-db-size-in-use-bytes":45453312,"current-db-size-in-use":"46 MB"} {"level":"info","ts":"2026-10-26T20:14:06.229824Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":325986478,"revision":22045,"compact-revision":19766} {"level":"info","ts":"2026-10-26T20:14:21.146912Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006709.wal"} {"level":"warn","ts":"2026-10-26T20:15:02.001829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.944437ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-26T20:15:02.001967Z","caller":"traceutil/trace.go:171","msg":"trace[1860809071] transaction","detail":"{read_only:false; response_revision:25949; number_of_response:1; }","duration":"156.04273ms","start":"2026-10-26T20:15:01.845904Z","end":"2026-10-26T20:15:02.001947Z","steps":["trace[1860809071] 'process raft request' (duration: 32.857269ms)","trace[1860809071] 'compare' (duration: 122.746403ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:15:02.002377Z","caller":"traceutil/trace.go:171","msg":"trace[1152502028] linearizableReadLoop","detail":"{readStateIndex:26797; appliedIndex:26795; }","duration":"152.075226ms","start":"2026-10-26T20:15:01.85029Z","end":"2026-10-26T20:15:02.002365Z","steps":["trace[1152502028] 'read index received' (duration: 28.620689ms)","trace[1152502028] 'applied index is now lower than readState.Index' (duration: 123.453127ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:15:02.002501Z","caller":"traceutil/trace.go:171","msg":"trace[1934010214] transaction","detail":"{read_only:false; response_revision:25950; number_of_response:1; }","duration":"155.644394ms","start":"2026-10-26T20:15:01.846816Z","end":"2026-10-26T20:15:02.002461Z","steps":["trace[1934010214] 'process raft request' (duration: 155.446701ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:15:02.002629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.078575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"warn","ts":"2026-10-26T20:15:02.002554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.258159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/heat-engine-cleaner-29884095-6dc95\" ","response":"range_response_count:1 size:6988"} {"level":"info","ts":"2026-10-26T20:15:02.002724Z","caller":"traceutil/trace.go:171","msg":"trace[1002100944] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25950; }","duration":"140.221638ms","start":"2026-10-26T20:15:01.862478Z","end":"2026-10-26T20:15:02.0027Z","steps":["trace[1002100944] 'agreement among raft nodes before linearized reading' (duration: 139.992624ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:15:02.002829Z","caller":"traceutil/trace.go:171","msg":"trace[728111834] range","detail":"{range_begin:/registry/pods/openstack/heat-engine-cleaner-29884095-6dc95; range_end:; response_count:1; response_revision:25950; }","duration":"152.516624ms","start":"2026-10-26T20:15:01.850243Z","end":"2026-10-26T20:15:02.00276Z","steps":["trace[728111834] 'agreement among raft nodes before linearized reading' (duration: 152.211038ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:15:03.564312Z","caller":"traceutil/trace.go:171","msg":"trace[1993283386] transaction","detail":"{read_only:false; response_revision:25960; number_of_response:1; }","duration":"141.241708ms","start":"2026-10-26T20:15:03.423036Z","end":"2026-10-26T20:15:03.564277Z","steps":["trace[1993283386] 'process raft request' (duration: 141.122735ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:15:03.835935Z","caller":"traceutil/trace.go:171","msg":"trace[1267296303] linearizableReadLoop","detail":"{readStateIndex:26809; appliedIndex:26808; }","duration":"124.329013ms","start":"2026-10-26T20:15:03.711575Z","end":"2026-10-26T20:15:03.835904Z","steps":["trace[1267296303] 'read index received' (duration: 121.968778ms)","trace[1267296303] 'applied index is now lower than readState.Index' (duration: 2.358615ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:15:03.836026Z","caller":"traceutil/trace.go:171","msg":"trace[729422355] transaction","detail":"{read_only:false; response_revision:25962; number_of_response:1; }","duration":"128.027844ms","start":"2026-10-26T20:15:03.707944Z","end":"2026-10-26T20:15:03.835972Z","steps":["trace[729422355] 'process raft request' (duration: 125.481365ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:15:03.836106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.493747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T20:15:03.836162Z","caller":"traceutil/trace.go:171","msg":"trace[1162265274] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25962; }","duration":"124.624509ms","start":"2026-10-26T20:15:03.711524Z","end":"2026-10-26T20:15:03.836149Z","steps":["trace[1162265274] 'agreement among raft nodes before linearized reading' (duration: 124.486416ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:15:03.907417Z","caller":"traceutil/trace.go:171","msg":"trace[1990699966] transaction","detail":"{read_only:false; response_revision:25963; number_of_response:1; }","duration":"146.532438ms","start":"2026-10-26T20:15:03.760842Z","end":"2026-10-26T20:15:03.907375Z","steps":["trace[1990699966] 'process raft request' (duration: 146.211611ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:15:04.172558Z","caller":"traceutil/trace.go:171","msg":"trace[972872097] transaction","detail":"{read_only:false; response_revision:25966; number_of_response:1; }","duration":"155.192215ms","start":"2026-10-26T20:15:04.017345Z","end":"2026-10-26T20:15:04.172537Z","steps":["trace[972872097] 'process raft request' (duration: 155.104193ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:15:04.172725Z","caller":"traceutil/trace.go:171","msg":"trace[1894286795] transaction","detail":"{read_only:false; response_revision:25965; number_of_response:1; }","duration":"155.593174ms","start":"2026-10-26T20:15:04.017124Z","end":"2026-10-26T20:15:04.172717Z","steps":["trace[1894286795] 'process raft request' (duration: 153.499843ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:15:04.172864Z","caller":"traceutil/trace.go:171","msg":"trace[543795418] transaction","detail":"{read_only:false; response_revision:25967; number_of_response:1; }","duration":"134.427705ms","start":"2026-10-26T20:15:04.038428Z","end":"2026-10-26T20:15:04.172856Z","steps":["trace[543795418] 'process raft request' (duration: 134.069439ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:15:04.51204Z","caller":"traceutil/trace.go:171","msg":"trace[293018797] linearizableReadLoop","detail":"{readStateIndex:26815; appliedIndex:26814; }","duration":"114.733369ms","start":"2026-10-26T20:15:04.397286Z","end":"2026-10-26T20:15:04.51202Z","steps":["trace[293018797] 'read index received' (duration: 114.548786ms)","trace[293018797] 'applied index is now lower than readState.Index' (duration: 183.873µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:15:04.512142Z","caller":"traceutil/trace.go:171","msg":"trace[1811377351] transaction","detail":"{read_only:false; response_revision:25968; number_of_response:1; }","duration":"132.183623ms","start":"2026-10-26T20:15:04.379924Z","end":"2026-10-26T20:15:04.512108Z","steps":["trace[1811377351] 'process raft request' (duration: 131.965939ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:15:04.512215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.897042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T20:15:04.512283Z","caller":"traceutil/trace.go:171","msg":"trace[1062614314] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:25968; }","duration":"114.989194ms","start":"2026-10-26T20:15:04.39728Z","end":"2026-10-26T20:15:04.512269Z","steps":["trace[1062614314] 'agreement among raft nodes before linearized reading' (duration: 114.860732ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:19:05.814742Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25423} {"level":"info","ts":"2026-10-26T20:19:05.988505Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25423,"took":"169.137931ms","hash":3569418248,"current-db-size-bytes":60297216,"current-db-size":"60 MB","current-db-size-in-use-bytes":36179968,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-26T20:19:05.988581Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3569418248,"revision":25423,"compact-revision":22045} {"level":"info","ts":"2026-10-26T20:20:34.981604Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e2af340d70e332c3","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-26T20:20:34.992425Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-26T20:20:34.992529Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-26T20:24:05.822298Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28369} {"level":"info","ts":"2026-10-26T20:24:05.973412Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28369,"took":"145.850133ms","hash":3416378989,"current-db-size-bytes":60297216,"current-db-size":"60 MB","current-db-size-in-use-bytes":31305728,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-26T20:24:05.973501Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3416378989,"revision":28369,"compact-revision":25423} {"level":"info","ts":"2026-10-26T20:29:05.830129Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30613} {"level":"info","ts":"2026-10-26T20:29:05.950988Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30613,"took":"116.822978ms","hash":680467816,"current-db-size-bytes":60297216,"current-db-size":"60 MB","current-db-size-in-use-bytes":31293440,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-26T20:29:05.951058Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":680467816,"revision":30613,"compact-revision":28369} {"level":"info","ts":"2026-10-26T20:34:05.838023Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32865} {"level":"info","ts":"2026-10-26T20:34:05.992757Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32865,"took":"150.076464ms","hash":1993995758,"current-db-size-bytes":60297216,"current-db-size":"60 MB","current-db-size-in-use-bytes":30253056,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-26T20:34:05.992848Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1993995758,"revision":32865,"compact-revision":30613} {"level":"info","ts":"2026-10-26T20:39:05.845843Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35092} {"level":"info","ts":"2026-10-26T20:39:05.986368Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35092,"took":"135.317313ms","hash":1169234688,"current-db-size-bytes":60772352,"current-db-size":"61 MB","current-db-size-in-use-bytes":32858112,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-26T20:39:05.986432Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1169234688,"revision":35092,"compact-revision":32865} {"level":"info","ts":"2026-10-26T20:42:06.668918Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e2af340d70e332c3","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-26T20:42:06.676027Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-26T20:42:06.676154Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-26T20:44:05.855328Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37388} {"level":"info","ts":"2026-10-26T20:44:05.988038Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37388,"took":"128.3274ms","hash":3188338639,"current-db-size-bytes":61624320,"current-db-size":"62 MB","current-db-size-in-use-bytes":32677888,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-26T20:44:05.988117Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3188338639,"revision":37388,"compact-revision":35092} {"level":"info","ts":"2026-10-26T20:49:05.863404Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39664} {"level":"info","ts":"2026-10-26T20:49:05.997247Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39664,"took":"129.226711ms","hash":853931264,"current-db-size-bytes":61624320,"current-db-size":"62 MB","current-db-size-in-use-bytes":30720000,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-26T20:49:05.997329Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":853931264,"revision":39664,"compact-revision":37388}