{"level":"warn","ts":"2026-10-21T01:16:26.583451Z","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-21T01:16:26.583564Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.206: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.206:2380","--initial-cluster=instance=https://162.253.55.206:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.206:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.206: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-21T01:16:26.583647Z","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-21T01:16:26.583666Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.206:2380"]} {"level":"info","ts":"2026-10-21T01:16:26.58369Z","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-21T01:16:26.584765Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.206:2379"]} {"level":"info","ts":"2026-10-21T01:16:26.584909Z","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.206:2380"],"listen-peer-urls":["https://162.253.55.206:2380"],"advertise-client-urls":["https://162.253.55.206:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.206:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.206: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-21T01:16:26.589865Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.634396ms"} {"level":"info","ts":"2026-10-21T01:16:26.60028Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cfc9fec265e3384a","cluster-id":"9866fe2b0d49ed88"} {"level":"info","ts":"2026-10-21T01:16:26.600373Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a switched to configuration voters=()"} {"level":"info","ts":"2026-10-21T01:16:26.600403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became follower at term 0"} {"level":"info","ts":"2026-10-21T01:16:26.600417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cfc9fec265e3384a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-21T01:16:26.600438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became follower at term 1"} {"level":"info","ts":"2026-10-21T01:16:26.600489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a switched to configuration voters=(14972778547056425034)"} {"level":"warn","ts":"2026-10-21T01:16:26.610615Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-21T01:16:26.613908Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-21T01:16:26.617601Z","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-21T01:16:26.621468Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cfc9fec265e3384a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-21T01:16:26.622114Z","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-21T01:16:26.622078Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cfc9fec265e3384a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-21T01:16:26.622181Z","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-21T01:16:26.622218Z","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-21T01:16:26.623065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a switched to configuration voters=(14972778547056425034)"} {"level":"info","ts":"2026-10-21T01:16:26.623277Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9866fe2b0d49ed88","local-member-id":"cfc9fec265e3384a","added-peer-id":"cfc9fec265e3384a","added-peer-peer-urls":["https://162.253.55.206:2380"]} {"level":"info","ts":"2026-10-21T01:16:26.627398Z","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-21T01:16:26.627605Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.206:2380"} {"level":"info","ts":"2026-10-21T01:16:26.627686Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.206:2380"} {"level":"info","ts":"2026-10-21T01:16:26.627757Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cfc9fec265e3384a","initial-advertise-peer-urls":["https://162.253.55.206:2380"],"listen-peer-urls":["https://162.253.55.206:2380"],"advertise-client-urls":["https://162.253.55.206:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.206:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-21T01:16:26.627799Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-21T01:16:26.701607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a is starting a new election at term 1"} {"level":"info","ts":"2026-10-21T01:16:26.701688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became pre-candidate at term 1"} {"level":"info","ts":"2026-10-21T01:16:26.701733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a received MsgPreVoteResp from cfc9fec265e3384a at term 1"} {"level":"info","ts":"2026-10-21T01:16:26.701752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became candidate at term 2"} {"level":"info","ts":"2026-10-21T01:16:26.701774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a received MsgVoteResp from cfc9fec265e3384a at term 2"} {"level":"info","ts":"2026-10-21T01:16:26.70179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became leader at term 2"} {"level":"info","ts":"2026-10-21T01:16:26.701804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cfc9fec265e3384a elected leader cfc9fec265e3384a at term 2"} {"level":"info","ts":"2026-10-21T01:16:26.703133Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cfc9fec265e3384a","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.206:2379]}","request-path":"/0/members/cfc9fec265e3384a/attributes","cluster-id":"9866fe2b0d49ed88","publish-timeout":"7s"} {"level":"info","ts":"2026-10-21T01:16:26.703149Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-21T01:16:26.703179Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-21T01:16:26.703138Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-21T01:16:26.703416Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-21T01:16:26.703588Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-21T01:16:26.704428Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9866fe2b0d49ed88","local-member-id":"cfc9fec265e3384a","cluster-version":"3.5"} {"level":"info","ts":"2026-10-21T01:16:26.704537Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-21T01:16:26.70457Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-21T01:16:26.706292Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-21T01:16:26.70654Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.206:2379"} {"level":"info","ts":"2026-10-21T01:17:18.186807Z","caller":"traceutil/trace.go:171","msg":"trace[1586659056] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"195.788431ms","start":"2026-10-21T01:17:17.990979Z","end":"2026-10-21T01:17:18.186768Z","steps":["trace[1586659056] 'process raft request' (duration: 195.195566ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:17:18.401768Z","caller":"traceutil/trace.go:171","msg":"trace[1794707158] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"197.854671ms","start":"2026-10-21T01:17:18.203886Z","end":"2026-10-21T01:17:18.401741Z","steps":["trace[1794707158] 'process raft request' (duration: 197.097233ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:17:18.776528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.026669ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-21T01:17:18.77665Z","caller":"traceutil/trace.go:171","msg":"trace[894847238] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:675; }","duration":"497.14222ms","start":"2026-10-21T01:17:18.279491Z","end":"2026-10-21T01:17:18.776633Z","steps":["trace[894847238] 'read index received' (duration: 121.509124ms)","trace[894847238] 'applied index is now lower than readState.Index' (duration: 375.631896ms)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:17:18.776671Z","caller":"traceutil/trace.go:171","msg":"trace[1735174292] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"513.184638ms","start":"2026-10-21T01:17:18.263457Z","end":"2026-10-21T01:17:18.776642Z","steps":["trace[1735174292] 'process raft request' (duration: 218.574114ms)","trace[1735174292] 'compare' (duration: 293.890716ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T01:17:18.776949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.439488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-10-21T01:17:18.776948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T01:17:18.263441Z","time spent":"513.342581ms","remote":"127.0.0.1:38204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-21T01:17:18.777021Z","caller":"traceutil/trace.go:171","msg":"trace[625936131] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:654; }","duration":"497.536391ms","start":"2026-10-21T01:17:18.279468Z","end":"2026-10-21T01:17:18.777004Z","steps":["trace[625936131] 'agreement among raft nodes before linearized reading' (duration: 497.251153ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:17:18.777073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T01:17:18.27946Z","time spent":"497.600512ms","remote":"127.0.0.1:38120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-21T01:17:18.77729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.51896ms","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-21T01:17:18.77737Z","caller":"traceutil/trace.go:171","msg":"trace[1286202861] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:654; }","duration":"192.612112ms","start":"2026-10-21T01:17:18.58474Z","end":"2026-10-21T01:17:18.777352Z","steps":["trace[1286202861] 'agreement among raft nodes before linearized reading' (duration: 192.057708ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:17:20.347573Z","caller":"traceutil/trace.go:171","msg":"trace[1167326299] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"106.863712ms","start":"2026-10-21T01:17:20.240677Z","end":"2026-10-21T01:17:20.347541Z","steps":["trace[1167326299] 'process raft request' (duration: 64.369091ms)","trace[1167326299] 'compare' (duration: 42.334277ms)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:17:33.889722Z","caller":"traceutil/trace.go:171","msg":"trace[694271895] transaction","detail":"{read_only:false; response_revision:823; number_of_response:1; }","duration":"117.160226ms","start":"2026-10-21T01:17:33.772537Z","end":"2026-10-21T01:17:33.889698Z","steps":["trace[694271895] 'process raft request' (duration: 117.011983ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:18:23.732911Z","caller":"traceutil/trace.go:171","msg":"trace[1569623928] transaction","detail":"{read_only:false; response_revision:1471; number_of_response:1; }","duration":"149.704827ms","start":"2026-10-21T01:18:23.583154Z","end":"2026-10-21T01:18:23.732858Z","steps":["trace[1569623928] 'process raft request' (duration: 149.458231ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:18:49.273838Z","caller":"traceutil/trace.go:171","msg":"trace[1875681115] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"228.115328ms","start":"2026-10-21T01:18:49.045692Z","end":"2026-10-21T01:18:49.273808Z","steps":["trace[1875681115] 'process raft request' (duration: 227.876872ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:18:49.716782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.203861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4d5df700-d03e-488d-bd06-7fae93d19ca5\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-21T01:18:49.716861Z","caller":"traceutil/trace.go:171","msg":"trace[808772572] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4d5df700-d03e-488d-bd06-7fae93d19ca5; range_end:; response_count:1; response_revision:1886; }","duration":"131.316354ms","start":"2026-10-21T01:18:49.585524Z","end":"2026-10-21T01:18:49.716841Z","steps":["trace[808772572] 'range keys from in-memory index tree' (duration: 130.987936ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:18:56.874417Z","caller":"traceutil/trace.go:171","msg":"trace[1536722578] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"109.990879ms","start":"2026-10-21T01:18:56.764389Z","end":"2026-10-21T01:18:56.87438Z","steps":["trace[1536722578] 'process raft request' (duration: 41.789289ms)","trace[1536722578] 'compare' (duration: 68.021286ms)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:19:03.473995Z","caller":"traceutil/trace.go:171","msg":"trace[1267972397] transaction","detail":"{read_only:false; response_revision:2012; number_of_response:1; }","duration":"143.950105ms","start":"2026-10-21T01:19:03.330016Z","end":"2026-10-21T01:19:03.473966Z","steps":["trace[1267972397] 'process raft request' (duration: 87.848733ms)","trace[1267972397] 'compare' (duration: 55.929748ms)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:19:04.272142Z","caller":"traceutil/trace.go:171","msg":"trace[978226578] linearizableReadLoop","detail":"{readStateIndex:2089; appliedIndex:2088; }","duration":"338.434655ms","start":"2026-10-21T01:19:03.933676Z","end":"2026-10-21T01:19:04.272111Z","steps":["trace[978226578] 'read index received' (duration: 338.24868ms)","trace[978226578] 'applied index is now lower than readState.Index' (duration: 184.695µs)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:19:04.272198Z","caller":"traceutil/trace.go:171","msg":"trace[784250468] transaction","detail":"{read_only:false; response_revision:2016; number_of_response:1; }","duration":"388.017917ms","start":"2026-10-21T01:19:03.884141Z","end":"2026-10-21T01:19:04.272159Z","steps":["trace[784250468] 'process raft request' (duration: 387.787701ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:19:04.272341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.798194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-21T01:19:04.272382Z","caller":"traceutil/trace.go:171","msg":"trace[1176966725] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:2016; }","duration":"323.879527ms","start":"2026-10-21T01:19:03.948488Z","end":"2026-10-21T01:19:04.272367Z","steps":["trace[1176966725] 'agreement among raft nodes before linearized reading' (duration: 323.790455ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:19:04.272414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T01:19:03.948473Z","time spent":"323.931338ms","remote":"127.0.0.1:38166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":4,"response size":31,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-10-21T01:19:04.272485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.779533ms","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-21T01:19:04.272565Z","caller":"traceutil/trace.go:171","msg":"trace[1471552465] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2016; }","duration":"338.902406ms","start":"2026-10-21T01:19:03.933642Z","end":"2026-10-21T01:19:04.272544Z","steps":["trace[1471552465] 'agreement among raft nodes before linearized reading' (duration: 338.6274ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:19:04.272614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T01:19:03.933631Z","time spent":"338.974398ms","remote":"127.0.0.1:38120","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-21T01:19:04.272629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T01:19:03.884108Z","time spent":"388.16995ms","remote":"127.0.0.1:38120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-21T01:19:33.092988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.597941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:19:33.093066Z","caller":"traceutil/trace.go:171","msg":"trace[1176664413] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2180; }","duration":"123.717464ms","start":"2026-10-21T01:19:32.969331Z","end":"2026-10-21T01:19:33.093048Z","steps":["trace[1176664413] 'range keys from in-memory index tree' (duration: 123.502859ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:19:33.109802Z","caller":"traceutil/trace.go:171","msg":"trace[1785816101] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"120.29904ms","start":"2026-10-21T01:19:32.989483Z","end":"2026-10-21T01:19:33.109782Z","steps":["trace[1785816101] 'process raft request' (duration: 119.811448ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:19:44.686374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.533718ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-21T01:19:44.686764Z","caller":"traceutil/trace.go:171","msg":"trace[1792627348] transaction","detail":"{read_only:false; response_revision:2243; number_of_response:1; }","duration":"209.175878ms","start":"2026-10-21T01:19:44.477558Z","end":"2026-10-21T01:19:44.686734Z","steps":["trace[1792627348] 'process raft request' (duration: 79.169208ms)","trace[1792627348] 'compare' (duration: 129.358944ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T01:19:44.91987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.223635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5700"} {"level":"info","ts":"2026-10-21T01:19:44.919972Z","caller":"traceutil/trace.go:171","msg":"trace[1167853029] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2243; }","duration":"130.367188ms","start":"2026-10-21T01:19:44.789582Z","end":"2026-10-21T01:19:44.919949Z","steps":["trace[1167853029] 'range keys from in-memory index tree' (duration: 130.03051ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:19:45.007875Z","caller":"traceutil/trace.go:171","msg":"trace[459263242] transaction","detail":"{read_only:false; response_revision:2244; number_of_response:1; }","duration":"134.07758ms","start":"2026-10-21T01:19:44.873771Z","end":"2026-10-21T01:19:45.007848Z","steps":["trace[459263242] 'process raft request' (duration: 133.830093ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:21:05.405115Z","caller":"traceutil/trace.go:171","msg":"trace[1424530983] transaction","detail":"{read_only:false; response_revision:2871; number_of_response:1; }","duration":"123.610162ms","start":"2026-10-21T01:21:05.281476Z","end":"2026-10-21T01:21:05.405087Z","steps":["trace[1424530983] 'process raft request' (duration: 123.415547ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:21:05.667679Z","caller":"traceutil/trace.go:171","msg":"trace[1633282827] transaction","detail":"{read_only:false; response_revision:2872; number_of_response:1; }","duration":"180.603408ms","start":"2026-10-21T01:21:05.487046Z","end":"2026-10-21T01:21:05.667649Z","steps":["trace[1633282827] 'process raft request' (duration: 180.297811ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:21:05.778225Z","caller":"traceutil/trace.go:171","msg":"trace[1339701735] transaction","detail":"{read_only:false; response_revision:2873; number_of_response:1; }","duration":"105.090845ms","start":"2026-10-21T01:21:05.673096Z","end":"2026-10-21T01:21:05.778187Z","steps":["trace[1339701735] 'process raft request' (duration: 81.81829ms)","trace[1339701735] 'compare' (duration: 23.099701ms)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:21:11.072312Z","caller":"traceutil/trace.go:171","msg":"trace[250782674] transaction","detail":"{read_only:false; response_revision:2904; number_of_response:1; }","duration":"127.898528ms","start":"2026-10-21T01:21:10.944386Z","end":"2026-10-21T01:21:11.072284Z","steps":["trace[250782674] 'process raft request' (duration: 127.752034ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:25:39.950804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.970584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:24 size:534158"} {"level":"info","ts":"2026-10-21T01:25:39.950886Z","caller":"traceutil/trace.go:171","msg":"trace[271372182] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:24; response_revision:5123; }","duration":"110.093158ms","start":"2026-10-21T01:25:39.840776Z","end":"2026-10-21T01:25:39.950869Z","steps":["trace[271372182] 'agreement among raft nodes before linearized reading' (duration: 109.661377ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:25:40.027251Z","caller":"traceutil/trace.go:171","msg":"trace[1600925674] transaction","detail":"{read_only:false; response_revision:5124; number_of_response:1; }","duration":"106.199636ms","start":"2026-10-21T01:25:39.92102Z","end":"2026-10-21T01:25:40.02722Z","steps":["trace[1600925674] 'process raft request' (duration: 105.991701ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:25:40.027394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.686949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-10-21T01:25:40.027502Z","caller":"traceutil/trace.go:171","msg":"trace[1068722479] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:5124; }","duration":"109.823043ms","start":"2026-10-21T01:25:39.917651Z","end":"2026-10-21T01:25:40.027474Z","steps":["trace[1068722479] 'agreement among raft nodes before linearized reading' (duration: 109.546496ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:25:43.45085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.813058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5c0e4701-d50e-4a67-a74d-ee2dbde06dce\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-21T01:25:43.450947Z","caller":"traceutil/trace.go:171","msg":"trace[1158076850] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5c0e4701-d50e-4a67-a74d-ee2dbde06dce; range_end:; response_count:1; response_revision:5248; }","duration":"206.948451ms","start":"2026-10-21T01:25:43.243979Z","end":"2026-10-21T01:25:43.450928Z","steps":["trace[1158076850] 'range keys from in-memory index tree' (duration: 206.706055ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:25:44.989187Z","caller":"traceutil/trace.go:171","msg":"trace[1954303689] transaction","detail":"{read_only:false; response_revision:5269; number_of_response:1; }","duration":"103.019429ms","start":"2026-10-21T01:25:44.886148Z","end":"2026-10-21T01:25:44.989167Z","steps":["trace[1954303689] 'process raft request' (duration: 54.65935ms)","trace[1954303689] 'compare' (duration: 48.003241ms)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:25:44.989191Z","caller":"traceutil/trace.go:171","msg":"trace[1213337094] transaction","detail":"{read_only:false; response_revision:5270; number_of_response:1; }","duration":"101.347359ms","start":"2026-10-21T01:25:44.887805Z","end":"2026-10-21T01:25:44.989152Z","steps":["trace[1213337094] 'process raft request' (duration: 101.209016ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:25:58.828633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.633823ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-21T01:25:58.82886Z","caller":"traceutil/trace.go:171","msg":"trace[893397903] linearizableReadLoop","detail":"{readStateIndex:5728; appliedIndex:5727; }","duration":"119.735051ms","start":"2026-10-21T01:25:58.709101Z","end":"2026-10-21T01:25:58.828836Z","steps":["trace[893397903] 'read index received' (duration: 8.818791ms)","trace[893397903] 'applied index is now lower than readState.Index' (duration: 110.913979ms)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:25:58.828844Z","caller":"traceutil/trace.go:171","msg":"trace[898013073] transaction","detail":"{read_only:false; response_revision:5522; number_of_response:1; }","duration":"128.250544ms","start":"2026-10-21T01:25:58.700519Z","end":"2026-10-21T01:25:58.828769Z","steps":["trace[898013073] 'process raft request' (duration: 17.404587ms)","trace[898013073] 'compare' (duration: 110.465888ms)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:25:58.828902Z","caller":"traceutil/trace.go:171","msg":"trace[1494775695] transaction","detail":"{read_only:false; response_revision:5523; number_of_response:1; }","duration":"116.421551ms","start":"2026-10-21T01:25:58.712429Z","end":"2026-10-21T01:25:58.828851Z","steps":["trace[1494775695] 'process raft request' (duration: 116.332349ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:25:58.829041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.91358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:25:58.829073Z","caller":"traceutil/trace.go:171","msg":"trace[1018419331] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5523; }","duration":"128.978742ms","start":"2026-10-21T01:25:58.700086Z","end":"2026-10-21T01:25:58.829065Z","steps":["trace[1018419331] 'agreement among raft nodes before linearized reading' (duration: 128.87756ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:25:59.469879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.927453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-21T01:25:59.469957Z","caller":"traceutil/trace.go:171","msg":"trace[1091016934] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5531; }","duration":"200.051055ms","start":"2026-10-21T01:25:59.269889Z","end":"2026-10-21T01:25:59.46994Z","steps":["trace[1091016934] 'range keys from in-memory index tree' (duration: 199.784539ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:26:08.650219Z","caller":"traceutil/trace.go:171","msg":"trace[589938251] transaction","detail":"{read_only:false; response_revision:5715; number_of_response:1; }","duration":"139.616246ms","start":"2026-10-21T01:26:08.510576Z","end":"2026-10-21T01:26:08.650192Z","steps":["trace[589938251] 'process raft request' (duration: 138.356856ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:26:08.857135Z","caller":"traceutil/trace.go:171","msg":"trace[80086560] transaction","detail":"{read_only:false; response_revision:5716; number_of_response:1; }","duration":"102.381134ms","start":"2026-10-21T01:26:08.754723Z","end":"2026-10-21T01:26:08.857104Z","steps":["trace[80086560] 'process raft request' (duration: 48.937853ms)","trace[80086560] 'compare' (duration: 53.328078ms)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:26:09.084491Z","caller":"traceutil/trace.go:171","msg":"trace[666306964] transaction","detail":"{read_only:false; response_revision:5718; number_of_response:1; }","duration":"147.086716ms","start":"2026-10-21T01:26:08.937352Z","end":"2026-10-21T01:26:09.084439Z","steps":["trace[666306964] 'process raft request' (duration: 146.900772ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:26:21.237207Z","caller":"traceutil/trace.go:171","msg":"trace[887398003] transaction","detail":"{read_only:false; response_revision:5858; number_of_response:1; }","duration":"121.032611ms","start":"2026-10-21T01:26:21.116141Z","end":"2026-10-21T01:26:21.237174Z","steps":["trace[887398003] 'process raft request' (duration: 120.656852ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:26:21.237333Z","caller":"traceutil/trace.go:171","msg":"trace[723631930] transaction","detail":"{read_only:false; response_revision:5857; number_of_response:1; }","duration":"122.689281ms","start":"2026-10-21T01:26:21.114632Z","end":"2026-10-21T01:26:21.237321Z","steps":["trace[723631930] 'process raft request' (duration: 81.941534ms)","trace[723631930] 'compare' (duration: 40.06601ms)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:26:21.237253Z","caller":"traceutil/trace.go:171","msg":"trace[663471674] transaction","detail":"{read_only:false; response_revision:5859; number_of_response:1; }","duration":"120.857776ms","start":"2026-10-21T01:26:21.116329Z","end":"2026-10-21T01:26:21.237187Z","steps":["trace[663471674] 'process raft request' (duration: 120.59692ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:26:27.091003Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2991} {"level":"info","ts":"2026-10-21T01:26:27.172389Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2991,"took":"79.957346ms","hash":1283029986,"current-db-size-bytes":57487360,"current-db-size":"58 MB","current-db-size-in-use-bytes":32583680,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-21T01:26:27.172453Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1283029986,"revision":2991,"compact-revision":-1} {"level":"info","ts":"2026-10-21T01:31:27.105294Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5917} {"level":"info","ts":"2026-10-21T01:31:27.208311Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5917,"took":"100.924665ms","hash":3016405957,"current-db-size-bytes":57487360,"current-db-size":"58 MB","current-db-size-in-use-bytes":26529792,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-21T01:31:27.208379Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3016405957,"revision":5917,"compact-revision":2991} {"level":"warn","ts":"2026-10-21T01:32:43.124653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.317008ms","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-21T01:32:43.124786Z","caller":"traceutil/trace.go:171","msg":"trace[2144486459] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8687; }","duration":"133.540734ms","start":"2026-10-21T01:32:42.991219Z","end":"2026-10-21T01:32:43.12476Z","steps":["trace[2144486459] 'range keys from in-memory index tree' (duration: 133.048982ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:32:43.758153Z","caller":"traceutil/trace.go:171","msg":"trace[914308616] transaction","detail":"{read_only:false; response_revision:8689; number_of_response:1; }","duration":"284.674216ms","start":"2026-10-21T01:32:43.473451Z","end":"2026-10-21T01:32:43.758125Z","steps":["trace[914308616] 'process raft request' (duration: 284.480761ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:32:43.75816Z","caller":"traceutil/trace.go:171","msg":"trace[1496787072] linearizableReadLoop","detail":"{readStateIndex:8998; appliedIndex:8998; }","duration":"248.73552ms","start":"2026-10-21T01:32:43.509398Z","end":"2026-10-21T01:32:43.758134Z","steps":["trace[1496787072] 'read index received' (duration: 248.72091ms)","trace[1496787072] 'applied index is now lower than readState.Index' (duration: 12.15µs)"],"step_count":2} {"level":"warn","ts":"2026-10-21T01:32:43.758306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.893603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:32:43.758358Z","caller":"traceutil/trace.go:171","msg":"trace[866007941] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:8689; }","duration":"249.019347ms","start":"2026-10-21T01:32:43.509317Z","end":"2026-10-21T01:32:43.758336Z","steps":["trace[866007941] 'agreement among raft nodes before linearized reading' (duration: 248.889324ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:32:43.957761Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002329.wal"} {"level":"info","ts":"2026-10-21T01:32:43.95849Z","caller":"traceutil/trace.go:171","msg":"trace[1558541909] transaction","detail":"{read_only:false; response_revision:8690; number_of_response:1; }","duration":"355.669528ms","start":"2026-10-21T01:32:43.602749Z","end":"2026-10-21T01:32:43.958418Z","steps":["trace[1558541909] 'process raft request' (duration: 355.34062ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:32:43.958702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T01:32:43.602717Z","time spent":"355.835982ms","remote":"127.0.0.1:38120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-21T01:32:43.958987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.699292ms","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-21T01:32:43.95906Z","caller":"traceutil/trace.go:171","msg":"trace[814207886] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8691; }","duration":"215.820384ms","start":"2026-10-21T01:32:43.743224Z","end":"2026-10-21T01:32:43.959044Z","steps":["trace[814207886] 'agreement among raft nodes before linearized reading' (duration: 215.627189ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:32:43.959362Z","caller":"traceutil/trace.go:171","msg":"trace[320013775] transaction","detail":"{read_only:false; response_revision:8691; number_of_response:1; }","duration":"267.736653ms","start":"2026-10-21T01:32:43.691584Z","end":"2026-10-21T01:32:43.959321Z","steps":["trace[320013775] 'process raft request' (duration: 266.700988ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:32:43.959602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.782202ms","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-21T01:32:43.959681Z","caller":"traceutil/trace.go:171","msg":"trace[225393247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8691; }","duration":"220.927417ms","start":"2026-10-21T01:32:43.738732Z","end":"2026-10-21T01:32:43.95966Z","steps":["trace[225393247] 'agreement among raft nodes before linearized reading' (duration: 220.558978ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:32:43.959794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.300836ms","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-21T01:32:43.95996Z","caller":"traceutil/trace.go:171","msg":"trace[503189026] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8691; }","duration":"315.552462ms","start":"2026-10-21T01:32:43.644376Z","end":"2026-10-21T01:32:43.959929Z","steps":["trace[503189026] 'agreement among raft nodes before linearized reading' (duration: 315.008589ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:32:43.960043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T01:32:43.644351Z","time spent":"315.666195ms","remote":"127.0.0.1:38120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-21T01:32:43.95988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.801009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-21T01:32:43.960219Z","caller":"traceutil/trace.go:171","msg":"trace[2106482551] linearizableReadLoop","detail":"{readStateIndex:9000; appliedIndex:8998; }","duration":"201.899313ms","start":"2026-10-21T01:32:43.758299Z","end":"2026-10-21T01:32:43.960198Z","steps":["trace[2106482551] 'read index received' (duration: 199.730261ms)","trace[2106482551] 'applied index is now lower than readState.Index' (duration: 544.643µs)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:32:43.960248Z","caller":"traceutil/trace.go:171","msg":"trace[1887800992] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8691; }","duration":"345.230499ms","start":"2026-10-21T01:32:43.614998Z","end":"2026-10-21T01:32:43.960229Z","steps":["trace[1887800992] 'agreement among raft nodes before linearized reading' (duration: 344.761478ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:32:43.960332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T01:32:43.614969Z","time spent":"345.345072ms","remote":"127.0.0.1:38120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-21T01:32:43.960367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.339227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-21T01:32:43.960407Z","caller":"traceutil/trace.go:171","msg":"trace[339262429] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:8691; }","duration":"130.423529ms","start":"2026-10-21T01:32:43.829973Z","end":"2026-10-21T01:32:43.960396Z","steps":["trace[339262429] 'agreement among raft nodes before linearized reading' (duration: 130.351338ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:32:44.577298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.008412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-cq7jx\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-10-21T01:32:44.577375Z","caller":"traceutil/trace.go:171","msg":"trace[1087404783] range","detail":"{range_begin:/registry/pods/openstack/keepalived-cq7jx; range_end:; response_count:1; response_revision:8698; }","duration":"102.145975ms","start":"2026-10-21T01:32:44.475211Z","end":"2026-10-21T01:32:44.577357Z","steps":["trace[1087404783] 'range keys from in-memory index tree' (duration: 101.817897ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:33:10.535232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.064106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/rook-ceph/csi-rbdplugin-metrics\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:33:10.535336Z","caller":"traceutil/trace.go:171","msg":"trace[1225604249] range","detail":"{range_begin:/registry/services/specs/rook-ceph/csi-rbdplugin-metrics; range_end:; response_count:0; response_revision:8886; }","duration":"116.236351ms","start":"2026-10-21T01:33:10.419077Z","end":"2026-10-21T01:33:10.535314Z","steps":["trace[1225604249] 'range keys from in-memory index tree' (duration: 115.968704ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:33:10.535398Z","caller":"traceutil/trace.go:171","msg":"trace[1516759027] transaction","detail":"{read_only:false; response_revision:8887; number_of_response:1; }","duration":"104.839009ms","start":"2026-10-21T01:33:10.430509Z","end":"2026-10-21T01:33:10.535348Z","steps":["trace[1516759027] 'process raft request' (duration: 27.797612ms)","trace[1516759027] 'compare' (duration: 76.878053ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T01:33:10.535998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.431979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.206\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-21T01:33:10.536233Z","caller":"traceutil/trace.go:171","msg":"trace[2044934510] range","detail":"{range_begin:/registry/masterleases/162.253.55.206; range_end:; response_count:1; response_revision:8886; }","duration":"109.852259ms","start":"2026-10-21T01:33:10.426365Z","end":"2026-10-21T01:33:10.536217Z","steps":["trace[2044934510] 'range keys from in-memory index tree' (duration: 108.494486ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:33:14.432108Z","caller":"traceutil/trace.go:171","msg":"trace[706458740] linearizableReadLoop","detail":"{readStateIndex:9224; appliedIndex:9223; }","duration":"294.029409ms","start":"2026-10-21T01:33:14.138051Z","end":"2026-10-21T01:33:14.43208Z","steps":["trace[706458740] 'read index received' (duration: 293.974357ms)","trace[706458740] 'applied index is now lower than readState.Index' (duration: 53.572µs)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:33:14.432249Z","caller":"traceutil/trace.go:171","msg":"trace[848799355] transaction","detail":"{read_only:false; response_revision:8907; number_of_response:1; }","duration":"297.597714ms","start":"2026-10-21T01:33:14.134585Z","end":"2026-10-21T01:33:14.432183Z","steps":["trace[848799355] 'process raft request' (duration: 297.347588ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:33:14.433261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.163456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-21T01:33:14.433348Z","caller":"traceutil/trace.go:171","msg":"trace[1296884181] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8907; }","duration":"295.317589ms","start":"2026-10-21T01:33:14.13801Z","end":"2026-10-21T01:33:14.433328Z","steps":["trace[1296884181] 'agreement among raft nodes before linearized reading' (duration: 294.195433ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:33:14.516193Z","caller":"traceutil/trace.go:171","msg":"trace[1670494862] transaction","detail":"{read_only:false; response_revision:8908; number_of_response:1; }","duration":"173.859014ms","start":"2026-10-21T01:33:14.342308Z","end":"2026-10-21T01:33:14.516167Z","steps":["trace[1670494862] 'process raft request' (duration: 161.562531ms)","trace[1670494862] 'compare' (duration: 11.821662ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T01:33:14.516453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.695329ms","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-21T01:33:14.516493Z","caller":"traceutil/trace.go:171","msg":"trace[576314076] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8909; }","duration":"350.802272ms","start":"2026-10-21T01:33:14.16568Z","end":"2026-10-21T01:33:14.516482Z","steps":["trace[576314076] 'agreement among raft nodes before linearized reading' (duration: 350.667198ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:33:14.51652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T01:33:14.165656Z","time spent":"350.856533ms","remote":"127.0.0.1:38120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-21T01:33:14.51674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.3236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:33:14.516777Z","caller":"traceutil/trace.go:171","msg":"trace[170046965] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:8909; }","duration":"100.386492ms","start":"2026-10-21T01:33:14.416378Z","end":"2026-10-21T01:33:14.516765Z","steps":["trace[170046965] 'agreement among raft nodes before linearized reading' (duration: 100.330031ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:33:14.517068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.460872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-6d6bd9ccc-6hq8j.18e0676722d451f8\" ","response":"range_response_count:1 size:1132"} {"level":"info","ts":"2026-10-21T01:33:14.517109Z","caller":"traceutil/trace.go:171","msg":"trace[2134380678] range","detail":"{range_begin:/registry/events/openstack/barbican-api-6d6bd9ccc-6hq8j.18e0676722d451f8; range_end:; response_count:1; response_revision:8909; }","duration":"157.539404ms","start":"2026-10-21T01:33:14.359558Z","end":"2026-10-21T01:33:14.517098Z","steps":["trace[2134380678] 'agreement among raft nodes before linearized reading' (duration: 157.432852ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:33:14.517297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.882372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-21T01:33:14.517331Z","caller":"traceutil/trace.go:171","msg":"trace[1303060847] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8909; }","duration":"347.975685ms","start":"2026-10-21T01:33:14.169347Z","end":"2026-10-21T01:33:14.517323Z","steps":["trace[1303060847] 'agreement among raft nodes before linearized reading' (duration: 347.888582ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:33:14.517355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T01:33:14.169335Z","time spent":"348.012955ms","remote":"127.0.0.1:38120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-21T01:33:25.048226Z","caller":"traceutil/trace.go:171","msg":"trace[209088746] linearizableReadLoop","detail":"{readStateIndex:9287; appliedIndex:9286; }","duration":"107.896422ms","start":"2026-10-21T01:33:24.9403Z","end":"2026-10-21T01:33:25.048196Z","steps":["trace[209088746] 'read index received' (duration: 107.644966ms)","trace[209088746] 'applied index is now lower than readState.Index' (duration: 249.626µs)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:33:25.048256Z","caller":"traceutil/trace.go:171","msg":"trace[439288121] transaction","detail":"{read_only:false; response_revision:8967; number_of_response:1; }","duration":"130.744327ms","start":"2026-10-21T01:33:24.917486Z","end":"2026-10-21T01:33:25.048231Z","steps":["trace[439288121] 'process raft request' (duration: 130.544542ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:33:25.048456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.132887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12429"} {"level":"warn","ts":"2026-10-21T01:33:25.048495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.848708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-cq7jx\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-10-21T01:33:25.048531Z","caller":"traceutil/trace.go:171","msg":"trace[409176147] range","detail":"{range_begin:/registry/pods/openstack/keepalived-cq7jx; range_end:; response_count:1; response_revision:8967; }","duration":"101.92779ms","start":"2026-10-21T01:33:24.946593Z","end":"2026-10-21T01:33:25.048521Z","steps":["trace[409176147] 'agreement among raft nodes before linearized reading' (duration: 101.774316ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:33:25.048544Z","caller":"traceutil/trace.go:171","msg":"trace[2086037648] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8967; }","duration":"108.242461ms","start":"2026-10-21T01:33:24.940271Z","end":"2026-10-21T01:33:25.048514Z","steps":["trace[2086037648] 'agreement among raft nodes before linearized reading' (duration: 108.072217ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:33:27.342665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.606163ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-21T01:33:27.342892Z","caller":"traceutil/trace.go:171","msg":"trace[1161569100] transaction","detail":"{read_only:false; response_revision:8987; number_of_response:1; }","duration":"112.883041ms","start":"2026-10-21T01:33:27.229992Z","end":"2026-10-21T01:33:27.342875Z","steps":["trace[1161569100] 'process raft request' (duration: 112.789209ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:33:27.343118Z","caller":"traceutil/trace.go:171","msg":"trace[1593814162] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8986; }","duration":"113.550378ms","start":"2026-10-21T01:33:27.229558Z","end":"2026-10-21T01:33:27.343109Z","steps":["trace[1593814162] 'compare' (duration: 109.429339ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:34:30.192369Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cfc9fec265e3384a","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-21T01:34:30.198462Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-21T01:34:30.198618Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-21T01:34:56.786003Z","caller":"traceutil/trace.go:171","msg":"trace[485974455] linearizableReadLoop","detail":"{readStateIndex:10184; appliedIndex:10183; }","duration":"116.898788ms","start":"2026-10-21T01:34:56.669077Z","end":"2026-10-21T01:34:56.785976Z","steps":["trace[485974455] 'read index received' (duration: 23.294646ms)","trace[485974455] 'applied index is now lower than readState.Index' (duration: 93.602811ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T01:34:56.786143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.043831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:34:56.786179Z","caller":"traceutil/trace.go:171","msg":"trace[1244576685] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9837; }","duration":"117.131792ms","start":"2026-10-21T01:34:56.669038Z","end":"2026-10-21T01:34:56.78617Z","steps":["trace[1244576685] 'agreement among raft nodes before linearized reading' (duration: 117.03216ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:34:56.78645Z","caller":"traceutil/trace.go:171","msg":"trace[558284828] transaction","detail":"{read_only:false; response_revision:9837; number_of_response:1; }","duration":"195.516172ms","start":"2026-10-21T01:34:56.590921Z","end":"2026-10-21T01:34:56.786437Z","steps":["trace[558284828] 'process raft request' (duration: 101.50981ms)","trace[558284828] 'compare' (duration: 93.256684ms)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:36:27.112654Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8084} {"level":"info","ts":"2026-10-21T01:36:27.189559Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8084,"took":"74.596581ms","hash":4056779569,"current-db-size-bytes":57487360,"current-db-size":"58 MB","current-db-size-in-use-bytes":28119040,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-21T01:36:27.189653Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4056779569,"revision":8084,"compact-revision":5917} {"level":"info","ts":"2026-10-21T01:40:32.415056Z","caller":"traceutil/trace.go:171","msg":"trace[585805703] linearizableReadLoop","detail":"{readStateIndex:12680; appliedIndex:12678; }","duration":"233.961049ms","start":"2026-10-21T01:40:32.181064Z","end":"2026-10-21T01:40:32.415025Z","steps":["trace[585805703] 'read index received' (duration: 233.680273ms)","trace[585805703] 'applied index is now lower than readState.Index' (duration: 279.176µs)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:40:32.41511Z","caller":"traceutil/trace.go:171","msg":"trace[1164983587] transaction","detail":"{read_only:false; response_revision:12255; number_of_response:1; }","duration":"236.577542ms","start":"2026-10-21T01:40:32.1785Z","end":"2026-10-21T01:40:32.415077Z","steps":["trace[1164983587] 'process raft request' (duration: 236.245514ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:40:32.415152Z","caller":"traceutil/trace.go:171","msg":"trace[1882319001] transaction","detail":"{read_only:false; response_revision:12256; number_of_response:1; }","duration":"236.623273ms","start":"2026-10-21T01:40:32.1785Z","end":"2026-10-21T01:40:32.415123Z","steps":["trace[1882319001] 'process raft request' (duration: 236.451689ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:40:32.415517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.432991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-cq7jx\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-10-21T01:40:32.415592Z","caller":"traceutil/trace.go:171","msg":"trace[1590603877] range","detail":"{range_begin:/registry/pods/openstack/keepalived-cq7jx; range_end:; response_count:1; response_revision:12256; }","duration":"234.549964ms","start":"2026-10-21T01:40:32.18102Z","end":"2026-10-21T01:40:32.41557Z","steps":["trace[1590603877] 'agreement among raft nodes before linearized reading' (duration: 234.129324ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:40:32.769491Z","caller":"traceutil/trace.go:171","msg":"trace[997574521] transaction","detail":"{read_only:false; response_revision:12257; number_of_response:1; }","duration":"105.40714ms","start":"2026-10-21T01:40:32.664036Z","end":"2026-10-21T01:40:32.769443Z","steps":["trace[997574521] 'process raft request' (duration: 105.146544ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:41:27.119199Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10447} {"level":"info","ts":"2026-10-21T01:41:27.206425Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10447,"took":"84.286356ms","hash":3132999778,"current-db-size-bytes":57487360,"current-db-size":"58 MB","current-db-size-in-use-bytes":26349568,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-21T01:41:27.206507Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3132999778,"revision":10447,"compact-revision":8084} {"level":"info","ts":"2026-10-21T01:46:27.126118Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12631} {"level":"info","ts":"2026-10-21T01:46:27.207954Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12631,"took":"79.338567ms","hash":3318253398,"current-db-size-bytes":57487360,"current-db-size":"58 MB","current-db-size-in-use-bytes":27779072,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-21T01:46:27.208032Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3318253398,"revision":12631,"compact-revision":10447} {"level":"info","ts":"2026-10-21T01:47:07.847542Z","caller":"traceutil/trace.go:171","msg":"trace[2070988093] linearizableReadLoop","detail":"{readStateIndex:15406; appliedIndex:15405; }","duration":"117.562696ms","start":"2026-10-21T01:47:07.729955Z","end":"2026-10-21T01:47:07.847517Z","steps":["trace[2070988093] 'read index received' (duration: 117.370191ms)","trace[2070988093] 'applied index is now lower than readState.Index' (duration: 191.705µs)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:47:07.847599Z","caller":"traceutil/trace.go:171","msg":"trace[1085774290] transaction","detail":"{read_only:false; response_revision:14887; number_of_response:1; }","duration":"124.723016ms","start":"2026-10-21T01:47:07.722852Z","end":"2026-10-21T01:47:07.847575Z","steps":["trace[1085774290] 'process raft request' (duration: 124.517911ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:47:07.847741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.7774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-cq7jx\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-10-21T01:47:07.847777Z","caller":"traceutil/trace.go:171","msg":"trace[496576079] range","detail":"{range_begin:/registry/pods/openstack/keepalived-cq7jx; range_end:; response_count:1; response_revision:14887; }","duration":"117.852322ms","start":"2026-10-21T01:47:07.729914Z","end":"2026-10-21T01:47:07.847766Z","steps":["trace[496576079] 'agreement among raft nodes before linearized reading' (duration: 117.708439ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:47:25.199729Z","caller":"traceutil/trace.go:171","msg":"trace[1464724534] transaction","detail":"{read_only:false; response_revision:14990; number_of_response:1; }","duration":"132.801698ms","start":"2026-10-21T01:47:25.066899Z","end":"2026-10-21T01:47:25.199701Z","steps":["trace[1464724534] 'process raft request' (duration: 132.628644ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:47:50.233498Z","caller":"traceutil/trace.go:171","msg":"trace[499232407] transaction","detail":"{read_only:false; response_revision:15319; number_of_response:1; }","duration":"100.405967ms","start":"2026-10-21T01:47:50.133066Z","end":"2026-10-21T01:47:50.233472Z","steps":["trace[499232407] 'process raft request' (duration: 100.241283ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:47:50.286505Z","caller":"traceutil/trace.go:171","msg":"trace[1834490052] linearizableReadLoop","detail":"{readStateIndex:15858; appliedIndex:15856; }","duration":"105.318975ms","start":"2026-10-21T01:47:50.181164Z","end":"2026-10-21T01:47:50.286483Z","steps":["trace[1834490052] 'read index received' (duration: 52.239482ms)","trace[1834490052] 'applied index is now lower than readState.Index' (duration: 53.078812ms)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:47:50.286638Z","caller":"traceutil/trace.go:171","msg":"trace[613839595] transaction","detail":"{read_only:false; response_revision:15320; number_of_response:1; }","duration":"147.157429ms","start":"2026-10-21T01:47:50.13945Z","end":"2026-10-21T01:47:50.286607Z","steps":["trace[613839595] 'process raft request' (duration: 127.348449ms)","trace[613839595] 'compare' (duration: 19.596045ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T01:47:50.286764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.595731ms","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-21T01:47:50.286795Z","caller":"traceutil/trace.go:171","msg":"trace[589456303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15320; }","duration":"105.670143ms","start":"2026-10-21T01:47:50.181118Z","end":"2026-10-21T01:47:50.286788Z","steps":["trace[589456303] 'agreement among raft nodes before linearized reading' (duration: 105.484038ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:49:16.74104Z","caller":"traceutil/trace.go:171","msg":"trace[940895157] linearizableReadLoop","detail":"{readStateIndex:16689; appliedIndex:16688; }","duration":"108.173363ms","start":"2026-10-21T01:49:16.632843Z","end":"2026-10-21T01:49:16.741017Z","steps":["trace[940895157] 'read index received' (duration: 108.073691ms)","trace[940895157] 'applied index is now lower than readState.Index' (duration: 98.652µs)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:49:16.741099Z","caller":"traceutil/trace.go:171","msg":"trace[1774211104] transaction","detail":"{read_only:false; response_revision:16127; number_of_response:1; }","duration":"111.964633ms","start":"2026-10-21T01:49:16.629113Z","end":"2026-10-21T01:49:16.741078Z","steps":["trace[1774211104] 'process raft request' (duration: 111.741248ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:16.741403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.536211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-10-21T01:49:16.742711Z","caller":"traceutil/trace.go:171","msg":"trace[125647622] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16127; }","duration":"109.850063ms","start":"2026-10-21T01:49:16.632836Z","end":"2026-10-21T01:49:16.742687Z","steps":["trace[125647622] 'agreement among raft nodes before linearized reading' (duration: 108.372678ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:16.801739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.641152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:49:16.801866Z","caller":"traceutil/trace.go:171","msg":"trace[313449514] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16128; }","duration":"168.799605ms","start":"2026-10-21T01:49:16.633049Z","end":"2026-10-21T01:49:16.801849Z","steps":["trace[313449514] 'agreement among raft nodes before linearized reading' (duration: 168.620231ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:49:16.802324Z","caller":"traceutil/trace.go:171","msg":"trace[1944606987] transaction","detail":"{read_only:false; response_revision:16128; number_of_response:1; }","duration":"150.345507ms","start":"2026-10-21T01:49:16.651959Z","end":"2026-10-21T01:49:16.802304Z","steps":["trace[1944606987] 'process raft request' (duration: 149.332533ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:16.802757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.093062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:49:16.802815Z","caller":"traceutil/trace.go:171","msg":"trace[1188194133] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16128; }","duration":"169.174685ms","start":"2026-10-21T01:49:16.633627Z","end":"2026-10-21T01:49:16.802802Z","steps":["trace[1188194133] 'agreement among raft nodes before linearized reading' (duration: 169.093313ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:16.802868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.264998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-10-21T01:49:16.802923Z","caller":"traceutil/trace.go:171","msg":"trace[2087575989] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16128; }","duration":"130.33206ms","start":"2026-10-21T01:49:16.672574Z","end":"2026-10-21T01:49:16.802906Z","steps":["trace[2087575989] 'agreement among raft nodes before linearized reading' (duration: 130.216367ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:16.802998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.81992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:49:16.803035Z","caller":"traceutil/trace.go:171","msg":"trace[314478090] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16128; }","duration":"169.873771ms","start":"2026-10-21T01:49:16.633151Z","end":"2026-10-21T01:49:16.803025Z","steps":["trace[314478090] 'agreement among raft nodes before linearized reading' (duration: 169.82512ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:16.802757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.583481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-10-21T01:49:16.80311Z","caller":"traceutil/trace.go:171","msg":"trace[179007025] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16128; }","duration":"134.965891ms","start":"2026-10-21T01:49:16.668136Z","end":"2026-10-21T01:49:16.803102Z","steps":["trace[179007025] 'agreement among raft nodes before linearized reading' (duration: 134.492489ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:16.803161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.310305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:49:16.803204Z","caller":"traceutil/trace.go:171","msg":"trace[458355557] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:16128; }","duration":"134.377127ms","start":"2026-10-21T01:49:16.668815Z","end":"2026-10-21T01:49:16.803192Z","steps":["trace[458355557] 'agreement among raft nodes before linearized reading' (duration: 134.311335ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:16.803265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.051113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:49:16.803315Z","caller":"traceutil/trace.go:171","msg":"trace[1063760168] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16128; }","duration":"135.141025ms","start":"2026-10-21T01:49:16.66816Z","end":"2026-10-21T01:49:16.803301Z","steps":["trace[1063760168] 'agreement among raft nodes before linearized reading' (duration: 135.050222ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:49:22.01659Z","caller":"traceutil/trace.go:171","msg":"trace[1409323042] linearizableReadLoop","detail":"{readStateIndex:16717; appliedIndex:16716; }","duration":"113.236224ms","start":"2026-10-21T01:49:21.903327Z","end":"2026-10-21T01:49:22.016563Z","steps":["trace[1409323042] 'read index received' (duration: 113.023619ms)","trace[1409323042] 'applied index is now lower than readState.Index' (duration: 211.615µs)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:49:22.017095Z","caller":"traceutil/trace.go:171","msg":"trace[1942545859] transaction","detail":"{read_only:false; response_revision:16154; number_of_response:1; }","duration":"124.01226ms","start":"2026-10-21T01:49:21.893068Z","end":"2026-10-21T01:49:22.01708Z","steps":["trace[1942545859] 'process raft request' (duration: 123.357275ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:22.017444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.099354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:49:22.017491Z","caller":"traceutil/trace.go:171","msg":"trace[2007301902] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:16154; }","duration":"114.196207ms","start":"2026-10-21T01:49:21.903282Z","end":"2026-10-21T01:49:22.017478Z","steps":["trace[2007301902] 'agreement among raft nodes before linearized reading' (duration: 114.109175ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:22.0178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.407731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-10-21T01:49:22.017857Z","caller":"traceutil/trace.go:171","msg":"trace[1683882364] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16154; }","duration":"114.478043ms","start":"2026-10-21T01:49:21.903365Z","end":"2026-10-21T01:49:22.017843Z","steps":["trace[1683882364] 'agreement among raft nodes before linearized reading' (duration: 114.33476ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:22.018135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.507176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:49:22.018186Z","caller":"traceutil/trace.go:171","msg":"trace[59885567] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16154; }","duration":"112.610429ms","start":"2026-10-21T01:49:21.905561Z","end":"2026-10-21T01:49:22.018171Z","steps":["trace[59885567] 'agreement among raft nodes before linearized reading' (duration: 112.540157ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:22.018884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.422968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-10-21T01:49:22.018929Z","caller":"traceutil/trace.go:171","msg":"trace[1876072696] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16154; }","duration":"113.49841ms","start":"2026-10-21T01:49:21.905418Z","end":"2026-10-21T01:49:22.018916Z","steps":["trace[1876072696] 'agreement among raft nodes before linearized reading' (duration: 113.379827ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:22.019017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.564291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:681"} {"level":"info","ts":"2026-10-21T01:49:22.019078Z","caller":"traceutil/trace.go:171","msg":"trace[1733603335] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:16154; }","duration":"113.664874ms","start":"2026-10-21T01:49:21.905403Z","end":"2026-10-21T01:49:22.019068Z","steps":["trace[1733603335] 'agreement among raft nodes before linearized reading' (duration: 113.53788ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:49:22.923509Z","caller":"traceutil/trace.go:171","msg":"trace[1767975702] transaction","detail":"{read_only:false; response_revision:16156; number_of_response:1; }","duration":"163.702175ms","start":"2026-10-21T01:49:22.75979Z","end":"2026-10-21T01:49:22.923493Z","steps":["trace[1767975702] 'process raft request' (duration: 163.444299ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:22.923739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.260526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:49:22.923443Z","caller":"traceutil/trace.go:171","msg":"trace[1551381671] linearizableReadLoop","detail":"{readStateIndex:16719; appliedIndex:16718; }","duration":"107.966239ms","start":"2026-10-21T01:49:22.815454Z","end":"2026-10-21T01:49:22.92342Z","steps":["trace[1551381671] 'read index received' (duration: 107.756654ms)","trace[1551381671] 'applied index is now lower than readState.Index' (duration: 208.715µs)"],"step_count":2} {"level":"info","ts":"2026-10-21T01:49:22.923853Z","caller":"traceutil/trace.go:171","msg":"trace[2053536807] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16156; }","duration":"108.405919ms","start":"2026-10-21T01:49:22.815419Z","end":"2026-10-21T01:49:22.923825Z","steps":["trace[2053536807] 'agreement among raft nodes before linearized reading' (duration: 108.227954ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:49:22.965392Z","caller":"traceutil/trace.go:171","msg":"trace[1069779028] transaction","detail":"{read_only:false; response_revision:16157; number_of_response:1; }","duration":"145.142863ms","start":"2026-10-21T01:49:22.82022Z","end":"2026-10-21T01:49:22.965363Z","steps":["trace[1069779028] 'process raft request' (duration: 144.867016ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:22.96545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.964999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-21T01:49:22.965475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.306807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:49:22.965508Z","caller":"traceutil/trace.go:171","msg":"trace[1298888810] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16158; }","duration":"124.046301ms","start":"2026-10-21T01:49:22.841443Z","end":"2026-10-21T01:49:22.965489Z","steps":["trace[1298888810] 'agreement among raft nodes before linearized reading' (duration: 123.945828ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:49:22.965529Z","caller":"traceutil/trace.go:171","msg":"trace[1801453206] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16158; }","duration":"145.380328ms","start":"2026-10-21T01:49:22.820134Z","end":"2026-10-21T01:49:22.965514Z","steps":["trace[1801453206] 'agreement among raft nodes before linearized reading' (duration: 145.289446ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:49:22.965641Z","caller":"traceutil/trace.go:171","msg":"trace[1078981258] transaction","detail":"{read_only:false; response_revision:16158; number_of_response:1; }","duration":"126.197312ms","start":"2026-10-21T01:49:22.839428Z","end":"2026-10-21T01:49:22.965625Z","steps":["trace[1078981258] 'process raft request' (duration: 125.791042ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:22.96574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.159296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-10-21T01:49:22.965838Z","caller":"traceutil/trace.go:171","msg":"trace[1678938822] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16158; }","duration":"143.285899ms","start":"2026-10-21T01:49:22.822534Z","end":"2026-10-21T01:49:22.96582Z","steps":["trace[1678938822] 'agreement among raft nodes before linearized reading' (duration: 143.037233ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:22.965933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.944744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-10-21T01:49:22.965992Z","caller":"traceutil/trace.go:171","msg":"trace[1040192410] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16158; }","duration":"115.020636ms","start":"2026-10-21T01:49:22.850956Z","end":"2026-10-21T01:49:22.965977Z","steps":["trace[1040192410] 'agreement among raft nodes before linearized reading' (duration: 114.884883ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:22.966031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.836905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:49:22.966066Z","caller":"traceutil/trace.go:171","msg":"trace[750888259] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16158; }","duration":"149.882785ms","start":"2026-10-21T01:49:22.816173Z","end":"2026-10-21T01:49:22.966056Z","steps":["trace[750888259] 'agreement among raft nodes before linearized reading' (duration: 149.840704ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:22.96617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.610656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:49:22.966198Z","caller":"traceutil/trace.go:171","msg":"trace[283972376] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16158; }","duration":"119.638186ms","start":"2026-10-21T01:49:22.846552Z","end":"2026-10-21T01:49:22.96619Z","steps":["trace[283972376] 'agreement among raft nodes before linearized reading' (duration: 119.596835ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:22.966204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.694755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:49:22.966249Z","caller":"traceutil/trace.go:171","msg":"trace[1336496035] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16158; }","duration":"116.751977ms","start":"2026-10-21T01:49:22.849484Z","end":"2026-10-21T01:49:22.966236Z","steps":["trace[1336496035] 'agreement among raft nodes before linearized reading' (duration: 116.617894ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:22.96636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.842427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-10-21T01:49:22.96639Z","caller":"traceutil/trace.go:171","msg":"trace[620452879] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16158; }","duration":"118.884918ms","start":"2026-10-21T01:49:22.847497Z","end":"2026-10-21T01:49:22.966382Z","steps":["trace[620452879] 'agreement among raft nodes before linearized reading' (duration: 118.808686ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:22.965995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.419489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-21T01:49:22.966465Z","caller":"traceutil/trace.go:171","msg":"trace[1254890314] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16158; }","duration":"150.927261ms","start":"2026-10-21T01:49:22.815531Z","end":"2026-10-21T01:49:22.966458Z","steps":["trace[1254890314] 'agreement among raft nodes before linearized reading' (duration: 150.440819ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:22.96629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.816829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-21T01:49:22.966569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.323591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-10-21T01:49:22.966548Z","caller":"traceutil/trace.go:171","msg":"trace[1090161682] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16158; }","duration":"117.081885ms","start":"2026-10-21T01:49:22.84945Z","end":"2026-10-21T01:49:22.966531Z","steps":["trace[1090161682] 'agreement among raft nodes before linearized reading' (duration: 116.802959ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:22.966633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.167957ms","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-21T01:49:22.966659Z","caller":"traceutil/trace.go:171","msg":"trace[1262759143] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:16158; }","duration":"122.212477ms","start":"2026-10-21T01:49:22.844438Z","end":"2026-10-21T01:49:22.96665Z","steps":["trace[1262759143] 'agreement among raft nodes before linearized reading' (duration: 122.136045ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:49:22.966671Z","caller":"traceutil/trace.go:171","msg":"trace[1220892483] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16158; }","duration":"125.427814ms","start":"2026-10-21T01:49:22.8412Z","end":"2026-10-21T01:49:22.966628Z","steps":["trace[1220892483] 'agreement among raft nodes before linearized reading' (duration: 125.159807ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:49:22.965783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.506212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-10-21T01:49:22.966926Z","caller":"traceutil/trace.go:171","msg":"trace[1036113772] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16158; }","duration":"146.633928ms","start":"2026-10-21T01:49:22.820268Z","end":"2026-10-21T01:49:22.966902Z","steps":["trace[1036113772] 'agreement among raft nodes before linearized reading' (duration: 145.42654ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:51:27.135631Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14637} {"level":"info","ts":"2026-10-21T01:51:27.220842Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14637,"took":"81.54714ms","hash":3603782834,"current-db-size-bytes":57487360,"current-db-size":"58 MB","current-db-size-in-use-bytes":31027200,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-21T01:51:27.220961Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3603782834,"revision":14637,"compact-revision":12631} {"level":"info","ts":"2026-10-21T01:53:57.288186Z","caller":"traceutil/trace.go:171","msg":"trace[2055893870] transaction","detail":"{read_only:false; response_revision:18375; number_of_response:1; }","duration":"193.020824ms","start":"2026-10-21T01:53:57.095123Z","end":"2026-10-21T01:53:57.288144Z","steps":["trace[2055893870] 'process raft request' (duration: 192.762487ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:53:57.289498Z","caller":"traceutil/trace.go:171","msg":"trace[626475367] linearizableReadLoop","detail":"{readStateIndex:19008; appliedIndex:19008; }","duration":"192.506671ms","start":"2026-10-21T01:53:57.096969Z","end":"2026-10-21T01:53:57.289476Z","steps":["trace[626475367] 'read index received' (duration: 192.496991ms)","trace[626475367] 'applied index is now lower than readState.Index' (duration: 7.63µs)"],"step_count":2} {"level":"warn","ts":"2026-10-21T01:53:57.289769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.780527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-10-21T01:53:57.289803Z","caller":"traceutil/trace.go:171","msg":"trace[590178185] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18375; }","duration":"192.87391ms","start":"2026-10-21T01:53:57.09692Z","end":"2026-10-21T01:53:57.289793Z","steps":["trace[590178185] 'agreement among raft nodes before linearized reading' (duration: 192.659145ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:53:57.303967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.261108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-21T01:53:57.304063Z","caller":"traceutil/trace.go:171","msg":"trace[1159571742] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:18376; }","duration":"127.402842ms","start":"2026-10-21T01:53:57.176636Z","end":"2026-10-21T01:53:57.304039Z","steps":["trace[1159571742] 'agreement among raft nodes before linearized reading' (duration: 127.223177ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:54:04.081978Z","caller":"traceutil/trace.go:171","msg":"trace[1198010618] transaction","detail":"{read_only:false; response_revision:18415; number_of_response:1; }","duration":"136.456917ms","start":"2026-10-21T01:54:03.945499Z","end":"2026-10-21T01:54:04.081955Z","steps":["trace[1198010618] 'process raft request' (duration: 136.260142ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:54:04.790943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.829419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-21T01:54:04.791022Z","caller":"traceutil/trace.go:171","msg":"trace[945491701] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:18418; }","duration":"213.975082ms","start":"2026-10-21T01:54:04.577028Z","end":"2026-10-21T01:54:04.791003Z","steps":["trace[945491701] 'count revisions from in-memory index tree' (duration: 213.692985ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:54:04.791429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.732234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-21T01:54:04.791463Z","caller":"traceutil/trace.go:171","msg":"trace[1692369558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18418; }","duration":"123.804336ms","start":"2026-10-21T01:54:04.667647Z","end":"2026-10-21T01:54:04.791452Z","steps":["trace[1692369558] 'range keys from in-memory index tree' (duration: 123.669133ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:54:04.792049Z","caller":"traceutil/trace.go:171","msg":"trace[716955823] transaction","detail":"{read_only:false; response_revision:18419; number_of_response:1; }","duration":"115.403566ms","start":"2026-10-21T01:54:04.676631Z","end":"2026-10-21T01:54:04.792035Z","steps":["trace[716955823] 'process raft request' (duration: 115.299753ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T01:54:05.042138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.697584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-k2gjs\" ","response":"range_response_count:1 size:9789"} {"level":"info","ts":"2026-10-21T01:54:05.042223Z","caller":"traceutil/trace.go:171","msg":"trace[1050684905] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-k2gjs; range_end:; response_count:1; response_revision:18419; }","duration":"110.844388ms","start":"2026-10-21T01:54:04.931358Z","end":"2026-10-21T01:54:05.042202Z","steps":["trace[1050684905] 'range keys from in-memory index tree' (duration: 110.530931ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T01:55:32.005725Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cfc9fec265e3384a","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-21T01:55:32.011762Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-21T01:55:32.011859Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-21T01:56:27.147347Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17010} {"level":"info","ts":"2026-10-21T01:56:27.256265Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17010,"took":"105.841908ms","hash":2593928224,"current-db-size-bytes":57487360,"current-db-size":"58 MB","current-db-size-in-use-bytes":34209792,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-21T01:56:27.25657Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2593928224,"revision":17010,"compact-revision":14637} {"level":"info","ts":"2026-10-21T02:00:03.840954Z","caller":"traceutil/trace.go:171","msg":"trace[1494020886] transaction","detail":"{read_only:false; response_revision:21207; number_of_response:1; }","duration":"492.501566ms","start":"2026-10-21T02:00:03.348422Z","end":"2026-10-21T02:00:03.840923Z","steps":["trace[1494020886] 'process raft request' (duration: 492.312191ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T02:00:03.841113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T02:00:03.348407Z","time spent":"492.631418ms","remote":"127.0.0.1:38120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-21T02:00:04.333494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.916471ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-21T02:00:04.333749Z","caller":"traceutil/trace.go:171","msg":"trace[1190445241] linearizableReadLoop","detail":"{readStateIndex:21933; appliedIndex:21929; }","duration":"854.197479ms","start":"2026-10-21T02:00:03.479534Z","end":"2026-10-21T02:00:04.333732Z","steps":["trace[1190445241] 'read index received' (duration: 361.198432ms)","trace[1190445241] 'applied index is now lower than readState.Index' (duration: 492.997837ms)"],"step_count":2} {"level":"info","ts":"2026-10-21T02:00:04.333813Z","caller":"traceutil/trace.go:171","msg":"trace[507511921] transaction","detail":"{read_only:false; response_revision:21209; number_of_response:1; }","duration":"894.934878ms","start":"2026-10-21T02:00:03.438869Z","end":"2026-10-21T02:00:04.333803Z","steps":["trace[507511921] 'process raft request' (duration: 894.741343ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T02:00:04.333883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T02:00:03.438844Z","time spent":"894.988839ms","remote":"127.0.0.1:38120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-21T02:00:04.33395Z","caller":"traceutil/trace.go:171","msg":"trace[241630619] transaction","detail":"{read_only:false; response_revision:21208; number_of_response:1; }","duration":"929.301315ms","start":"2026-10-21T02:00:03.404609Z","end":"2026-10-21T02:00:04.333911Z","steps":["trace[241630619] 'process raft request' (duration: 658.854912ms)","trace[241630619] 'compare' (duration: 269.671725ms)"],"step_count":2} {"level":"info","ts":"2026-10-21T02:00:04.334147Z","caller":"traceutil/trace.go:171","msg":"trace[1761690599] transaction","detail":"{read_only:false; response_revision:21210; number_of_response:1; }","duration":"889.97643ms","start":"2026-10-21T02:00:03.443992Z","end":"2026-10-21T02:00:04.333968Z","steps":["trace[1761690599] 'process raft request' (duration: 889.701983ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T02:00:04.334183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.65494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-21T02:00:04.334217Z","caller":"traceutil/trace.go:171","msg":"trace[1650786813] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21210; }","duration":"854.728591ms","start":"2026-10-21T02:00:03.479475Z","end":"2026-10-21T02:00:04.334203Z","steps":["trace[1650786813] 'agreement among raft nodes before linearized reading' (duration: 854.612309ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T02:00:04.334242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T02:00:03.479454Z","time spent":"854.781873ms","remote":"127.0.0.1:38120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-21T02:00:04.334241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T02:00:03.443967Z","time spent":"890.227136ms","remote":"127.0.0.1:38120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-21T02:00:04.334246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T02:00:03.404585Z","time spent":"929.543942ms","remote":"127.0.0.1:38120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-21T02:00:04.334986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.978017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-21T02:00:04.335124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.071051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-21T02:00:04.335234Z","caller":"traceutil/trace.go:171","msg":"trace[211806251] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagerconfigs/; range_end:/registry/monitoring.coreos.com/alertmanagerconfigs0; response_count:0; response_revision:21211; }","duration":"565.225485ms","start":"2026-10-21T02:00:03.769978Z","end":"2026-10-21T02:00:04.335203Z","steps":["trace[211806251] 'agreement among raft nodes before linearized reading' (duration: 565.01952ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T02:00:04.335154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.683333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-21T02:00:04.335323Z","caller":"traceutil/trace.go:171","msg":"trace[185608387] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:21211; }","duration":"625.897589ms","start":"2026-10-21T02:00:03.709405Z","end":"2026-10-21T02:00:04.335303Z","steps":["trace[185608387] 'agreement among raft nodes before linearized reading' (duration: 625.621882ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T02:00:04.335315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T02:00:03.769965Z","time spent":"565.330187ms","remote":"127.0.0.1:38462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true "} {"level":"warn","ts":"2026-10-21T02:00:04.335362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T02:00:03.709384Z","time spent":"625.96362ms","remote":"127.0.0.1:37998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":13,"response size":32,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-10-21T02:00:04.335367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.509283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-21T02:00:04.335393Z","caller":"traceutil/trace.go:171","msg":"trace[771182735] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:21211; }","duration":"641.178092ms","start":"2026-10-21T02:00:03.693936Z","end":"2026-10-21T02:00:04.335115Z","steps":["trace[771182735] 'agreement among raft nodes before linearized reading' (duration: 640.945597ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T02:00:04.335434Z","caller":"traceutil/trace.go:171","msg":"trace[534341105] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:21211; }","duration":"494.633326ms","start":"2026-10-21T02:00:03.84078Z","end":"2026-10-21T02:00:04.335414Z","steps":["trace[534341105] 'agreement among raft nodes before linearized reading' (duration: 494.460312ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T02:00:04.335417Z","caller":"traceutil/trace.go:171","msg":"trace[1523968961] transaction","detail":"{read_only:false; response_revision:21211; number_of_response:1; }","duration":"159.501955ms","start":"2026-10-21T02:00:04.175888Z","end":"2026-10-21T02:00:04.33539Z","steps":["trace[1523968961] 'process raft request' (duration: 158.843679ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T02:00:04.335482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T02:00:03.840759Z","time spent":"494.709458ms","remote":"127.0.0.1:38024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":32,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-10-21T02:00:04.335503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T02:00:03.693916Z","time spent":"641.53877ms","remote":"127.0.0.1:58276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":30,"request content":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true "} {"level":"warn","ts":"2026-10-21T02:00:04.888352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.021701ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-21T02:00:04.888457Z","caller":"traceutil/trace.go:171","msg":"trace[490400999] transaction","detail":"{read_only:false; response_revision:21212; number_of_response:1; }","duration":"549.307206ms","start":"2026-10-21T02:00:04.33913Z","end":"2026-10-21T02:00:04.888437Z","steps":["trace[490400999] 'process raft request' (duration: 343.153552ms)","trace[490400999] 'compare' (duration: 205.830926ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T02:00:04.88853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T02:00:04.339112Z","time spent":"549.387278ms","remote":"127.0.0.1:38120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-21T02:00:04.896085Z","caller":"traceutil/trace.go:171","msg":"trace[205321807] linearizableReadLoop","detail":"{readStateIndex:21936; appliedIndex:21934; }","duration":"286.194198ms","start":"2026-10-21T02:00:04.609875Z","end":"2026-10-21T02:00:04.896069Z","steps":["trace[205321807] 'read index received' (duration: 72.32609ms)","trace[205321807] 'applied index is now lower than readState.Index' (duration: 213.867058ms)"],"step_count":2} {"level":"warn","ts":"2026-10-21T02:00:04.896232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.31947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-21T02:00:04.896202Z","caller":"traceutil/trace.go:171","msg":"trace[1112688805] transaction","detail":"{read_only:false; response_revision:21213; number_of_response:1; }","duration":"556.427956ms","start":"2026-10-21T02:00:04.339728Z","end":"2026-10-21T02:00:04.896155Z","steps":["trace[1112688805] 'process raft request' (duration: 556.251161ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T02:00:04.896277Z","caller":"traceutil/trace.go:171","msg":"trace[1646013534] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:21213; }","duration":"286.426173ms","start":"2026-10-21T02:00:04.609833Z","end":"2026-10-21T02:00:04.896259Z","steps":["trace[1646013534] 'agreement among raft nodes before linearized reading' (duration: 286.327411ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T02:00:04.896309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.861644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-21T02:00:04.896378Z","caller":"traceutil/trace.go:171","msg":"trace[833006651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21213; }","duration":"228.964246ms","start":"2026-10-21T02:00:04.667396Z","end":"2026-10-21T02:00:04.89636Z","steps":["trace[833006651] 'agreement among raft nodes before linearized reading' (duration: 228.850514ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T02:00:04.896391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-21T02:00:04.339708Z","time spent":"556.57813ms","remote":"127.0.0.1:38120","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-21T02:00:04.896503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.916175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-10-21T02:00:04.896602Z","caller":"traceutil/trace.go:171","msg":"trace[1477905080] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:21213; }","duration":"131.086188ms","start":"2026-10-21T02:00:04.765498Z","end":"2026-10-21T02:00:04.896584Z","steps":["trace[1477905080] 'agreement among raft nodes before linearized reading' (duration: 130.77341ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T02:01:27.154759Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19717} {"level":"info","ts":"2026-10-21T02:01:27.281417Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19717,"took":"123.062647ms","hash":3617741138,"current-db-size-bytes":57487360,"current-db-size":"58 MB","current-db-size-in-use-bytes":30318592,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-21T02:01:27.281486Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3617741138,"revision":19717,"compact-revision":17010} {"level":"info","ts":"2026-10-21T02:04:17.927936Z","caller":"traceutil/trace.go:171","msg":"trace[1145507801] transaction","detail":"{read_only:false; response_revision:23787; number_of_response:1; }","duration":"176.090598ms","start":"2026-10-21T02:04:17.751784Z","end":"2026-10-21T02:04:17.927875Z","steps":["trace[1145507801] 'process raft request' (duration: 175.905414ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T02:06:27.164166Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21957} {"level":"info","ts":"2026-10-21T02:06:27.286853Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21957,"took":"118.043798ms","hash":1418454437,"current-db-size-bytes":57487360,"current-db-size":"58 MB","current-db-size-in-use-bytes":44625920,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-10-21T02:06:27.286906Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1418454437,"revision":21957,"compact-revision":19717} {"level":"info","ts":"2026-10-21T02:07:55.103672Z","caller":"traceutil/trace.go:171","msg":"trace[629511150] transaction","detail":"{read_only:false; response_revision:25939; number_of_response:1; }","duration":"164.422292ms","start":"2026-10-21T02:07:54.939214Z","end":"2026-10-21T02:07:55.103637Z","steps":["trace[629511150] 'process raft request' (duration: 164.244408ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T02:08:13.185672Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000693a.wal"} {"level":"warn","ts":"2026-10-21T02:09:00.045971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.486755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-21T02:09:00.046086Z","caller":"traceutil/trace.go:171","msg":"trace[1604322344] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26513; }","duration":"117.642999ms","start":"2026-10-21T02:08:59.928403Z","end":"2026-10-21T02:09:00.046046Z","steps":["trace[1604322344] 'range keys from in-memory index tree' (duration: 117.247879ms)"],"step_count":1} {"level":"warn","ts":"2026-10-21T02:09:00.046475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.881274ms","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-21T02:09:00.046636Z","caller":"traceutil/trace.go:171","msg":"trace[1860355300] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26513; }","duration":"102.089929ms","start":"2026-10-21T02:08:59.944519Z","end":"2026-10-21T02:09:00.046609Z","steps":["trace[1860355300] 'range keys from in-memory index tree' (duration: 101.729271ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T02:09:00.297879Z","caller":"traceutil/trace.go:171","msg":"trace[242742984] transaction","detail":"{read_only:false; response_revision:26518; number_of_response:1; }","duration":"216.341027ms","start":"2026-10-21T02:09:00.081503Z","end":"2026-10-21T02:09:00.297844Z","steps":["trace[242742984] 'process raft request' (duration: 216.261035ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T02:09:00.298376Z","caller":"traceutil/trace.go:171","msg":"trace[372857639] transaction","detail":"{read_only:false; response_revision:26515; number_of_response:1; }","duration":"247.845976ms","start":"2026-10-21T02:09:00.050514Z","end":"2026-10-21T02:09:00.29836Z","steps":["trace[372857639] 'process raft request' (duration: 246.959435ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T02:09:00.298546Z","caller":"traceutil/trace.go:171","msg":"trace[1023081535] transaction","detail":"{read_only:false; response_revision:26516; number_of_response:1; }","duration":"247.073198ms","start":"2026-10-21T02:09:00.051458Z","end":"2026-10-21T02:09:00.298532Z","steps":["trace[1023081535] 'process raft request' (duration: 246.205668ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T02:09:00.298713Z","caller":"traceutil/trace.go:171","msg":"trace[1840585726] transaction","detail":"{read_only:false; response_revision:26517; number_of_response:1; }","duration":"243.920383ms","start":"2026-10-21T02:09:00.054778Z","end":"2026-10-21T02:09:00.298698Z","steps":["trace[1840585726] 'process raft request' (duration: 242.93869ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T02:09:00.299239Z","caller":"traceutil/trace.go:171","msg":"trace[263032950] transaction","detail":"{read_only:false; response_revision:26519; number_of_response:1; }","duration":"188.280859ms","start":"2026-10-21T02:09:00.110934Z","end":"2026-10-21T02:09:00.299215Z","steps":["trace[263032950] 'process raft request' (duration: 188.167697ms)"],"step_count":1} {"level":"info","ts":"2026-10-21T02:11:27.174742Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25156} {"level":"info","ts":"2026-10-21T02:11:27.337929Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25156,"took":"156.135235ms","hash":3157186617,"current-db-size-bytes":59183104,"current-db-size":"59 MB","current-db-size-in-use-bytes":37191680,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-10-21T02:11:27.338073Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3157186617,"revision":25156,"compact-revision":21957} {"level":"info","ts":"2026-10-21T02:13:19.46105Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cfc9fec265e3384a","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-21T02:13:19.466957Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-21T02:13:19.467062Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-21T02:16:27.182876Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27932} {"level":"info","ts":"2026-10-21T02:16:27.332954Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27932,"took":"144.281353ms","hash":2395927221,"current-db-size-bytes":59183104,"current-db-size":"59 MB","current-db-size-in-use-bytes":33460224,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-21T02:16:27.333022Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2395927221,"revision":27932,"compact-revision":25156} {"level":"info","ts":"2026-10-21T02:21:27.191832Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30502} {"level":"info","ts":"2026-10-21T02:21:27.345582Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30502,"took":"145.894371ms","hash":150763867,"current-db-size-bytes":59183104,"current-db-size":"59 MB","current-db-size-in-use-bytes":30765056,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-21T02:21:27.345665Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":150763867,"revision":30502,"compact-revision":27932} {"level":"info","ts":"2026-10-21T02:26:27.201031Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32748} {"level":"info","ts":"2026-10-21T02:26:27.359035Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32748,"took":"151.946846ms","hash":2397991697,"current-db-size-bytes":60227584,"current-db-size":"60 MB","current-db-size-in-use-bytes":30392320,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-21T02:26:27.359112Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2397991697,"revision":32748,"compact-revision":30502} {"level":"info","ts":"2026-10-21T02:31:27.212711Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34979} {"level":"info","ts":"2026-10-21T02:31:27.3419Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34979,"took":"124.642126ms","hash":4037052302,"current-db-size-bytes":60227584,"current-db-size":"60 MB","current-db-size-in-use-bytes":32288768,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-21T02:31:27.341968Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4037052302,"revision":34979,"compact-revision":32748} {"level":"info","ts":"2026-10-21T02:34:50.270232Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cfc9fec265e3384a","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-21T02:34:50.276052Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-21T02:34:50.276141Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-21T02:36:27.225052Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37270} {"level":"info","ts":"2026-10-21T02:36:27.357661Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37270,"took":"128.526187ms","hash":1665066126,"current-db-size-bytes":60227584,"current-db-size":"60 MB","current-db-size-in-use-bytes":32899072,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-21T02:36:27.357727Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1665066126,"revision":37270,"compact-revision":34979} {"level":"info","ts":"2026-10-21T02:41:27.236936Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39554} {"level":"info","ts":"2026-10-21T02:41:27.378439Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39554,"took":"136.813424ms","hash":508275339,"current-db-size-bytes":60227584,"current-db-size":"60 MB","current-db-size-in-use-bytes":30965760,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-21T02:41:27.378511Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":508275339,"revision":39554,"compact-revision":37270}