{"level":"warn","ts":"2026-08-21T02:22:44.530021Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-21T02:22:44.530135Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.204:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.204:2380","--initial-cluster=instance=https://199.19.213.204:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.204:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.204: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-08-21T02:22:44.530217Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-21T02:22:44.530228Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.204:2380"]} {"level":"info","ts":"2026-08-21T02:22:44.530256Z","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-08-21T02:22:44.531035Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.204:2379"]} {"level":"info","ts":"2026-08-21T02:22:44.531123Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.204:2380"],"listen-peer-urls":["https://199.19.213.204:2380"],"advertise-client-urls":["https://199.19.213.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.204: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-08-21T02:22:44.536996Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.587757ms"} {"level":"info","ts":"2026-08-21T02:22:44.550828Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7e62df5d1e8b96ac","cluster-id":"502b8ba4e757e03a"} {"level":"info","ts":"2026-08-21T02:22:44.550933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac switched to configuration voters=()"} {"level":"info","ts":"2026-08-21T02:22:44.550957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac became follower at term 0"} {"level":"info","ts":"2026-08-21T02:22:44.550975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7e62df5d1e8b96ac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-21T02:22:44.550987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac became follower at term 1"} {"level":"info","ts":"2026-08-21T02:22:44.551034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac switched to configuration voters=(9107086987533981356)"} {"level":"warn","ts":"2026-08-21T02:22:44.57789Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-21T02:22:44.583208Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-21T02:22:44.588503Z","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-08-21T02:22:44.593782Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7e62df5d1e8b96ac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-21T02:22:44.594325Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7e62df5d1e8b96ac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-21T02:22:44.594459Z","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-08-21T02:22:44.594501Z","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-08-21T02:22:44.594511Z","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-08-21T02:22:44.598277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac switched to configuration voters=(9107086987533981356)"} {"level":"info","ts":"2026-08-21T02:22:44.598464Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"502b8ba4e757e03a","local-member-id":"7e62df5d1e8b96ac","added-peer-id":"7e62df5d1e8b96ac","added-peer-peer-urls":["https://199.19.213.204:2380"]} {"level":"info","ts":"2026-08-21T02:22:44.602566Z","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-08-21T02:22:44.602745Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.204:2380"} {"level":"info","ts":"2026-08-21T02:22:44.602779Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.204:2380"} {"level":"info","ts":"2026-08-21T02:22:44.603208Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7e62df5d1e8b96ac","initial-advertise-peer-urls":["https://199.19.213.204:2380"],"listen-peer-urls":["https://199.19.213.204:2380"],"advertise-client-urls":["https://199.19.213.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-21T02:22:44.60325Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-21T02:22:45.451293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac is starting a new election at term 1"} {"level":"info","ts":"2026-08-21T02:22:45.451403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac became pre-candidate at term 1"} {"level":"info","ts":"2026-08-21T02:22:45.451439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac received MsgPreVoteResp from 7e62df5d1e8b96ac at term 1"} {"level":"info","ts":"2026-08-21T02:22:45.451461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac became candidate at term 2"} {"level":"info","ts":"2026-08-21T02:22:45.451471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac received MsgVoteResp from 7e62df5d1e8b96ac at term 2"} {"level":"info","ts":"2026-08-21T02:22:45.45149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac became leader at term 2"} {"level":"info","ts":"2026-08-21T02:22:45.451504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7e62df5d1e8b96ac elected leader 7e62df5d1e8b96ac at term 2"} {"level":"info","ts":"2026-08-21T02:22:45.452915Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-21T02:22:45.454151Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-21T02:22:45.454693Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"502b8ba4e757e03a","local-member-id":"7e62df5d1e8b96ac","cluster-version":"3.5"} {"level":"info","ts":"2026-08-21T02:22:45.454824Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-21T02:22:45.454861Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-21T02:22:45.454163Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7e62df5d1e8b96ac","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.204:2379]}","request-path":"/0/members/7e62df5d1e8b96ac/attributes","cluster-id":"502b8ba4e757e03a","publish-timeout":"7s"} {"level":"info","ts":"2026-08-21T02:22:45.45427Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-21T02:22:45.455012Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-21T02:22:45.455055Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-21T02:22:45.459711Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-21T02:22:45.465191Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.204:2379"} {"level":"info","ts":"2026-08-21T02:23:26.792565Z","caller":"traceutil/trace.go:171","msg":"trace[1331960566] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"117.836154ms","start":"2026-08-21T02:23:26.674712Z","end":"2026-08-21T02:23:26.792548Z","steps":["trace[1331960566] 'process raft request' (duration: 113.907005ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:23:27.116734Z","caller":"traceutil/trace.go:171","msg":"trace[1012948326] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"233.52499ms","start":"2026-08-21T02:23:26.883192Z","end":"2026-08-21T02:23:27.116717Z","steps":["trace[1012948326] 'process raft request' (duration: 223.687744ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:23:33.326346Z","caller":"traceutil/trace.go:171","msg":"trace[1339564621] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"262.703737ms","start":"2026-08-21T02:23:33.063617Z","end":"2026-08-21T02:23:33.32632Z","steps":["trace[1339564621] 'process raft request' (duration: 262.518273ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:23:33.744469Z","caller":"traceutil/trace.go:171","msg":"trace[1746065026] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"203.708498ms","start":"2026-08-21T02:23:33.540734Z","end":"2026-08-21T02:23:33.744442Z","steps":["trace[1746065026] 'read index received' (duration: 203.514843ms)","trace[1746065026] 'applied index is now lower than readState.Index' (duration: 192.625µs)"],"step_count":2} {"level":"warn","ts":"2026-08-21T02:23:33.744611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.850881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-21T02:23:33.744647Z","caller":"traceutil/trace.go:171","msg":"trace[2143040977] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"244.49944ms","start":"2026-08-21T02:23:33.500059Z","end":"2026-08-21T02:23:33.744559Z","steps":["trace[2143040977] 'process raft request' (duration: 244.216544ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:23:33.744935Z","caller":"traceutil/trace.go:171","msg":"trace[2074512945] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:652; }","duration":"204.230279ms","start":"2026-08-21T02:23:33.540689Z","end":"2026-08-21T02:23:33.744919Z","steps":["trace[2074512945] 'agreement among raft nodes before linearized reading' (duration: 203.858951ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:23:34.061316Z","caller":"traceutil/trace.go:171","msg":"trace[105443836] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"295.610169ms","start":"2026-08-21T02:23:33.765674Z","end":"2026-08-21T02:23:34.061284Z","steps":["trace[105443836] 'process raft request' (duration: 287.954223ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:23:49.889409Z","caller":"traceutil/trace.go:171","msg":"trace[870896858] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"321.04282ms","start":"2026-08-21T02:23:49.568336Z","end":"2026-08-21T02:23:49.889379Z","steps":["trace[870896858] 'process raft request' (duration: 320.861945ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:23:49.889993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T02:23:49.568313Z","time spent":"321.180393ms","remote":"127.0.0.1:40486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-21T02:24:18.466727Z","caller":"traceutil/trace.go:171","msg":"trace[2046753499] linearizableReadLoop","detail":"{readStateIndex:1236; appliedIndex:1235; }","duration":"174.775934ms","start":"2026-08-21T02:24:18.291921Z","end":"2026-08-21T02:24:18.466697Z","steps":["trace[2046753499] 'read index received' (duration: 174.466577ms)","trace[2046753499] 'applied index is now lower than readState.Index' (duration: 308.337µs)"],"step_count":2} {"level":"info","ts":"2026-08-21T02:24:18.466925Z","caller":"traceutil/trace.go:171","msg":"trace[1309364974] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"229.038874ms","start":"2026-08-21T02:24:18.237746Z","end":"2026-08-21T02:24:18.466785Z","steps":["trace[1309364974] 'process raft request' (duration: 228.752058ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:24:18.46719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.203073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-21T02:24:18.467307Z","caller":"traceutil/trace.go:171","msg":"trace[960345659] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1203; }","duration":"175.419438ms","start":"2026-08-21T02:24:18.291862Z","end":"2026-08-21T02:24:18.467282Z","steps":["trace[960345659] 'agreement among raft nodes before linearized reading' (duration: 174.964038ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:25:03.633246Z","caller":"traceutil/trace.go:171","msg":"trace[547069325] linearizableReadLoop","detail":"{readStateIndex:1934; appliedIndex:1933; }","duration":"253.317007ms","start":"2026-08-21T02:25:03.379902Z","end":"2026-08-21T02:25:03.633219Z","steps":["trace[547069325] 'read index received' (duration: 253.121042ms)","trace[547069325] 'applied index is now lower than readState.Index' (duration: 194.915µs)"],"step_count":2} {"level":"info","ts":"2026-08-21T02:25:03.63347Z","caller":"traceutil/trace.go:171","msg":"trace[907944074] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"266.240423ms","start":"2026-08-21T02:25:03.367216Z","end":"2026-08-21T02:25:03.633457Z","steps":["trace[907944074] 'process raft request' (duration: 265.783783ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:25:03.634184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.245379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-08-21T02:25:03.634522Z","caller":"traceutil/trace.go:171","msg":"trace[1560109665] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1866; }","duration":"254.386122ms","start":"2026-08-21T02:25:03.37987Z","end":"2026-08-21T02:25:03.634256Z","steps":["trace[1560109665] 'agreement among raft nodes before linearized reading' (duration: 253.588863ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:25:03.766553Z","caller":"traceutil/trace.go:171","msg":"trace[656305106] linearizableReadLoop","detail":"{readStateIndex:1935; appliedIndex:1934; }","duration":"133.099911ms","start":"2026-08-21T02:25:03.633428Z","end":"2026-08-21T02:25:03.766528Z","steps":["trace[656305106] 'read index received' (duration: 132.877476ms)","trace[656305106] 'applied index is now lower than readState.Index' (duration: 221.625µs)"],"step_count":2} {"level":"info","ts":"2026-08-21T02:25:03.766601Z","caller":"traceutil/trace.go:171","msg":"trace[2123184790] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"359.107384ms","start":"2026-08-21T02:25:03.407465Z","end":"2026-08-21T02:25:03.766572Z","steps":["trace[2123184790] 'process raft request' (duration: 358.92378ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:25:03.766776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.327885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-be4fad26-0b90-405d-9275-2878e94d312b\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-08-21T02:25:03.766779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T02:25:03.407439Z","time spent":"359.244238ms","remote":"127.0.0.1:40486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-21T02:25:03.766821Z","caller":"traceutil/trace.go:171","msg":"trace[1279430677] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-be4fad26-0b90-405d-9275-2878e94d312b; range_end:; response_count:1; response_revision:1867; }","duration":"252.423437ms","start":"2026-08-21T02:25:03.514388Z","end":"2026-08-21T02:25:03.766811Z","steps":["trace[1279430677] 'agreement among raft nodes before linearized reading' (duration: 252.264544ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:25:03.76676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.27406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-21T02:25:03.766847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.489627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-21T02:25:03.766905Z","caller":"traceutil/trace.go:171","msg":"trace[2049592461] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1867; }","duration":"226.486974ms","start":"2026-08-21T02:25:03.540407Z","end":"2026-08-21T02:25:03.766894Z","steps":["trace[2049592461] 'agreement among raft nodes before linearized reading' (duration: 226.176867ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:25:03.766931Z","caller":"traceutil/trace.go:171","msg":"trace[228654065] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1867; }","duration":"132.63393ms","start":"2026-08-21T02:25:03.634272Z","end":"2026-08-21T02:25:03.766906Z","steps":["trace[228654065] 'agreement among raft nodes before linearized reading' (duration: 132.416595ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:25:15.925686Z","caller":"traceutil/trace.go:171","msg":"trace[1856962032] linearizableReadLoop","detail":"{readStateIndex:2040; appliedIndex:2039; }","duration":"210.719634ms","start":"2026-08-21T02:25:15.714942Z","end":"2026-08-21T02:25:15.925662Z","steps":["trace[1856962032] 'read index received' (duration: 210.599701ms)","trace[1856962032] 'applied index is now lower than readState.Index' (duration: 118.843µs)"],"step_count":2} {"level":"info","ts":"2026-08-21T02:25:15.925811Z","caller":"traceutil/trace.go:171","msg":"trace[1613805256] transaction","detail":"{read_only:false; response_revision:1969; number_of_response:1; }","duration":"242.98406ms","start":"2026-08-21T02:25:15.682794Z","end":"2026-08-21T02:25:15.925778Z","steps":["trace[1613805256] 'process raft request' (duration: 242.722604ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:25:15.925973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.00942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-08-21T02:25:15.926017Z","caller":"traceutil/trace.go:171","msg":"trace[546818327] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1969; }","duration":"211.108552ms","start":"2026-08-21T02:25:15.714896Z","end":"2026-08-21T02:25:15.926005Z","steps":["trace[546818327] 'agreement among raft nodes before linearized reading' (duration: 210.927508ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:25:15.975566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.401916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-08-21T02:25:15.975652Z","caller":"traceutil/trace.go:171","msg":"trace[872837530] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1970; }","duration":"143.540429ms","start":"2026-08-21T02:25:15.832091Z","end":"2026-08-21T02:25:15.975631Z","steps":["trace[872837530] 'agreement among raft nodes before linearized reading' (duration: 143.310794ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:25:23.450306Z","caller":"traceutil/trace.go:171","msg":"trace[1494660102] linearizableReadLoop","detail":"{readStateIndex:2089; appliedIndex:2088; }","duration":"123.745947ms","start":"2026-08-21T02:25:23.326533Z","end":"2026-08-21T02:25:23.450279Z","steps":["trace[1494660102] 'read index received' (duration: 123.558262ms)","trace[1494660102] 'applied index is now lower than readState.Index' (duration: 186.824µs)"],"step_count":2} {"level":"warn","ts":"2026-08-21T02:25:23.450462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.910221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-21T02:25:23.450497Z","caller":"traceutil/trace.go:171","msg":"trace[684064470] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:2017; }","duration":"124.005162ms","start":"2026-08-21T02:25:23.326481Z","end":"2026-08-21T02:25:23.450487Z","steps":["trace[684064470] 'agreement among raft nodes before linearized reading' (duration: 123.89564ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:25:23.450677Z","caller":"traceutil/trace.go:171","msg":"trace[1418838877] transaction","detail":"{read_only:false; response_revision:2017; number_of_response:1; }","duration":"264.299447ms","start":"2026-08-21T02:25:23.186363Z","end":"2026-08-21T02:25:23.450663Z","steps":["trace[1418838877] 'process raft request' (duration: 263.796926ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:25:47.37531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.792664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"warn","ts":"2026-08-21T02:25:47.375355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.789484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-08-21T02:25:47.375507Z","caller":"traceutil/trace.go:171","msg":"trace[1309819603] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2152; }","duration":"312.947328ms","start":"2026-08-21T02:25:47.062542Z","end":"2026-08-21T02:25:47.375489Z","steps":["trace[1309819603] 'range keys from in-memory index tree' (duration: 312.724653ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:25:47.375554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T02:25:47.062522Z","time spent":"313.024069ms","remote":"127.0.0.1:40286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":140,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"warn","ts":"2026-08-21T02:25:47.375805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.477351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12380"} {"level":"info","ts":"2026-08-21T02:25:47.375423Z","caller":"traceutil/trace.go:171","msg":"trace[1205821086] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2152; }","duration":"231.953758ms","start":"2026-08-21T02:25:47.143442Z","end":"2026-08-21T02:25:47.375396Z","steps":["trace[1205821086] 'range keys from in-memory index tree' (duration: 231.61227ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:25:47.37588Z","caller":"traceutil/trace.go:171","msg":"trace[1224629691] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2152; }","duration":"141.588754ms","start":"2026-08-21T02:25:47.234273Z","end":"2026-08-21T02:25:47.375862Z","steps":["trace[1224629691] 'range keys from in-memory index tree' (duration: 141.114984ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:25:47.376231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.659762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:102507"} {"level":"info","ts":"2026-08-21T02:25:47.376344Z","caller":"traceutil/trace.go:171","msg":"trace[672595765] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2152; }","duration":"316.805436ms","start":"2026-08-21T02:25:47.05953Z","end":"2026-08-21T02:25:47.376335Z","steps":["trace[672595765] 'range keys from in-memory index tree' (duration: 316.216193ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:25:47.376498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T02:25:47.059513Z","time spent":"316.972669ms","remote":"127.0.0.1:40276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":102529,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-08-21T02:26:34.791518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.441572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-21T02:26:34.791593Z","caller":"traceutil/trace.go:171","msg":"trace[207516764] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:2513; }","duration":"131.527904ms","start":"2026-08-21T02:26:34.660049Z","end":"2026-08-21T02:26:34.791577Z","steps":["trace[207516764] 'count revisions from in-memory index tree' (duration: 131.302089ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:26:34.791616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.047166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-08-21T02:26:34.791642Z","caller":"traceutil/trace.go:171","msg":"trace[481657675] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2513; }","duration":"263.095377ms","start":"2026-08-21T02:26:34.528539Z","end":"2026-08-21T02:26:34.791634Z","steps":["trace[481657675] 'range keys from in-memory index tree' (duration: 262.969424ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:26:34.791794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.602687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-21T02:26:34.791858Z","caller":"traceutil/trace.go:171","msg":"trace[1532308553] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2513; }","duration":"252.670139ms","start":"2026-08-21T02:26:34.539172Z","end":"2026-08-21T02:26:34.791842Z","steps":["trace[1532308553] 'range keys from in-memory index tree' (duration: 252.570087ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:27:06.811477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.148698ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-21T02:27:06.811802Z","caller":"traceutil/trace.go:171","msg":"trace[397893131] transaction","detail":"{read_only:false; response_revision:2691; number_of_response:1; }","duration":"267.708521ms","start":"2026-08-21T02:27:06.543922Z","end":"2026-08-21T02:27:06.81163Z","steps":["trace[397893131] 'process raft request' (duration: 78.223415ms)","trace[397893131] 'compare' (duration: 188.840792ms)"],"step_count":2} {"level":"warn","ts":"2026-08-21T02:27:07.133148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.955777ms","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-08-21T02:27:07.133306Z","caller":"traceutil/trace.go:171","msg":"trace[943300651] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2691; }","duration":"180.10281ms","start":"2026-08-21T02:27:06.953122Z","end":"2026-08-21T02:27:07.133225Z","steps":["trace[943300651] 'range keys from in-memory index tree' (duration: 179.791084ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:27:07.133584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.273947ms","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-08-21T02:27:07.133659Z","caller":"traceutil/trace.go:171","msg":"trace[1836483647] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2691; }","duration":"188.4039ms","start":"2026-08-21T02:27:06.945244Z","end":"2026-08-21T02:27:07.133648Z","steps":["trace[1836483647] 'range keys from in-memory index tree' (duration: 188.086773ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:28:56.697566Z","caller":"traceutil/trace.go:171","msg":"trace[1956079874] transaction","detail":"{read_only:false; response_revision:3346; number_of_response:1; }","duration":"110.998292ms","start":"2026-08-21T02:28:56.586546Z","end":"2026-08-21T02:28:56.697544Z","steps":["trace[1956079874] 'process raft request' (duration: 110.866919ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:30:58.870939Z","caller":"traceutil/trace.go:171","msg":"trace[902385779] transaction","detail":"{read_only:false; response_revision:4548; number_of_response:1; }","duration":"104.499554ms","start":"2026-08-21T02:30:58.766411Z","end":"2026-08-21T02:30:58.870911Z","steps":["trace[902385779] 'process raft request' (duration: 104.33133ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:31:02.184603Z","caller":"traceutil/trace.go:171","msg":"trace[870336997] transaction","detail":"{read_only:false; response_revision:4623; number_of_response:1; }","duration":"203.452819ms","start":"2026-08-21T02:31:01.981128Z","end":"2026-08-21T02:31:02.184581Z","steps":["trace[870336997] 'process raft request' (duration: 114.790387ms)","trace[870336997] 'compare' (duration: 88.57942ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T02:31:02.184673Z","caller":"traceutil/trace.go:171","msg":"trace[756700690] linearizableReadLoop","detail":"{readStateIndex:4794; appliedIndex:4793; }","duration":"133.238248ms","start":"2026-08-21T02:31:02.051426Z","end":"2026-08-21T02:31:02.184665Z","steps":["trace[756700690] 'read index received' (duration: 44.439873ms)","trace[756700690] 'applied index is now lower than readState.Index' (duration: 88.797975ms)"],"step_count":2} {"level":"warn","ts":"2026-08-21T02:31:02.184807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.365331ms","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-08-21T02:31:02.184866Z","caller":"traceutil/trace.go:171","msg":"trace[1035638290] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4624; }","duration":"133.438473ms","start":"2026-08-21T02:31:02.051398Z","end":"2026-08-21T02:31:02.184837Z","steps":["trace[1035638290] 'agreement among raft nodes before linearized reading' (duration: 133.31035ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:31:02.308309Z","caller":"traceutil/trace.go:171","msg":"trace[262320380] transaction","detail":"{read_only:false; response_revision:4625; number_of_response:1; }","duration":"124.175273ms","start":"2026-08-21T02:31:02.1841Z","end":"2026-08-21T02:31:02.308275Z","steps":["trace[262320380] 'process raft request' (duration: 122.590446ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:31:02.308584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.741627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-64t7k\" ","response":"range_response_count:1 size:9757"} {"level":"warn","ts":"2026-08-21T02:31:02.308629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.722243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-21T02:31:02.308682Z","caller":"traceutil/trace.go:171","msg":"trace[620286027] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-64t7k; range_end:; response_count:1; response_revision:4625; }","duration":"125.88823ms","start":"2026-08-21T02:31:02.182776Z","end":"2026-08-21T02:31:02.308664Z","steps":["trace[620286027] 'agreement among raft nodes before linearized reading' (duration: 125.571393ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:31:02.308745Z","caller":"traceutil/trace.go:171","msg":"trace[900941306] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:0; response_revision:4625; }","duration":"152.904137ms","start":"2026-08-21T02:31:02.155825Z","end":"2026-08-21T02:31:02.308729Z","steps":["trace[900941306] 'agreement among raft nodes before linearized reading' (duration: 152.724663ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:31:02.308709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.039137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-21T02:31:02.308923Z","caller":"traceutil/trace.go:171","msg":"trace[1017059620] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:4625; }","duration":"145.344774ms","start":"2026-08-21T02:31:02.163563Z","end":"2026-08-21T02:31:02.308908Z","steps":["trace[1017059620] 'agreement among raft nodes before linearized reading' (duration: 144.782881ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:31:02.309012Z","caller":"traceutil/trace.go:171","msg":"trace[1625156335] transaction","detail":"{read_only:false; response_revision:4626; number_of_response:1; }","duration":"121.913691ms","start":"2026-08-21T02:31:02.187084Z","end":"2026-08-21T02:31:02.308998Z","steps":["trace[1625156335] 'process raft request' (duration: 121.794358ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:31:02.30831Z","caller":"traceutil/trace.go:171","msg":"trace[1889115838] linearizableReadLoop","detail":"{readStateIndex:4796; appliedIndex:4795; }","duration":"123.595138ms","start":"2026-08-21T02:31:02.184694Z","end":"2026-08-21T02:31:02.308289Z","steps":["trace[1889115838] 'read index received' (duration: 122.138234ms)","trace[1889115838] 'applied index is now lower than readState.Index' (duration: 1.455874ms)"],"step_count":2} {"level":"warn","ts":"2026-08-21T02:31:04.939113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.431684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-315561ba-3bea-4019-9602-f44a381f7637\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-08-21T02:31:04.939203Z","caller":"traceutil/trace.go:171","msg":"trace[454523695] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-315561ba-3bea-4019-9602-f44a381f7637; range_end:; response_count:1; response_revision:4698; }","duration":"344.561366ms","start":"2026-08-21T02:31:04.594621Z","end":"2026-08-21T02:31:04.939182Z","steps":["trace[454523695] 'range keys from in-memory index tree' (duration: 344.26652ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:31:04.939208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.711522ms","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-08-21T02:31:04.939247Z","caller":"traceutil/trace.go:171","msg":"trace[1363219978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4698; }","duration":"441.785833ms","start":"2026-08-21T02:31:04.49745Z","end":"2026-08-21T02:31:04.939236Z","steps":["trace[1363219978] 'range keys from in-memory index tree' (duration: 441.574219ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:31:04.939253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T02:31:04.594604Z","time spent":"344.631828ms","remote":"127.0.0.1:40408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-315561ba-3bea-4019-9602-f44a381f7637\" "} {"level":"warn","ts":"2026-08-21T02:31:04.939275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T02:31:04.49743Z","time spent":"441.838995ms","remote":"127.0.0.1:40486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-21T02:31:04.939432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.612979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-21T02:31:04.939494Z","caller":"traceutil/trace.go:171","msg":"trace[1095673768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4698; }","duration":"398.67781ms","start":"2026-08-21T02:31:04.540781Z","end":"2026-08-21T02:31:04.939458Z","steps":["trace[1095673768] 'range keys from in-memory index tree' (duration: 398.448254ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:31:04.939482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.383434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-08-21T02:31:04.939525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T02:31:04.540763Z","time spent":"398.754502ms","remote":"127.0.0.1:40206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-21T02:31:04.939553Z","caller":"traceutil/trace.go:171","msg":"trace[1409081058] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4698; }","duration":"409.499877ms","start":"2026-08-21T02:31:04.530036Z","end":"2026-08-21T02:31:04.939536Z","steps":["trace[1409081058] 'range keys from in-memory index tree' (duration: 409.192ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:31:04.939585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.155467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-08-21T02:31:04.939606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-21T02:31:04.530019Z","time spent":"409.577408ms","remote":"127.0.0.1:40486","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-08-21T02:31:04.939645Z","caller":"traceutil/trace.go:171","msg":"trace[1332722484] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4698; }","duration":"251.242609ms","start":"2026-08-21T02:31:04.688386Z","end":"2026-08-21T02:31:04.939629Z","steps":["trace[1332722484] 'range keys from in-memory index tree' (duration: 251.039404ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:31:08.78553Z","caller":"traceutil/trace.go:171","msg":"trace[1574265638] linearizableReadLoop","detail":"{readStateIndex:4917; appliedIndex:4916; }","duration":"137.427253ms","start":"2026-08-21T02:31:08.648081Z","end":"2026-08-21T02:31:08.785508Z","steps":["trace[1574265638] 'read index received' (duration: 137.260489ms)","trace[1574265638] 'applied index is now lower than readState.Index' (duration: 165.804µs)"],"step_count":2} {"level":"info","ts":"2026-08-21T02:31:08.785566Z","caller":"traceutil/trace.go:171","msg":"trace[345879047] transaction","detail":"{read_only:false; response_revision:4744; number_of_response:1; }","duration":"161.020202ms","start":"2026-08-21T02:31:08.624522Z","end":"2026-08-21T02:31:08.785542Z","steps":["trace[345879047] 'process raft request' (duration: 160.850878ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:31:08.785783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.688709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-08-21T02:31:08.785825Z","caller":"traceutil/trace.go:171","msg":"trace[1567626363] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4744; }","duration":"137.784822ms","start":"2026-08-21T02:31:08.648029Z","end":"2026-08-21T02:31:08.785813Z","steps":["trace[1567626363] 'agreement among raft nodes before linearized reading' (duration: 137.635248ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:31:08.785893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.767349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-64t7k.18cdb133cddc2246\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-08-21T02:31:08.785938Z","caller":"traceutil/trace.go:171","msg":"trace[1590930799] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-64t7k.18cdb133cddc2246; range_end:; response_count:1; response_revision:4744; }","duration":"136.904611ms","start":"2026-08-21T02:31:08.649018Z","end":"2026-08-21T02:31:08.785923Z","steps":["trace[1590930799] 'agreement among raft nodes before linearized reading' (duration: 136.680206ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:31:15.362669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.737675ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-21T02:31:15.362825Z","caller":"traceutil/trace.go:171","msg":"trace[1850372441] transaction","detail":"{read_only:false; response_revision:4805; number_of_response:1; }","duration":"211.861102ms","start":"2026-08-21T02:31:15.150945Z","end":"2026-08-21T02:31:15.362806Z","steps":["trace[1850372441] 'process raft request' (duration: 43.893622ms)","trace[1850372441] 'compare' (duration: 167.604811ms)"],"step_count":2} {"level":"info","ts":"2026-08-21T02:31:15.363016Z","caller":"traceutil/trace.go:171","msg":"trace[1630769700] linearizableReadLoop","detail":"{readStateIndex:4981; appliedIndex:4979; }","duration":"201.125246ms","start":"2026-08-21T02:31:15.161868Z","end":"2026-08-21T02:31:15.362993Z","steps":["trace[1630769700] 'read index received' (duration: 33.031433ms)","trace[1630769700] 'applied index is now lower than readState.Index' (duration: 168.092743ms)"],"step_count":2} {"level":"warn","ts":"2026-08-21T02:31:15.363293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.415672ms","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-08-21T02:31:15.363335Z","caller":"traceutil/trace.go:171","msg":"trace[940010073] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4806; }","duration":"201.493854ms","start":"2026-08-21T02:31:15.161829Z","end":"2026-08-21T02:31:15.363323Z","steps":["trace[940010073] 'agreement among raft nodes before linearized reading' (duration: 201.281219ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:31:15.364172Z","caller":"traceutil/trace.go:171","msg":"trace[1742449915] transaction","detail":"{read_only:false; response_revision:4806; number_of_response:1; }","duration":"211.378639ms","start":"2026-08-21T02:31:15.152763Z","end":"2026-08-21T02:31:15.364142Z","steps":["trace[1742449915] 'process raft request' (duration: 210.000119ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:31:15.58669Z","caller":"traceutil/trace.go:171","msg":"trace[252441163] transaction","detail":"{read_only:false; response_revision:4812; number_of_response:1; }","duration":"133.198498ms","start":"2026-08-21T02:31:15.453466Z","end":"2026-08-21T02:31:15.586664Z","steps":["trace[252441163] 'process raft request' (duration: 132.998453ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:31:15.586918Z","caller":"traceutil/trace.go:171","msg":"trace[145516277] transaction","detail":"{read_only:false; response_revision:4813; number_of_response:1; }","duration":"133.29857ms","start":"2026-08-21T02:31:15.453587Z","end":"2026-08-21T02:31:15.586885Z","steps":["trace[145516277] 'process raft request' (duration: 133.031824ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:31:46.368088Z","caller":"traceutil/trace.go:171","msg":"trace[440115159] linearizableReadLoop","detail":"{readStateIndex:5359; appliedIndex:5358; }","duration":"140.983274ms","start":"2026-08-21T02:31:46.227081Z","end":"2026-08-21T02:31:46.368064Z","steps":["trace[440115159] 'read index received' (duration: 140.80877ms)","trace[440115159] 'applied index is now lower than readState.Index' (duration: 173.084µs)"],"step_count":2} {"level":"info","ts":"2026-08-21T02:31:46.368189Z","caller":"traceutil/trace.go:171","msg":"trace[385562375] transaction","detail":"{read_only:false; response_revision:5174; number_of_response:1; }","duration":"141.63558ms","start":"2026-08-21T02:31:46.226531Z","end":"2026-08-21T02:31:46.368166Z","steps":["trace[385562375] 'process raft request' (duration: 141.369374ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:31:46.368412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.200009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:11717"} {"level":"info","ts":"2026-08-21T02:31:46.368477Z","caller":"traceutil/trace.go:171","msg":"trace[1773819135] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5174; }","duration":"141.401264ms","start":"2026-08-21T02:31:46.227057Z","end":"2026-08-21T02:31:46.368458Z","steps":["trace[1773819135] 'agreement among raft nodes before linearized reading' (duration: 141.110548ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:31:46.53449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.950411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-21T02:31:46.53457Z","caller":"traceutil/trace.go:171","msg":"trace[448627389] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5176; }","duration":"108.048204ms","start":"2026-08-21T02:31:46.4265Z","end":"2026-08-21T02:31:46.534548Z","steps":["trace[448627389] 'range keys from in-memory index tree' (duration: 107.90249ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:31:46.669431Z","caller":"traceutil/trace.go:171","msg":"trace[960000487] linearizableReadLoop","detail":"{readStateIndex:5362; appliedIndex:5361; }","duration":"128.49531ms","start":"2026-08-21T02:31:46.540912Z","end":"2026-08-21T02:31:46.669407Z","steps":["trace[960000487] 'read index received' (duration: 128.328096ms)","trace[960000487] 'applied index is now lower than readState.Index' (duration: 165.914µs)"],"step_count":2} {"level":"info","ts":"2026-08-21T02:31:46.669489Z","caller":"traceutil/trace.go:171","msg":"trace[741867461] transaction","detail":"{read_only:false; response_revision:5177; number_of_response:1; }","duration":"129.511332ms","start":"2026-08-21T02:31:46.53995Z","end":"2026-08-21T02:31:46.669461Z","steps":["trace[741867461] 'process raft request' (duration: 129.217305ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:31:46.669779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.850068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:11717"} {"level":"info","ts":"2026-08-21T02:31:46.670581Z","caller":"traceutil/trace.go:171","msg":"trace[107576283] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5177; }","duration":"129.600385ms","start":"2026-08-21T02:31:46.540891Z","end":"2026-08-21T02:31:46.670491Z","steps":["trace[107576283] 'agreement among raft nodes before linearized reading' (duration: 128.676903ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:31:46.827585Z","caller":"traceutil/trace.go:171","msg":"trace[1131196533] linearizableReadLoop","detail":"{readStateIndex:5363; appliedIndex:5362; }","duration":"157.505072ms","start":"2026-08-21T02:31:46.670053Z","end":"2026-08-21T02:31:46.827558Z","steps":["trace[1131196533] 'read index received' (duration: 157.302877ms)","trace[1131196533] 'applied index is now lower than readState.Index' (duration: 201.165µs)"],"step_count":2} {"level":"warn","ts":"2026-08-21T02:31:46.827756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.632835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-21T02:31:46.827729Z","caller":"traceutil/trace.go:171","msg":"trace[1500401907] transaction","detail":"{read_only:false; response_revision:5178; number_of_response:1; }","duration":"284.475696ms","start":"2026-08-21T02:31:46.543218Z","end":"2026-08-21T02:31:46.827693Z","steps":["trace[1500401907] 'process raft request' (duration: 284.19414ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:31:46.827794Z","caller":"traceutil/trace.go:171","msg":"trace[579966896] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:5178; }","duration":"225.690016ms","start":"2026-08-21T02:31:46.602093Z","end":"2026-08-21T02:31:46.827783Z","steps":["trace[579966896] 'agreement among raft nodes before linearized reading' (duration: 225.603964ms)"],"step_count":1} {"level":"warn","ts":"2026-08-21T02:31:46.828003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.01846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"} {"level":"info","ts":"2026-08-21T02:31:46.828036Z","caller":"traceutil/trace.go:171","msg":"trace[2138917437] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5178; }","duration":"143.087622ms","start":"2026-08-21T02:31:46.684938Z","end":"2026-08-21T02:31:46.828026Z","steps":["trace[2138917437] 'agreement among raft nodes before linearized reading' (duration: 142.947829ms)"],"step_count":1} {"level":"info","ts":"2026-08-21T02:32:45.497386Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2897} {"level":"info","ts":"2026-08-21T02:32:45.587025Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2897,"took":"87.832412ms","hash":900764267,"current-db-size-bytes":53293056,"current-db-size":"53 MB","current-db-size-in-use-bytes":29519872,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-21T02:32:45.587099Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":900764267,"revision":2897,"compact-revision":-1} {"level":"info","ts":"2026-08-21T02:37:45.501796Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5608} {"level":"info","ts":"2026-08-21T02:37:45.573229Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5608,"took":"70.211209ms","hash":899482256,"current-db-size-bytes":53293056,"current-db-size":"53 MB","current-db-size-in-use-bytes":18440192,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-21T02:37:45.573274Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":899482256,"revision":5608,"compact-revision":2897}