{"level":"warn","ts":"2026-02-19T03:54:21.561657Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-19T03:54:21.561757Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.49: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.49:2380","--initial-cluster=instance=https://162.253.55.49:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.49:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.49: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-02-19T03:54:21.561832Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-19T03:54:21.561845Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.49:2380"]} {"level":"info","ts":"2026-02-19T03:54:21.561864Z","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-02-19T03:54:21.562449Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.49:2379"]} {"level":"info","ts":"2026-02-19T03:54:21.562526Z","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.49:2380"],"listen-peer-urls":["https://162.253.55.49:2380"],"advertise-client-urls":["https://162.253.55.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.49: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-02-19T03:54:21.567629Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.866984ms"} {"level":"info","ts":"2026-02-19T03:54:21.578987Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6a9ba61e55fef5be","cluster-id":"9612db6e19ac6ce7"} {"level":"info","ts":"2026-02-19T03:54:21.579064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be switched to configuration voters=()"} {"level":"info","ts":"2026-02-19T03:54:21.579094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became follower at term 0"} {"level":"info","ts":"2026-02-19T03:54:21.579105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6a9ba61e55fef5be [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-19T03:54:21.57912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became follower at term 1"} {"level":"info","ts":"2026-02-19T03:54:21.57916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be switched to configuration voters=(7681916238632515006)"} {"level":"warn","ts":"2026-02-19T03:54:21.583615Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-19T03:54:21.585036Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-19T03:54:21.586327Z","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-02-19T03:54:21.588358Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6a9ba61e55fef5be","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-19T03:54:21.589173Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6a9ba61e55fef5be","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-19T03:54:21.58924Z","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-02-19T03:54:21.589387Z","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-02-19T03:54:21.58942Z","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-02-19T03:54:21.591098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be switched to configuration voters=(7681916238632515006)"} {"level":"info","ts":"2026-02-19T03:54:21.5913Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9612db6e19ac6ce7","local-member-id":"6a9ba61e55fef5be","added-peer-id":"6a9ba61e55fef5be","added-peer-peer-urls":["https://162.253.55.49:2380"]} {"level":"info","ts":"2026-02-19T03:54:21.594463Z","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-02-19T03:54:21.594609Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.49:2380"} {"level":"info","ts":"2026-02-19T03:54:21.594653Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.49:2380"} {"level":"info","ts":"2026-02-19T03:54:21.59479Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6a9ba61e55fef5be","initial-advertise-peer-urls":["https://162.253.55.49:2380"],"listen-peer-urls":["https://162.253.55.49:2380"],"advertise-client-urls":["https://162.253.55.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-19T03:54:21.594854Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-19T03:54:22.479828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be is starting a new election at term 1"} {"level":"info","ts":"2026-02-19T03:54:22.479934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became pre-candidate at term 1"} {"level":"info","ts":"2026-02-19T03:54:22.479973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be received MsgPreVoteResp from 6a9ba61e55fef5be at term 1"} {"level":"info","ts":"2026-02-19T03:54:22.479994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became candidate at term 2"} {"level":"info","ts":"2026-02-19T03:54:22.480006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be received MsgVoteResp from 6a9ba61e55fef5be at term 2"} {"level":"info","ts":"2026-02-19T03:54:22.480024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became leader at term 2"} {"level":"info","ts":"2026-02-19T03:54:22.480039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6a9ba61e55fef5be elected leader 6a9ba61e55fef5be at term 2"} {"level":"info","ts":"2026-02-19T03:54:22.481557Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T03:54:22.482567Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T03:54:22.482556Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6a9ba61e55fef5be","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.49:2379]}","request-path":"/0/members/6a9ba61e55fef5be/attributes","cluster-id":"9612db6e19ac6ce7","publish-timeout":"7s"} {"level":"info","ts":"2026-02-19T03:54:22.482598Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T03:54:22.482985Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-19T03:54:22.483084Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-19T03:54:22.483133Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9612db6e19ac6ce7","local-member-id":"6a9ba61e55fef5be","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T03:54:22.483295Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T03:54:22.483346Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T03:54:22.484535Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.49:2379"} {"level":"info","ts":"2026-02-19T03:54:22.486262Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-19T03:54:39.524575Z","caller":"traceutil/trace.go:171","msg":"trace[1131838811] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"220.40464ms","start":"2026-02-19T03:54:39.304096Z","end":"2026-02-19T03:54:39.524501Z","steps":["trace[1131838811] 'process raft request' (duration: 220.237187ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:54:49.781488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.632879ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T03:54:49.781817Z","caller":"traceutil/trace.go:171","msg":"trace[667840629] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"325.430236ms","start":"2026-02-19T03:54:49.456351Z","end":"2026-02-19T03:54:49.781781Z","steps":["trace[667840629] 'process raft request' (duration: 30.814205ms)","trace[667840629] 'compare' (duration: 293.485926ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:54:49.782027Z","caller":"traceutil/trace.go:171","msg":"trace[1147094218] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"317.935587ms","start":"2026-02-19T03:54:49.463967Z","end":"2026-02-19T03:54:49.781903Z","steps":["trace[1147094218] 'process raft request' (duration: 317.670302ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:54:49.782138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:54:49.456336Z","time spent":"325.61163ms","remote":"127.0.0.1:34878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4595,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T03:54:49.782354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:54:49.463951Z","time spent":"318.134681ms","remote":"127.0.0.1:34620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16637,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T03:54:49.805025Z","caller":"traceutil/trace.go:171","msg":"trace[1429591914] linearizableReadLoop","detail":"{readStateIndex:474; appliedIndex:471; }","duration":"240.05201ms","start":"2026-02-19T03:54:49.564941Z","end":"2026-02-19T03:54:49.804993Z","steps":["trace[1429591914] 'read index received' (duration: 80.372491ms)","trace[1429591914] 'applied index is now lower than readState.Index' (duration: 159.678439ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:54:49.805172Z","caller":"traceutil/trace.go:171","msg":"trace[41670556] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"304.89024ms","start":"2026-02-19T03:54:49.500198Z","end":"2026-02-19T03:54:49.805088Z","steps":["trace[41670556] 'process raft request' (duration: 303.898909ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:54:49.805296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.327255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-02-19T03:54:49.805344Z","caller":"traceutil/trace.go:171","msg":"trace[1070241603] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:456; }","duration":"240.445898ms","start":"2026-02-19T03:54:49.564885Z","end":"2026-02-19T03:54:49.805331Z","steps":["trace[1070241603] 'agreement among raft nodes before linearized reading' (duration: 240.244383ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:54:49.805353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:54:49.500163Z","time spent":"305.119285ms","remote":"127.0.0.1:34560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317263,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T03:54:49.807529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.4178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T03:54:49.808006Z","caller":"traceutil/trace.go:171","msg":"trace[1753198096] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:457; }","duration":"196.87214ms","start":"2026-02-19T03:54:49.611051Z","end":"2026-02-19T03:54:49.807923Z","steps":["trace[1753198096] 'agreement among raft nodes before linearized reading' (duration: 196.42789ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:54:49.808063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.023862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-02-19T03:54:49.808273Z","caller":"traceutil/trace.go:171","msg":"trace[316332069] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:457; }","duration":"243.241877ms","start":"2026-02-19T03:54:49.56498Z","end":"2026-02-19T03:54:49.808221Z","steps":["trace[316332069] 'agreement among raft nodes before linearized reading' (duration: 242.512482ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:54:49.809437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.475207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-19T03:54:49.809562Z","caller":"traceutil/trace.go:171","msg":"trace[1154931060] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:457; }","duration":"129.597069ms","start":"2026-02-19T03:54:49.679923Z","end":"2026-02-19T03:54:49.80952Z","steps":["trace[1154931060] 'agreement among raft nodes before linearized reading' (duration: 128.298781ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:54:50.303076Z","caller":"traceutil/trace.go:171","msg":"trace[204458845] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"127.179587ms","start":"2026-02-19T03:54:50.175867Z","end":"2026-02-19T03:54:50.303047Z","steps":["trace[204458845] 'process raft request' (duration: 127.018674ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:54:50.536121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.347609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-19T03:54:50.536218Z","caller":"traceutil/trace.go:171","msg":"trace[1623123624] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:460; }","duration":"102.514672ms","start":"2026-02-19T03:54:50.433679Z","end":"2026-02-19T03:54:50.536194Z","steps":["trace[1623123624] 'range keys from in-memory index tree' (duration: 102.161845ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:54:52.696935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.73635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-19T03:54:52.697067Z","caller":"traceutil/trace.go:171","msg":"trace[1659321422] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:467; }","duration":"147.927104ms","start":"2026-02-19T03:54:52.549115Z","end":"2026-02-19T03:54:52.697042Z","steps":["trace[1659321422] 'range keys from in-memory index tree' (duration: 147.609128ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:54:58.761983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.386104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T03:54:58.762445Z","caller":"traceutil/trace.go:171","msg":"trace[2059689519] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:507; }","duration":"150.913925ms","start":"2026-02-19T03:54:58.611508Z","end":"2026-02-19T03:54:58.762421Z","steps":["trace[2059689519] 'range keys from in-memory index tree' (duration: 150.249351ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:54:59.19729Z","caller":"traceutil/trace.go:171","msg":"trace[811516912] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"221.30264ms","start":"2026-02-19T03:54:58.975962Z","end":"2026-02-19T03:54:59.197265Z","steps":["trace[811516912] 'process raft request' (duration: 221.139767ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:54:59.343779Z","caller":"traceutil/trace.go:171","msg":"trace[663915963] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"105.999046ms","start":"2026-02-19T03:54:59.237739Z","end":"2026-02-19T03:54:59.343738Z","steps":["trace[663915963] 'process raft request' (duration: 94.562725ms)","trace[663915963] 'compare' (duration: 11.168986ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T03:55:00.261851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.271074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-19T03:55:00.261945Z","caller":"traceutil/trace.go:171","msg":"trace[1590740248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:510; }","duration":"402.419437ms","start":"2026-02-19T03:54:59.859501Z","end":"2026-02-19T03:55:00.261921Z","steps":["trace[1590740248] 'range keys from in-memory index tree' (duration: 402.04689ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:00.261999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:54:59.859478Z","time spent":"402.506989ms","remote":"127.0.0.1:34686","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-02-19T03:55:00.262049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"812.668403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/cert-manager/\" range_end:\"/registry/resourcequotas/cert-manager0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T03:55:00.262106Z","caller":"traceutil/trace.go:171","msg":"trace[814442374] range","detail":"{range_begin:/registry/resourcequotas/cert-manager/; range_end:/registry/resourcequotas/cert-manager0; response_count:0; response_revision:510; }","duration":"812.791895ms","start":"2026-02-19T03:54:59.449299Z","end":"2026-02-19T03:55:00.262091Z","steps":["trace[814442374] 'range keys from in-memory index tree' (duration: 812.583401ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:00.262138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:54:59.449278Z","time spent":"812.851447ms","remote":"127.0.0.1:34548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/cert-manager/\" range_end:\"/registry/resourcequotas/cert-manager0\" "} {"level":"warn","ts":"2026-02-19T03:55:00.262114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.359107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T03:55:00.262197Z","caller":"traceutil/trace.go:171","msg":"trace[94063923] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:510; }","duration":"650.49561ms","start":"2026-02-19T03:54:59.61168Z","end":"2026-02-19T03:55:00.262176Z","steps":["trace[94063923] 'range keys from in-memory index tree' (duration: 650.158592ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:00.262242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:54:59.611657Z","time spent":"650.575881ms","remote":"127.0.0.1:34470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-19T03:55:00.415209Z","caller":"traceutil/trace.go:171","msg":"trace[1039926561] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"151.177771ms","start":"2026-02-19T03:55:00.264005Z","end":"2026-02-19T03:55:00.415183Z","steps":["trace[1039926561] 'process raft request' (duration: 151.038047ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:00.430289Z","caller":"traceutil/trace.go:171","msg":"trace[1644661971] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"164.147423ms","start":"2026-02-19T03:55:00.266108Z","end":"2026-02-19T03:55:00.430256Z","steps":["trace[1644661971] 'process raft request' (duration: 163.950009ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:00.758701Z","caller":"traceutil/trace.go:171","msg":"trace[1238350774] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"142.830112ms","start":"2026-02-19T03:55:00.615835Z","end":"2026-02-19T03:55:00.758666Z","steps":["trace[1238350774] 'process raft request' (duration: 68.363415ms)","trace[1238350774] 'compare' (duration: 73.958417ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:55:00.758769Z","caller":"traceutil/trace.go:171","msg":"trace[1477255516] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"141.955044ms","start":"2026-02-19T03:55:00.616792Z","end":"2026-02-19T03:55:00.758747Z","steps":["trace[1477255516] 'process raft request' (duration: 141.614818ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:00.758923Z","caller":"traceutil/trace.go:171","msg":"trace[1802535573] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"138.456243ms","start":"2026-02-19T03:55:00.620453Z","end":"2026-02-19T03:55:00.758909Z","steps":["trace[1802535573] 'process raft request' (duration: 138.084965ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:00.759156Z","caller":"traceutil/trace.go:171","msg":"trace[1948262437] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"137.242938ms","start":"2026-02-19T03:55:00.6219Z","end":"2026-02-19T03:55:00.759143Z","steps":["trace[1948262437] 'process raft request' (duration: 136.855941ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:00.971651Z","caller":"traceutil/trace.go:171","msg":"trace[2080155022] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"154.437717ms","start":"2026-02-19T03:55:00.817175Z","end":"2026-02-19T03:55:00.971612Z","steps":["trace[2080155022] 'process raft request' (duration: 112.669561ms)","trace[2080155022] 'compare' (duration: 41.559212ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:55:00.975878Z","caller":"traceutil/trace.go:171","msg":"trace[1912001775] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"130.756388ms","start":"2026-02-19T03:55:00.845082Z","end":"2026-02-19T03:55:00.975838Z","steps":["trace[1912001775] 'process raft request' (duration: 130.522123ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:00.976026Z","caller":"traceutil/trace.go:171","msg":"trace[1474609041] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"129.933621ms","start":"2026-02-19T03:55:00.846052Z","end":"2026-02-19T03:55:00.975985Z","steps":["trace[1474609041] 'process raft request' (duration: 129.692846ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:00.97631Z","caller":"traceutil/trace.go:171","msg":"trace[1632457986] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"130.038764ms","start":"2026-02-19T03:55:00.846236Z","end":"2026-02-19T03:55:00.976275Z","steps":["trace[1632457986] 'process raft request' (duration: 129.680057ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:00.976653Z","caller":"traceutil/trace.go:171","msg":"trace[679507148] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:592; }","duration":"105.933905ms","start":"2026-02-19T03:55:00.870696Z","end":"2026-02-19T03:55:00.97663Z","steps":["trace[679507148] 'read index received' (duration: 59.150707ms)","trace[679507148] 'applied index is now lower than readState.Index' (duration: 46.781778ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T03:55:00.976793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.045898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T03:55:00.97685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.127438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T03:55:00.976883Z","caller":"traceutil/trace.go:171","msg":"trace[1879351187] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:577; }","duration":"106.21015ms","start":"2026-02-19T03:55:00.870649Z","end":"2026-02-19T03:55:00.97686Z","steps":["trace[1879351187] 'agreement among raft nodes before linearized reading' (duration: 106.007216ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:00.976903Z","caller":"traceutil/trace.go:171","msg":"trace[77693230] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:577; }","duration":"106.227311ms","start":"2026-02-19T03:55:00.870659Z","end":"2026-02-19T03:55:00.976886Z","steps":["trace[77693230] 'agreement among raft nodes before linearized reading' (duration: 106.062228ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:00.976663Z","caller":"traceutil/trace.go:171","msg":"trace[763471741] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"130.310029ms","start":"2026-02-19T03:55:00.846332Z","end":"2026-02-19T03:55:00.976642Z","steps":["trace[763471741] 'process raft request' (duration: 129.892161ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:00.99233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.45427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T03:55:00.992411Z","caller":"traceutil/trace.go:171","msg":"trace[1791285601] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:578; }","duration":"121.572762ms","start":"2026-02-19T03:55:00.870819Z","end":"2026-02-19T03:55:00.992392Z","steps":["trace[1791285601] 'agreement among raft nodes before linearized reading' (duration: 121.405268ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:00.992694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.490817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T03:55:00.992738Z","caller":"traceutil/trace.go:171","msg":"trace[1297986549] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:578; }","duration":"107.547718ms","start":"2026-02-19T03:55:00.885178Z","end":"2026-02-19T03:55:00.992725Z","steps":["trace[1297986549] 'agreement among raft nodes before linearized reading' (duration: 107.488866ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:00.992926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.262881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T03:55:00.992985Z","caller":"traceutil/trace.go:171","msg":"trace[1829249791] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:578; }","duration":"108.302302ms","start":"2026-02-19T03:55:00.884651Z","end":"2026-02-19T03:55:00.992954Z","steps":["trace[1829249791] 'agreement among raft nodes before linearized reading' (duration: 108.249121ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:00.99322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.816953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T03:55:00.993551Z","caller":"traceutil/trace.go:171","msg":"trace[313200316] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:578; }","duration":"109.17797ms","start":"2026-02-19T03:55:00.884359Z","end":"2026-02-19T03:55:00.993537Z","steps":["trace[313200316] 'agreement among raft nodes before linearized reading' (duration: 108.68842ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:01.182283Z","caller":"traceutil/trace.go:171","msg":"trace[821405353] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"112.741772ms","start":"2026-02-19T03:55:01.069513Z","end":"2026-02-19T03:55:01.182254Z","steps":["trace[821405353] 'process raft request' (duration: 112.685361ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:01.182427Z","caller":"traceutil/trace.go:171","msg":"trace[1487165592] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"114.060509ms","start":"2026-02-19T03:55:01.068326Z","end":"2026-02-19T03:55:01.182387Z","steps":["trace[1487165592] 'process raft request' (duration: 113.692151ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:01.182321Z","caller":"traceutil/trace.go:171","msg":"trace[146512011] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"113.283843ms","start":"2026-02-19T03:55:01.069003Z","end":"2026-02-19T03:55:01.182287Z","steps":["trace[146512011] 'process raft request' (duration: 113.16168ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:01.517929Z","caller":"traceutil/trace.go:171","msg":"trace[1108738178] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:635; }","duration":"214.336799ms","start":"2026-02-19T03:55:01.303556Z","end":"2026-02-19T03:55:01.517893Z","steps":["trace[1108738178] 'read index received' (duration: 214.179495ms)","trace[1108738178] 'applied index is now lower than readState.Index' (duration: 156.154µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:55:01.517972Z","caller":"traceutil/trace.go:171","msg":"trace[1801010717] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"222.424762ms","start":"2026-02-19T03:55:01.295512Z","end":"2026-02-19T03:55:01.517937Z","steps":["trace[1801010717] 'process raft request' (duration: 222.32208ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:01.517972Z","caller":"traceutil/trace.go:171","msg":"trace[825121014] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"222.78674ms","start":"2026-02-19T03:55:01.295146Z","end":"2026-02-19T03:55:01.517933Z","steps":["trace[825121014] 'process raft request' (duration: 222.429563ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:01.518277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.850802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/cert-manager/cert-manager-cainjector-6447d7755c\" ","response":"range_response_count:1 size:3544"} {"level":"info","ts":"2026-02-19T03:55:01.518384Z","caller":"traceutil/trace.go:171","msg":"trace[2128088582] range","detail":"{range_begin:/registry/replicasets/cert-manager/cert-manager-cainjector-6447d7755c; range_end:; response_count:1; response_revision:616; }","duration":"223.991025ms","start":"2026-02-19T03:55:01.294366Z","end":"2026-02-19T03:55:01.518357Z","steps":["trace[2128088582] 'agreement among raft nodes before linearized reading' (duration: 223.657838ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:01.67411Z","caller":"traceutil/trace.go:171","msg":"trace[1600909765] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"366.52483ms","start":"2026-02-19T03:55:01.307547Z","end":"2026-02-19T03:55:01.674072Z","steps":["trace[1600909765] 'process raft request' (duration: 366.273465ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:01.674164Z","caller":"traceutil/trace.go:171","msg":"trace[1063713518] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"364.471988ms","start":"2026-02-19T03:55:01.309649Z","end":"2026-02-19T03:55:01.674121Z","steps":["trace[1063713518] 'process raft request' (duration: 364.311285ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:01.674261Z","caller":"traceutil/trace.go:171","msg":"trace[1598129148] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"364.371286ms","start":"2026-02-19T03:55:01.309855Z","end":"2026-02-19T03:55:01.674226Z","steps":["trace[1598129148] 'process raft request' (duration: 364.168622ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:01.674402Z","caller":"traceutil/trace.go:171","msg":"trace[278027645] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"363.598741ms","start":"2026-02-19T03:55:01.310777Z","end":"2026-02-19T03:55:01.674375Z","steps":["trace[278027645] 'process raft request' (duration: 363.288425ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:01.674407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:55:01.309848Z","time spent":"364.491419ms","remote":"127.0.0.1:34878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4952,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T03:55:01.674408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:55:01.30964Z","time spent":"364.620992ms","remote":"127.0.0.1:34620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T03:55:01.674494Z","caller":"traceutil/trace.go:171","msg":"trace[1761635879] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"297.85245ms","start":"2026-02-19T03:55:01.376631Z","end":"2026-02-19T03:55:01.674484Z","steps":["trace[1761635879] 'process raft request' (duration: 297.512453ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:01.674513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:55:01.310769Z","time spent":"363.682453ms","remote":"127.0.0.1:34878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4665,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T03:55:01.674902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:55:01.307516Z","time spent":"366.692704ms","remote":"127.0.0.1:34536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":872,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-19T03:55:01.79544Z","caller":"traceutil/trace.go:171","msg":"trace[1027285808] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"270.985096ms","start":"2026-02-19T03:55:01.524418Z","end":"2026-02-19T03:55:01.795403Z","steps":["trace[1027285808] 'process raft request' (duration: 269.987637ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:01.795482Z","caller":"traceutil/trace.go:171","msg":"trace[481067056] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:637; }","duration":"184.071696ms","start":"2026-02-19T03:55:01.611345Z","end":"2026-02-19T03:55:01.795417Z","steps":["trace[481067056] 'read index received' (duration: 62.474364ms)","trace[481067056] 'applied index is now lower than readState.Index' (duration: 121.591602ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:55:01.795737Z","caller":"traceutil/trace.go:171","msg":"trace[1841730384] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"105.564986ms","start":"2026-02-19T03:55:01.690159Z","end":"2026-02-19T03:55:01.795724Z","steps":["trace[1841730384] 'process raft request' (duration: 105.144667ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:01.79594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.557376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T03:55:01.796072Z","caller":"traceutil/trace.go:171","msg":"trace[120392651] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"184.76214ms","start":"2026-02-19T03:55:01.611285Z","end":"2026-02-19T03:55:01.796047Z","steps":["trace[120392651] 'agreement among raft nodes before linearized reading' (duration: 184.23992ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:02.128991Z","caller":"traceutil/trace.go:171","msg":"trace[1925267152] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"143.015145ms","start":"2026-02-19T03:55:01.985921Z","end":"2026-02-19T03:55:02.128936Z","steps":["trace[1925267152] 'process raft request' (duration: 142.714249ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:02.45683Z","caller":"traceutil/trace.go:171","msg":"trace[643630439] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"112.761942ms","start":"2026-02-19T03:55:02.344027Z","end":"2026-02-19T03:55:02.456789Z","steps":["trace[643630439] 'process raft request' (duration: 106.038377ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:05.74174Z","caller":"traceutil/trace.go:171","msg":"trace[1705657082] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"100.953584ms","start":"2026-02-19T03:55:05.640744Z","end":"2026-02-19T03:55:05.741697Z","steps":["trace[1705657082] 'process raft request' (duration: 100.77786ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:06.72375Z","caller":"traceutil/trace.go:171","msg":"trace[1606046139] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"169.673344ms","start":"2026-02-19T03:55:06.554044Z","end":"2026-02-19T03:55:06.723717Z","steps":["trace[1606046139] 'process raft request' (duration: 153.547509ms)","trace[1606046139] 'compare' (duration: 15.944262ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:55:06.723867Z","caller":"traceutil/trace.go:171","msg":"trace[1076248101] linearizableReadLoop","detail":"{readStateIndex:722; appliedIndex:721; }","duration":"150.65725ms","start":"2026-02-19T03:55:06.573165Z","end":"2026-02-19T03:55:06.723822Z","steps":["trace[1076248101] 'read index received' (duration: 134.536154ms)","trace[1076248101] 'applied index is now lower than readState.Index' (duration: 16.117465ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:55:06.723919Z","caller":"traceutil/trace.go:171","msg":"trace[15190391] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"133.809489ms","start":"2026-02-19T03:55:06.590077Z","end":"2026-02-19T03:55:06.723887Z","steps":["trace[15190391] 'process raft request' (duration: 133.731236ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:06.72417Z","caller":"traceutil/trace.go:171","msg":"trace[1301750258] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"144.576347ms","start":"2026-02-19T03:55:06.579543Z","end":"2026-02-19T03:55:06.724119Z","steps":["trace[1301750258] 'process raft request' (duration: 144.182079ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:06.724242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.01465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-19T03:55:06.724293Z","caller":"traceutil/trace.go:171","msg":"trace[361389328] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:702; }","duration":"200.109702ms","start":"2026-02-19T03:55:06.524167Z","end":"2026-02-19T03:55:06.724276Z","steps":["trace[361389328] 'agreement among raft nodes before linearized reading' (duration: 199.829876ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:06.724279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.909277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T03:55:06.725389Z","caller":"traceutil/trace.go:171","msg":"trace[1258288389] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:702; }","duration":"113.700902ms","start":"2026-02-19T03:55:06.611289Z","end":"2026-02-19T03:55:06.72499Z","steps":["trace[1258288389] 'agreement among raft nodes before linearized reading' (duration: 112.885696ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:08.04472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.292307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-02-19T03:55:08.044822Z","caller":"traceutil/trace.go:171","msg":"trace[68202304] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:717; }","duration":"168.46869ms","start":"2026-02-19T03:55:07.876332Z","end":"2026-02-19T03:55:08.044801Z","steps":["trace[68202304] 'range keys from in-memory index tree' (duration: 168.059862ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:09.962789Z","caller":"traceutil/trace.go:171","msg":"trace[308161469] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"171.129775ms","start":"2026-02-19T03:55:09.791632Z","end":"2026-02-19T03:55:09.962762Z","steps":["trace[308161469] 'process raft request' (duration: 170.9181ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:55:09.968941Z","caller":"traceutil/trace.go:171","msg":"trace[611488064] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"161.644803ms","start":"2026-02-19T03:55:09.807271Z","end":"2026-02-19T03:55:09.968916Z","steps":["trace[611488064] 'process raft request' (duration: 161.535131ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:22.072503Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762807045624314,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T03:55:22.444108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.586097ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T03:55:22.444204Z","caller":"traceutil/trace.go:171","msg":"trace[2111389233] linearizableReadLoop","detail":"{readStateIndex:923; appliedIndex:922; }","duration":"872.000843ms","start":"2026-02-19T03:55:21.572189Z","end":"2026-02-19T03:55:22.44419Z","steps":["trace[2111389233] 'read index received' (duration: 683.879385ms)","trace[2111389233] 'applied index is now lower than readState.Index' (duration: 188.120528ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:55:22.444246Z","caller":"traceutil/trace.go:171","msg":"trace[1074482071] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"979.461357ms","start":"2026-02-19T03:55:21.46475Z","end":"2026-02-19T03:55:22.444211Z","steps":["trace[1074482071] 'process raft request' (duration: 791.36909ms)","trace[1074482071] 'compare' (duration: 187.424884ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T03:55:22.444282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.629487ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T03:55:22.444411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.212627ms","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-02-19T03:55:22.444429Z","caller":"traceutil/trace.go:171","msg":"trace[225331463] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:896; }","duration":"389.232389ms","start":"2026-02-19T03:55:22.055175Z","end":"2026-02-19T03:55:22.444408Z","steps":["trace[225331463] 'range keys from in-memory index tree' (duration: 388.538775ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:22.444424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:55:21.464714Z","time spent":"979.60823ms","remote":"127.0.0.1:34878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3853,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T03:55:22.444428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.038744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T03:55:22.444475Z","caller":"traceutil/trace.go:171","msg":"trace[1057509301] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:897; }","duration":"872.325259ms","start":"2026-02-19T03:55:21.572134Z","end":"2026-02-19T03:55:22.44446Z","steps":["trace[1057509301] 'agreement among raft nodes before linearized reading' (duration: 872.153186ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:22.444512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:55:21.572096Z","time spent":"872.408791ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-19T03:55:22.444514Z","caller":"traceutil/trace.go:171","msg":"trace[214681647] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:897; }","duration":"833.163436ms","start":"2026-02-19T03:55:21.611329Z","end":"2026-02-19T03:55:22.444492Z","steps":["trace[214681647] 'agreement among raft nodes before linearized reading' (duration: 833.015503ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:22.444559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:55:21.611307Z","time spent":"833.242348ms","remote":"127.0.0.1:34470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-19T03:55:22.444862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.233066ms","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-02-19T03:55:22.444985Z","caller":"traceutil/trace.go:171","msg":"trace[972834364] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:897; }","duration":"417.490932ms","start":"2026-02-19T03:55:22.027454Z","end":"2026-02-19T03:55:22.444945Z","steps":["trace[972834364] 'agreement among raft nodes before linearized reading' (duration: 416.927001ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:55:22.445042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:55:22.027432Z","time spent":"417.595793ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-19T03:55:43.935731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.275425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-19T03:55:43.935858Z","caller":"traceutil/trace.go:171","msg":"trace[553246383] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1050; }","duration":"117.508319ms","start":"2026-02-19T03:55:43.818322Z","end":"2026-02-19T03:55:43.93583Z","steps":["trace[553246383] 'count revisions from in-memory index tree' (duration: 117.117971ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:56:14.817171Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762807045625687,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-19T03:56:14.861645Z","caller":"traceutil/trace.go:171","msg":"trace[1720849447] transaction","detail":"{read_only:false; response_revision:1570; number_of_response:1; }","duration":"554.022772ms","start":"2026-02-19T03:56:14.307583Z","end":"2026-02-19T03:56:14.861606Z","steps":["trace[1720849447] 'process raft request' (duration: 553.680574ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:56:14.861933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:56:14.307557Z","time spent":"554.229956ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T03:56:14.907413Z","caller":"traceutil/trace.go:171","msg":"trace[950593428] linearizableReadLoop","detail":"{readStateIndex:1634; appliedIndex:1632; }","duration":"590.961558ms","start":"2026-02-19T03:56:14.316421Z","end":"2026-02-19T03:56:14.907382Z","steps":["trace[950593428] 'read index received' (duration: 544.811843ms)","trace[950593428] 'applied index is now lower than readState.Index' (duration: 46.148325ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:56:14.907495Z","caller":"traceutil/trace.go:171","msg":"trace[1270408335] transaction","detail":"{read_only:false; response_revision:1571; number_of_response:1; }","duration":"391.505698ms","start":"2026-02-19T03:56:14.515944Z","end":"2026-02-19T03:56:14.90745Z","steps":["trace[1270408335] 'process raft request' (duration: 391.264693ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:56:14.907645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.171162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-19T03:56:14.907723Z","caller":"traceutil/trace.go:171","msg":"trace[1019517044] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1571; }","duration":"591.325924ms","start":"2026-02-19T03:56:14.316379Z","end":"2026-02-19T03:56:14.907705Z","steps":["trace[1019517044] 'agreement among raft nodes before linearized reading' (duration: 591.153721ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:56:14.907748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:56:14.515918Z","time spent":"391.681461ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T03:56:14.90779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:56:14.31636Z","time spent":"591.412497ms","remote":"127.0.0.1:34858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-02-19T03:56:14.90787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.148375ms","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-02-19T03:56:14.908321Z","caller":"traceutil/trace.go:171","msg":"trace[1528634179] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1571; }","duration":"116.656225ms","start":"2026-02-19T03:56:14.791638Z","end":"2026-02-19T03:56:14.908295Z","steps":["trace[1528634179] 'agreement among raft nodes before linearized reading' (duration: 116.046603ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:56:14.907935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.481069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c63911d0-0a95-457e-add5-468027614e17\" ","response":"range_response_count:1 size:3582"} {"level":"info","ts":"2026-02-19T03:56:14.908445Z","caller":"traceutil/trace.go:171","msg":"trace[1515528775] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c63911d0-0a95-457e-add5-468027614e17; range_end:; response_count:1; response_revision:1571; }","duration":"264.011089ms","start":"2026-02-19T03:56:14.64439Z","end":"2026-02-19T03:56:14.908401Z","steps":["trace[1515528775] 'agreement among raft nodes before linearized reading' (duration: 263.290165ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:56:14.90845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.625316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5324"} {"level":"warn","ts":"2026-02-19T03:56:14.907868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.627066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T03:56:14.908606Z","caller":"traceutil/trace.go:171","msg":"trace[1528750761] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1571; }","duration":"273.85846ms","start":"2026-02-19T03:56:14.634711Z","end":"2026-02-19T03:56:14.90857Z","steps":["trace[1528750761] 'agreement among raft nodes before linearized reading' (duration: 273.070615ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:56:14.908702Z","caller":"traceutil/trace.go:171","msg":"trace[1556381234] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1571; }","duration":"295.497434ms","start":"2026-02-19T03:56:14.61314Z","end":"2026-02-19T03:56:14.908637Z","steps":["trace[1556381234] 'agreement among raft nodes before linearized reading' (duration: 294.521814ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:56:15.501366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.016613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c63911d0-0a95-457e-add5-468027614e17\" ","response":"range_response_count:1 size:3686"} {"level":"warn","ts":"2026-02-19T03:56:15.501452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.018691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-02-19T03:56:15.501452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.057158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-19T03:56:15.501534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.010064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.189589a56f3c1f57\" ","response":"range_response_count:1 size:982"} {"level":"info","ts":"2026-02-19T03:56:15.501543Z","caller":"traceutil/trace.go:171","msg":"trace[417686668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1575; }","duration":"289.186815ms","start":"2026-02-19T03:56:15.212333Z","end":"2026-02-19T03:56:15.50152Z","steps":["trace[417686668] 'range keys from in-memory index tree' (duration: 288.747676ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:56:15.50149Z","caller":"traceutil/trace.go:171","msg":"trace[496843585] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c63911d0-0a95-457e-add5-468027614e17; range_end:; response_count:1; response_revision:1575; }","duration":"382.238108ms","start":"2026-02-19T03:56:15.119227Z","end":"2026-02-19T03:56:15.501465Z","steps":["trace[496843585] 'range keys from in-memory index tree' (duration: 381.794448ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:56:15.501606Z","caller":"traceutil/trace.go:171","msg":"trace[294713675] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.189589a56f3c1f57; range_end:; response_count:1; response_revision:1575; }","duration":"273.115266ms","start":"2026-02-19T03:56:15.228466Z","end":"2026-02-19T03:56:15.501581Z","steps":["trace[294713675] 'range keys from in-memory index tree' (duration: 272.864301ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:56:15.501589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.190873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-19T03:56:15.501691Z","caller":"traceutil/trace.go:171","msg":"trace[1896672640] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1575; }","duration":"131.362007ms","start":"2026-02-19T03:56:15.370304Z","end":"2026-02-19T03:56:15.501666Z","steps":["trace[1896672640] 'range keys from in-memory index tree' (duration: 130.954939ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:56:15.501551Z","caller":"traceutil/trace.go:171","msg":"trace[947500183] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:1575; }","duration":"213.208841ms","start":"2026-02-19T03:56:15.288324Z","end":"2026-02-19T03:56:15.501533Z","steps":["trace[947500183] 'count revisions from in-memory index tree' (duration: 212.988716ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:56:15.501606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:56:15.11919Z","time spent":"382.404971ms","remote":"127.0.0.1:34620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3709,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c63911d0-0a95-457e-add5-468027614e17\" "} {"level":"warn","ts":"2026-02-19T03:56:15.501371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.513251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-19T03:56:15.501923Z","caller":"traceutil/trace.go:171","msg":"trace[2134048149] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1575; }","duration":"289.179775ms","start":"2026-02-19T03:56:15.212724Z","end":"2026-02-19T03:56:15.501903Z","steps":["trace[2134048149] 'range keys from in-memory index tree' (duration: 288.222475ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:56:15.670709Z","caller":"traceutil/trace.go:171","msg":"trace[2014553506] transaction","detail":"{read_only:false; response_revision:1576; number_of_response:1; }","duration":"165.535945ms","start":"2026-02-19T03:56:15.505131Z","end":"2026-02-19T03:56:15.670667Z","steps":["trace[2014553506] 'process raft request' (duration: 117.808009ms)","trace[2014553506] 'compare' (duration: 47.39751ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:56:15.670736Z","caller":"traceutil/trace.go:171","msg":"trace[1686287440] transaction","detail":"{read_only:false; response_revision:1577; number_of_response:1; }","duration":"165.512165ms","start":"2026-02-19T03:56:15.505195Z","end":"2026-02-19T03:56:15.670707Z","steps":["trace[1686287440] 'process raft request' (duration: 165.340792ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:56:15.670947Z","caller":"traceutil/trace.go:171","msg":"trace[1291453115] transaction","detail":"{read_only:false; response_revision:1579; number_of_response:1; }","duration":"165.134116ms","start":"2026-02-19T03:56:15.505792Z","end":"2026-02-19T03:56:15.670926Z","steps":["trace[1291453115] 'process raft request' (duration: 165.014124ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:56:15.670941Z","caller":"traceutil/trace.go:171","msg":"trace[1659627070] transaction","detail":"{read_only:false; response_revision:1578; number_of_response:1; }","duration":"165.221849ms","start":"2026-02-19T03:56:15.505683Z","end":"2026-02-19T03:56:15.670904Z","steps":["trace[1659627070] 'process raft request' (duration: 164.978644ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:56:15.67119Z","caller":"traceutil/trace.go:171","msg":"trace[389897079] transaction","detail":"{read_only:false; response_revision:1580; number_of_response:1; }","duration":"139.964702ms","start":"2026-02-19T03:56:15.531213Z","end":"2026-02-19T03:56:15.671178Z","steps":["trace[389897079] 'process raft request' (duration: 139.660315ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:56:17.111157Z","caller":"traceutil/trace.go:171","msg":"trace[431763494] linearizableReadLoop","detail":"{readStateIndex:1655; appliedIndex:1654; }","duration":"104.362195ms","start":"2026-02-19T03:56:17.006765Z","end":"2026-02-19T03:56:17.111127Z","steps":["trace[431763494] 'read index received' (duration: 15.09567ms)","trace[431763494] 'applied index is now lower than readState.Index' (duration: 89.264925ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T03:56:17.111423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.635761ms","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-02-19T03:56:17.111462Z","caller":"traceutil/trace.go:171","msg":"trace[391693492] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1591; }","duration":"104.740483ms","start":"2026-02-19T03:56:17.006711Z","end":"2026-02-19T03:56:17.111451Z","steps":["trace[391693492] 'agreement among raft nodes before linearized reading' (duration: 104.520329ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:56:17.11149Z","caller":"traceutil/trace.go:171","msg":"trace[428393655] transaction","detail":"{read_only:false; response_revision:1591; number_of_response:1; }","duration":"118.730729ms","start":"2026-02-19T03:56:16.99272Z","end":"2026-02-19T03:56:17.111451Z","steps":["trace[428393655] 'process raft request' (duration: 29.242849ms)","trace[428393655] 'compare' (duration: 88.850616ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:56:21.389942Z","caller":"traceutil/trace.go:171","msg":"trace[7121178] transaction","detail":"{read_only:false; response_revision:1629; number_of_response:1; }","duration":"233.991186ms","start":"2026-02-19T03:56:21.155924Z","end":"2026-02-19T03:56:21.389916Z","steps":["trace[7121178] 'process raft request' (duration: 233.826593ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:56:27.030833Z","caller":"traceutil/trace.go:171","msg":"trace[1277141793] transaction","detail":"{read_only:false; response_revision:1669; number_of_response:1; }","duration":"132.109213ms","start":"2026-02-19T03:56:26.898696Z","end":"2026-02-19T03:56:27.030805Z","steps":["trace[1277141793] 'process raft request' (duration: 88.408078ms)","trace[1277141793] 'compare' (duration: 43.592373ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:56:27.108932Z","caller":"traceutil/trace.go:171","msg":"trace[717567974] linearizableReadLoop","detail":"{readStateIndex:1737; appliedIndex:1735; }","duration":"135.625664ms","start":"2026-02-19T03:56:26.973259Z","end":"2026-02-19T03:56:27.108885Z","steps":["trace[717567974] 'read index received' (duration: 13.829963ms)","trace[717567974] 'applied index is now lower than readState.Index' (duration: 121.794631ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:56:27.109051Z","caller":"traceutil/trace.go:171","msg":"trace[1480236487] transaction","detail":"{read_only:false; response_revision:1670; number_of_response:1; }","duration":"165.805191ms","start":"2026-02-19T03:56:26.94322Z","end":"2026-02-19T03:56:27.109025Z","steps":["trace[1480236487] 'process raft request' (duration: 165.505465ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:56:27.109198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.921871ms","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-02-19T03:56:27.109244Z","caller":"traceutil/trace.go:171","msg":"trace[1391828972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1670; }","duration":"136.023763ms","start":"2026-02-19T03:56:26.973209Z","end":"2026-02-19T03:56:27.109232Z","steps":["trace[1391828972] 'agreement among raft nodes before linearized reading' (duration: 135.85966ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:56:27.109309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.492543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5324"} {"level":"info","ts":"2026-02-19T03:56:27.1094Z","caller":"traceutil/trace.go:171","msg":"trace[1286012638] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1670; }","duration":"116.635836ms","start":"2026-02-19T03:56:26.992746Z","end":"2026-02-19T03:56:27.109382Z","steps":["trace[1286012638] 'agreement among raft nodes before linearized reading' (duration: 116.368621ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:56:27.243574Z","caller":"traceutil/trace.go:171","msg":"trace[894108175] transaction","detail":"{read_only:false; response_revision:1671; number_of_response:1; }","duration":"127.461968ms","start":"2026-02-19T03:56:27.116068Z","end":"2026-02-19T03:56:27.24353Z","steps":["trace[894108175] 'process raft request' (duration: 115.265898ms)","trace[894108175] 'compare' (duration: 12.027015ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T03:56:27.598097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.080908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11829"} {"level":"info","ts":"2026-02-19T03:56:27.598192Z","caller":"traceutil/trace.go:171","msg":"trace[70051665] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1672; }","duration":"123.69186ms","start":"2026-02-19T03:56:27.474478Z","end":"2026-02-19T03:56:27.59817Z","steps":["trace[70051665] 'range keys from in-memory index tree' (duration: 122.806892ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:56:31.389948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.672187ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-19T03:56:31.391086Z","caller":"traceutil/trace.go:171","msg":"trace[1851886462] transaction","detail":"{read_only:false; response_revision:1701; number_of_response:1; }","duration":"264.726985ms","start":"2026-02-19T03:56:31.125735Z","end":"2026-02-19T03:56:31.390462Z","steps":["trace[1851886462] 'process raft request' (duration: 264.570562ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:56:31.390465Z","caller":"traceutil/trace.go:171","msg":"trace[246526442] transaction","detail":"{read_only:false; response_revision:1700; number_of_response:1; }","duration":"342.899334ms","start":"2026-02-19T03:56:31.047544Z","end":"2026-02-19T03:56:31.390443Z","steps":["trace[246526442] 'process raft request' (duration: 342.554267ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:56:31.391464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:56:31.047517Z","time spent":"343.793352ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":553,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T03:56:31.391981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.912494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5324"} {"level":"info","ts":"2026-02-19T03:56:31.392153Z","caller":"traceutil/trace.go:171","msg":"trace[1075185217] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1701; }","duration":"255.081277ms","start":"2026-02-19T03:56:31.136983Z","end":"2026-02-19T03:56:31.392064Z","steps":["trace[1075185217] 'agreement among raft nodes before linearized reading' (duration: 254.72382ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:56:31.394421Z","caller":"traceutil/trace.go:171","msg":"trace[764300330] linearizableReadLoop","detail":"{readStateIndex:1769; appliedIndex:1766; }","duration":"257.311743ms","start":"2026-02-19T03:56:31.137038Z","end":"2026-02-19T03:56:31.39435Z","steps":["trace[764300330] 'read index received' (duration: 251.142317ms)","trace[764300330] 'applied index is now lower than readState.Index' (duration: 3.381179ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:56:50.000364Z","caller":"traceutil/trace.go:171","msg":"trace[1455625517] linearizableReadLoop","detail":"{readStateIndex:1871; appliedIndex:1870; }","duration":"120.715999ms","start":"2026-02-19T03:56:49.879593Z","end":"2026-02-19T03:56:50.000309Z","steps":["trace[1455625517] 'read index received' (duration: 120.542916ms)","trace[1455625517] 'applied index is now lower than readState.Index' (duration: 171.213µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:56:50.000403Z","caller":"traceutil/trace.go:171","msg":"trace[1105793618] transaction","detail":"{read_only:false; response_revision:1799; number_of_response:1; }","duration":"160.717917ms","start":"2026-02-19T03:56:49.839633Z","end":"2026-02-19T03:56:50.000351Z","steps":["trace[1105793618] 'process raft request' (duration: 160.502973ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:56:50.000572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.969444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-19T03:56:50.000651Z","caller":"traceutil/trace.go:171","msg":"trace[540190561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1799; }","duration":"121.089017ms","start":"2026-02-19T03:56:49.879542Z","end":"2026-02-19T03:56:50.000631Z","steps":["trace[540190561] 'agreement among raft nodes before linearized reading' (duration: 120.893733ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:57:03.878458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.374792ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T03:57:03.878596Z","caller":"traceutil/trace.go:171","msg":"trace[233705933] linearizableReadLoop","detail":"{readStateIndex:1937; appliedIndex:1936; }","duration":"267.153293ms","start":"2026-02-19T03:57:03.611418Z","end":"2026-02-19T03:57:03.878571Z","steps":["trace[233705933] 'read index received' (duration: 51.590407ms)","trace[233705933] 'applied index is now lower than readState.Index' (duration: 215.561456ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:57:03.878679Z","caller":"traceutil/trace.go:171","msg":"trace[1820383278] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"371.376289ms","start":"2026-02-19T03:57:03.507286Z","end":"2026-02-19T03:57:03.878663Z","steps":["trace[1820383278] 'process raft request' (duration: 155.699631ms)","trace[1820383278] 'compare' (duration: 215.25602ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T03:57:03.878717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.294736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T03:57:03.878766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:57:03.507275Z","time spent":"371.447321ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T03:57:03.878783Z","caller":"traceutil/trace.go:171","msg":"trace[662539133] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1862; }","duration":"267.403538ms","start":"2026-02-19T03:57:03.611363Z","end":"2026-02-19T03:57:03.878766Z","steps":["trace[662539133] 'agreement among raft nodes before linearized reading' (duration: 267.298026ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:57:03.904201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.490021ms","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-02-19T03:57:03.904266Z","caller":"traceutil/trace.go:171","msg":"trace[1168856513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1863; }","duration":"267.582882ms","start":"2026-02-19T03:57:03.63667Z","end":"2026-02-19T03:57:03.904253Z","steps":["trace[1168856513] 'agreement among raft nodes before linearized reading' (duration: 267.409388ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:57:03.904258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.623932ms","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-02-19T03:57:03.904342Z","caller":"traceutil/trace.go:171","msg":"trace[1842708447] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1863; }","duration":"230.759164ms","start":"2026-02-19T03:57:03.673564Z","end":"2026-02-19T03:57:03.904324Z","steps":["trace[1842708447] 'agreement among raft nodes before linearized reading' (duration: 230.513959ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:57:03.904469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.732888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5324"} {"level":"info","ts":"2026-02-19T03:57:03.904561Z","caller":"traceutil/trace.go:171","msg":"trace[706583085] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1863; }","duration":"276.874701ms","start":"2026-02-19T03:57:03.627664Z","end":"2026-02-19T03:57:03.904539Z","steps":["trace[706583085] 'agreement among raft nodes before linearized reading' (duration: 276.606755ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:57:04.01056Z","caller":"traceutil/trace.go:171","msg":"trace[2099408036] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"102.156223ms","start":"2026-02-19T03:57:03.90837Z","end":"2026-02-19T03:57:04.010527Z","steps":["trace[2099408036] 'process raft request' (duration: 75.790839ms)","trace[2099408036] 'compare' (duration: 26.16208ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:57:04.223267Z","caller":"traceutil/trace.go:171","msg":"trace[504995170] linearizableReadLoop","detail":"{readStateIndex:1942; appliedIndex:1941; }","duration":"144.874442ms","start":"2026-02-19T03:57:04.07836Z","end":"2026-02-19T03:57:04.223234Z","steps":["trace[504995170] 'read index received' (duration: 144.633817ms)","trace[504995170] 'applied index is now lower than readState.Index' (duration: 239.505µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:57:04.223349Z","caller":"traceutil/trace.go:171","msg":"trace[576991025] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"160.10162ms","start":"2026-02-19T03:57:04.063194Z","end":"2026-02-19T03:57:04.223295Z","steps":["trace[576991025] 'process raft request' (duration: 159.880486ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:57:04.223554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.183398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-19T03:57:04.223614Z","caller":"traceutil/trace.go:171","msg":"trace[810669982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1867; }","duration":"145.2877ms","start":"2026-02-19T03:57:04.07831Z","end":"2026-02-19T03:57:04.223598Z","steps":["trace[810669982] 'agreement among raft nodes before linearized reading' (duration: 145.098787ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:57:10.748334Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762807045626449,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-19T03:57:10.76455Z","caller":"traceutil/trace.go:171","msg":"trace[2125183443] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"728.146913ms","start":"2026-02-19T03:57:10.036367Z","end":"2026-02-19T03:57:10.764513Z","steps":["trace[2125183443] 'process raft request' (duration: 727.962929ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:57:10.76483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:57:10.036349Z","time spent":"728.376567ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T03:57:11.093643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.262108ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T03:57:11.093898Z","caller":"traceutil/trace.go:171","msg":"trace[1902565240] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"1.054954338s","start":"2026-02-19T03:57:10.038914Z","end":"2026-02-19T03:57:11.093868Z","steps":["trace[1902565240] 'process raft request' (duration: 880.389884ms)","trace[1902565240] 'compare' (duration: 174.067154ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T03:57:11.094063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:57:10.038891Z","time spent":"1.055095102s","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T03:57:11.094115Z","caller":"traceutil/trace.go:171","msg":"trace[1216083805] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"1.011351452s","start":"2026-02-19T03:57:10.082676Z","end":"2026-02-19T03:57:11.094027Z","steps":["trace[1216083805] 'process raft request' (duration: 1.011080457s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:57:11.094301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:57:10.082655Z","time spent":"1.011552177s","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T03:57:11.459813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.933338ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-19T03:57:11.459908Z","caller":"traceutil/trace.go:171","msg":"trace[1957787478] linearizableReadLoop","detail":"{readStateIndex:1973; appliedIndex:1969; }","duration":"1.212480746s","start":"2026-02-19T03:57:10.247409Z","end":"2026-02-19T03:57:11.459889Z","steps":["trace[1957787478] 'read index received' (duration: 516.895134ms)","trace[1957787478] 'applied index is now lower than readState.Index' (duration: 695.584102ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T03:57:11.460154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.212741831s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-02-19T03:57:11.460166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.989112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-19T03:57:11.460152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.834669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T03:57:11.460199Z","caller":"traceutil/trace.go:171","msg":"trace[585085471] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1896; }","duration":"1.212835503s","start":"2026-02-19T03:57:10.247351Z","end":"2026-02-19T03:57:11.460187Z","steps":["trace[585085471] 'agreement among raft nodes before linearized reading' (duration: 1.212679289s)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:57:11.460208Z","caller":"traceutil/trace.go:171","msg":"trace[1275923435] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1896; }","duration":"637.080884ms","start":"2026-02-19T03:57:10.823118Z","end":"2026-02-19T03:57:11.460199Z","steps":["trace[1275923435] 'agreement among raft nodes before linearized reading' (duration: 636.996232ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:57:11.460226Z","caller":"traceutil/trace.go:171","msg":"trace[92359162] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:1896; }","duration":"407.964632ms","start":"2026-02-19T03:57:11.052243Z","end":"2026-02-19T03:57:11.460208Z","steps":["trace[92359162] 'agreement among raft nodes before linearized reading' (duration: 407.85325ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:57:11.46024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:57:10.823091Z","time spent":"637.139324ms","remote":"127.0.0.1:46020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-02-19T03:57:11.460232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.755732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5324"} {"level":"warn","ts":"2026-02-19T03:57:11.460218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.185366196s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-02-19T03:57:11.460268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:57:11.052211Z","time spent":"408.047284ms","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true "} {"level":"info","ts":"2026-02-19T03:57:11.460303Z","caller":"traceutil/trace.go:171","msg":"trace[822014315] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1896; }","duration":"1.18549821s","start":"2026-02-19T03:57:10.274786Z","end":"2026-02-19T03:57:11.460285Z","steps":["trace[822014315] 'agreement among raft nodes before linearized reading' (duration: 1.185271934s)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:57:11.4603Z","caller":"traceutil/trace.go:171","msg":"trace[766345467] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1896; }","duration":"489.908666ms","start":"2026-02-19T03:57:10.970367Z","end":"2026-02-19T03:57:11.460276Z","steps":["trace[766345467] 'agreement among raft nodes before linearized reading' (duration: 489.707501ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:57:11.460343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:57:10.274764Z","time spent":"1.185570951s","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T03:57:11.46036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:57:10.970346Z","time spent":"489.999388ms","remote":"127.0.0.1:46064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5347,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-02-19T03:57:11.4606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:57:10.247326Z","time spent":"1.213260803s","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-19T03:57:44.361299Z","caller":"traceutil/trace.go:171","msg":"trace[1868367823] linearizableReadLoop","detail":"{readStateIndex:2326; appliedIndex:2325; }","duration":"140.436731ms","start":"2026-02-19T03:57:44.22083Z","end":"2026-02-19T03:57:44.361267Z","steps":["trace[1868367823] 'read index received' (duration: 138.360828ms)","trace[1868367823] 'applied index is now lower than readState.Index' (duration: 2.074583ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:57:44.361418Z","caller":"traceutil/trace.go:171","msg":"trace[185525706] transaction","detail":"{read_only:false; response_revision:2235; number_of_response:1; }","duration":"233.399099ms","start":"2026-02-19T03:57:44.127967Z","end":"2026-02-19T03:57:44.361366Z","steps":["trace[185525706] 'process raft request' (duration: 231.359867ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:57:44.361557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.709866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-19T03:57:44.361625Z","caller":"traceutil/trace.go:171","msg":"trace[368022531] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2235; }","duration":"140.84964ms","start":"2026-02-19T03:57:44.220757Z","end":"2026-02-19T03:57:44.361607Z","steps":["trace[368022531] 'agreement among raft nodes before linearized reading' (duration: 140.609705ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:57:45.052187Z","caller":"traceutil/trace.go:171","msg":"trace[378529160] transaction","detail":"{read_only:false; response_revision:2237; number_of_response:1; }","duration":"118.881484ms","start":"2026-02-19T03:57:44.933275Z","end":"2026-02-19T03:57:45.052156Z","steps":["trace[378529160] 'process raft request' (duration: 118.65594ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:57:49.826349Z","caller":"traceutil/trace.go:171","msg":"trace[248016797] transaction","detail":"{read_only:false; response_revision:2269; number_of_response:1; }","duration":"101.207825ms","start":"2026-02-19T03:57:49.725096Z","end":"2026-02-19T03:57:49.826303Z","steps":["trace[248016797] 'process raft request' (duration: 100.885288ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:58:18.165483Z","caller":"traceutil/trace.go:171","msg":"trace[509322503] linearizableReadLoop","detail":"{readStateIndex:2519; appliedIndex:2518; }","duration":"211.254707ms","start":"2026-02-19T03:58:17.954205Z","end":"2026-02-19T03:58:18.16546Z","steps":["trace[509322503] 'read index received' (duration: 211.148574ms)","trace[509322503] 'applied index is now lower than readState.Index' (duration: 105.073µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:58:18.165676Z","caller":"traceutil/trace.go:171","msg":"trace[2067023780] transaction","detail":"{read_only:false; response_revision:2421; number_of_response:1; }","duration":"227.732438ms","start":"2026-02-19T03:58:17.937886Z","end":"2026-02-19T03:58:18.165618Z","steps":["trace[2067023780] 'process raft request' (duration: 227.427632ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:58:18.165998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.761447ms","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-02-19T03:58:18.166086Z","caller":"traceutil/trace.go:171","msg":"trace[1817747013] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2421; }","duration":"211.907369ms","start":"2026-02-19T03:58:17.954158Z","end":"2026-02-19T03:58:18.166065Z","steps":["trace[1817747013] 'agreement among raft nodes before linearized reading' (duration: 211.664485ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:58:18.166203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.783276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-19T03:58:18.166421Z","caller":"traceutil/trace.go:171","msg":"trace[164353645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2421; }","duration":"196.022742ms","start":"2026-02-19T03:58:17.970386Z","end":"2026-02-19T03:58:18.166409Z","steps":["trace[164353645] 'agreement among raft nodes before linearized reading' (duration: 195.359828ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:58:18.30703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.579418ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T03:58:18.30718Z","caller":"traceutil/trace.go:171","msg":"trace[625259981] transaction","detail":"{read_only:false; response_revision:2424; number_of_response:1; }","duration":"108.848463ms","start":"2026-02-19T03:58:18.198307Z","end":"2026-02-19T03:58:18.307155Z","steps":["trace[625259981] 'compare' (duration: 102.288762ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:58:18.782368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.356026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T03:58:18.782479Z","caller":"traceutil/trace.go:171","msg":"trace[1629277479] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:2424; }","duration":"330.54646ms","start":"2026-02-19T03:58:18.451908Z","end":"2026-02-19T03:58:18.782454Z","steps":["trace[1629277479] 'count revisions from in-memory index tree' (duration: 330.237394ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:58:18.782532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T03:58:18.451881Z","time spent":"330.639332ms","remote":"127.0.0.1:34548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-02-19T03:58:18.78262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.894468ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T03:58:18.782707Z","caller":"traceutil/trace.go:171","msg":"trace[2081468929] linearizableReadLoop","detail":"{readStateIndex:2523; appliedIndex:2522; }","duration":"254.708079ms","start":"2026-02-19T03:58:18.527986Z","end":"2026-02-19T03:58:18.782694Z","steps":["trace[2081468929] 'read index received' (duration: 80.671267ms)","trace[2081468929] 'applied index is now lower than readState.Index' (duration: 174.035592ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T03:58:18.782803Z","caller":"traceutil/trace.go:171","msg":"trace[1362135908] transaction","detail":"{read_only:false; response_revision:2425; number_of_response:1; }","duration":"298.824444ms","start":"2026-02-19T03:58:18.483964Z","end":"2026-02-19T03:58:18.782788Z","steps":["trace[1362135908] 'process raft request' (duration: 124.66733ms)","trace[1362135908] 'compare' (duration: 173.368128ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T03:58:18.782908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.897888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T03:58:18.782987Z","caller":"traceutil/trace.go:171","msg":"trace[1095769080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2425; }","duration":"171.038751ms","start":"2026-02-19T03:58:18.611929Z","end":"2026-02-19T03:58:18.782968Z","steps":["trace[1095769080] 'agreement among raft nodes before linearized reading' (duration: 170.911318ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T03:58:18.783062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.076167ms","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-02-19T03:58:18.783098Z","caller":"traceutil/trace.go:171","msg":"trace[324864452] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2425; }","duration":"255.164778ms","start":"2026-02-19T03:58:18.527922Z","end":"2026-02-19T03:58:18.783087Z","steps":["trace[324864452] 'agreement among raft nodes before linearized reading' (duration: 255.007925ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T03:58:24.340727Z","caller":"traceutil/trace.go:171","msg":"trace[623614226] transaction","detail":"{read_only:false; response_revision:2453; number_of_response:1; }","duration":"119.550268ms","start":"2026-02-19T03:58:24.221152Z","end":"2026-02-19T03:58:24.340702Z","steps":["trace[623614226] 'process raft request' (duration: 119.407004ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:00:49.676298Z","caller":"traceutil/trace.go:171","msg":"trace[1481714331] linearizableReadLoop","detail":"{readStateIndex:3478; appliedIndex:3477; }","duration":"276.900857ms","start":"2026-02-19T04:00:49.399369Z","end":"2026-02-19T04:00:49.67627Z","steps":["trace[1481714331] 'read index received' (duration: 250.539096ms)","trace[1481714331] 'applied index is now lower than readState.Index' (duration: 26.360621ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T04:00:49.676476Z","caller":"traceutil/trace.go:171","msg":"trace[2078257580] transaction","detail":"{read_only:false; response_revision:3343; number_of_response:1; }","duration":"352.275133ms","start":"2026-02-19T04:00:49.324187Z","end":"2026-02-19T04:00:49.676462Z","steps":["trace[2078257580] 'process raft request' (duration: 325.742509ms)","trace[2078257580] 'compare' (duration: 25.983363ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T04:00:49.676595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T04:00:49.324163Z","time spent":"352.346674ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T04:00:49.676677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.368429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T04:00:49.676814Z","caller":"traceutil/trace.go:171","msg":"trace[1500833181] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:3343; }","duration":"204.593843ms","start":"2026-02-19T04:00:49.472165Z","end":"2026-02-19T04:00:49.676759Z","steps":["trace[1500833181] 'agreement among raft nodes before linearized reading' (duration: 204.321508ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:00:49.677227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.834895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12017"} {"level":"info","ts":"2026-02-19T04:00:49.677342Z","caller":"traceutil/trace.go:171","msg":"trace[1895741999] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3343; }","duration":"277.948578ms","start":"2026-02-19T04:00:49.399337Z","end":"2026-02-19T04:00:49.677286Z","steps":["trace[1895741999] 'agreement among raft nodes before linearized reading' (duration: 277.606871ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:02:10.798904Z","caller":"traceutil/trace.go:171","msg":"trace[645266248] transaction","detail":"{read_only:false; response_revision:4304; number_of_response:1; }","duration":"112.392424ms","start":"2026-02-19T04:02:10.686492Z","end":"2026-02-19T04:02:10.798884Z","steps":["trace[645266248] 'process raft request' (duration: 112.305513ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:02:11.340357Z","caller":"traceutil/trace.go:171","msg":"trace[1250061828] transaction","detail":"{read_only:false; response_revision:4312; number_of_response:1; }","duration":"104.000946ms","start":"2026-02-19T04:02:11.236331Z","end":"2026-02-19T04:02:11.340332Z","steps":["trace[1250061828] 'process raft request' (duration: 95.978055ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:02:14.916589Z","caller":"traceutil/trace.go:171","msg":"trace[538833640] transaction","detail":"{read_only:false; response_revision:4467; number_of_response:1; }","duration":"470.17137ms","start":"2026-02-19T04:02:14.446395Z","end":"2026-02-19T04:02:14.916566Z","steps":["trace[538833640] 'process raft request' (duration: 469.972676ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:02:14.916785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T04:02:14.446378Z","time spent":"470.309602ms","remote":"127.0.0.1:34620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T04:02:14.916794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.316489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-02-19T04:02:14.916849Z","caller":"traceutil/trace.go:171","msg":"trace[1841924087] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:4467; }","duration":"412.439611ms","start":"2026-02-19T04:02:14.504394Z","end":"2026-02-19T04:02:14.916834Z","steps":["trace[1841924087] 'agreement among raft nodes before linearized reading' (duration: 412.246437ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:02:14.917113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T04:02:14.504371Z","time spent":"412.727997ms","remote":"127.0.0.1:34628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":917,"request content":"key:\"/registry/serviceaccounts/monitoring/vector\" "} {"level":"info","ts":"2026-02-19T04:02:14.916538Z","caller":"traceutil/trace.go:171","msg":"trace[70855949] linearizableReadLoop","detail":"{readStateIndex:4645; appliedIndex:4643; }","duration":"412.042644ms","start":"2026-02-19T04:02:14.504472Z","end":"2026-02-19T04:02:14.916515Z","steps":["trace[70855949] 'read index received' (duration: 1.01448ms)","trace[70855949] 'applied index is now lower than readState.Index' (duration: 411.027184ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T04:02:14.917571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.221081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T04:02:14.917597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.721492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-14ff230a-f3c5-46df-b927-5a67d3406794\" ","response":"range_response_count:1 size:3657"} {"level":"info","ts":"2026-02-19T04:02:14.917625Z","caller":"traceutil/trace.go:171","msg":"trace[443681498] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4467; }","duration":"307.304692ms","start":"2026-02-19T04:02:14.610305Z","end":"2026-02-19T04:02:14.91761Z","steps":["trace[443681498] 'agreement among raft nodes before linearized reading' (duration: 307.20843ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:02:14.917639Z","caller":"traceutil/trace.go:171","msg":"trace[2035821825] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-14ff230a-f3c5-46df-b927-5a67d3406794; range_end:; response_count:1; response_revision:4467; }","duration":"319.798094ms","start":"2026-02-19T04:02:14.597828Z","end":"2026-02-19T04:02:14.917626Z","steps":["trace[2035821825] 'agreement among raft nodes before linearized reading' (duration: 319.727212ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:02:14.917656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T04:02:14.610294Z","time spent":"307.355913ms","remote":"127.0.0.1:34470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-19T04:02:14.917671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T04:02:14.597804Z","time spent":"319.860134ms","remote":"127.0.0.1:34620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3680,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-14ff230a-f3c5-46df-b927-5a67d3406794\" "} {"level":"warn","ts":"2026-02-19T04:02:14.917641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.098231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-19T04:02:14.917746Z","caller":"traceutil/trace.go:171","msg":"trace[2083825227] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:4467; }","duration":"167.309685ms","start":"2026-02-19T04:02:14.750413Z","end":"2026-02-19T04:02:14.917723Z","steps":["trace[2083825227] 'agreement among raft nodes before linearized reading' (duration: 167.037889ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:02:14.918006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.173877ms","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-02-19T04:02:14.918081Z","caller":"traceutil/trace.go:171","msg":"trace[46984185] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4467; }","duration":"247.477073ms","start":"2026-02-19T04:02:14.670582Z","end":"2026-02-19T04:02:14.918059Z","steps":["trace[46984185] 'agreement among raft nodes before linearized reading' (duration: 247.115536ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:02:14.919684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.066851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:24 size:772114"} {"level":"info","ts":"2026-02-19T04:02:14.919853Z","caller":"traceutil/trace.go:171","msg":"trace[1452684681] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:24; response_revision:4467; }","duration":"357.289475ms","start":"2026-02-19T04:02:14.562547Z","end":"2026-02-19T04:02:14.919836Z","steps":["trace[1452684681] 'agreement among raft nodes before linearized reading' (duration: 354.821386ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:02:14.920007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T04:02:14.562511Z","time spent":"357.477469ms","remote":"127.0.0.1:34560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":24,"response size":772137,"request content":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" "} {"level":"info","ts":"2026-02-19T04:02:15.339625Z","caller":"traceutil/trace.go:171","msg":"trace[1150386771] transaction","detail":"{read_only:false; response_revision:4469; number_of_response:1; }","duration":"144.258074ms","start":"2026-02-19T04:02:15.195326Z","end":"2026-02-19T04:02:15.339584Z","steps":["trace[1150386771] 'process raft request' (duration: 143.955528ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:02:15.500461Z","caller":"traceutil/trace.go:171","msg":"trace[2069993785] transaction","detail":"{read_only:false; response_revision:4471; number_of_response:1; }","duration":"156.054079ms","start":"2026-02-19T04:02:15.344375Z","end":"2026-02-19T04:02:15.500429Z","steps":["trace[2069993785] 'process raft request' (duration: 116.349983ms)","trace[2069993785] 'compare' (duration: 39.495202ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T04:02:15.500692Z","caller":"traceutil/trace.go:171","msg":"trace[1581396373] transaction","detail":"{read_only:false; response_revision:4472; number_of_response:1; }","duration":"149.268614ms","start":"2026-02-19T04:02:15.351396Z","end":"2026-02-19T04:02:15.500665Z","steps":["trace[1581396373] 'process raft request' (duration: 148.986668ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:02:15.500687Z","caller":"traceutil/trace.go:171","msg":"trace[563814353] linearizableReadLoop","detail":"{readStateIndex:4650; appliedIndex:4647; }","duration":"123.516798ms","start":"2026-02-19T04:02:15.377127Z","end":"2026-02-19T04:02:15.500644Z","steps":["trace[563814353] 'read index received' (duration: 12.811308ms)","trace[563814353] 'applied index is now lower than readState.Index' (duration: 110.70273ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T04:02:15.500909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.759432ms","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-02-19T04:02:15.50095Z","caller":"traceutil/trace.go:171","msg":"trace[1877870268] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4472; }","duration":"123.868355ms","start":"2026-02-19T04:02:15.37707Z","end":"2026-02-19T04:02:15.500938Z","steps":["trace[1877870268] 'agreement among raft nodes before linearized reading' (duration: 123.675531ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:02:25.646019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.227497ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-02-19T04:02:25.652095Z","caller":"traceutil/trace.go:171","msg":"trace[1871783617] transaction","detail":"{read_only:false; response_revision:4668; number_of_response:1; }","duration":"102.049742ms","start":"2026-02-19T04:02:25.550019Z","end":"2026-02-19T04:02:25.652068Z","steps":["trace[1871783617] 'process raft request' (duration: 101.783127ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:02:33.428602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.860278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T04:02:33.428722Z","caller":"traceutil/trace.go:171","msg":"trace[91015709] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:4795; }","duration":"113.124443ms","start":"2026-02-19T04:02:33.315572Z","end":"2026-02-19T04:02:33.428696Z","steps":["trace[91015709] 'count revisions from in-memory index tree' (duration: 112.652015ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:02:50.436009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.974162ms","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-02-19T04:02:50.436087Z","caller":"traceutil/trace.go:171","msg":"trace[523187059] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5042; }","duration":"145.122895ms","start":"2026-02-19T04:02:50.290947Z","end":"2026-02-19T04:02:50.43607Z","steps":["trace[523187059] 'range keys from in-memory index tree' (duration: 144.816639ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:03:25.349217Z","caller":"traceutil/trace.go:171","msg":"trace[1008646867] linearizableReadLoop","detail":"{readStateIndex:5542; appliedIndex:5541; }","duration":"122.101383ms","start":"2026-02-19T04:03:25.227094Z","end":"2026-02-19T04:03:25.349195Z","steps":["trace[1008646867] 'read index received' (duration: 121.96786ms)","trace[1008646867] 'applied index is now lower than readState.Index' (duration: 132.243µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T04:03:25.349271Z","caller":"traceutil/trace.go:171","msg":"trace[462328663] transaction","detail":"{read_only:false; response_revision:5338; number_of_response:1; }","duration":"218.383841ms","start":"2026-02-19T04:03:25.130852Z","end":"2026-02-19T04:03:25.349236Z","steps":["trace[462328663] 'process raft request' (duration: 218.151706ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:03:25.349402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.289447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-19T04:03:25.349447Z","caller":"traceutil/trace.go:171","msg":"trace[807002371] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:5338; }","duration":"122.395999ms","start":"2026-02-19T04:03:25.227039Z","end":"2026-02-19T04:03:25.349435Z","steps":["trace[807002371] 'agreement among raft nodes before linearized reading' (duration: 122.264206ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:03:34.291895Z","caller":"traceutil/trace.go:171","msg":"trace[1232573859] transaction","detail":"{read_only:false; response_revision:5393; number_of_response:1; }","duration":"126.800518ms","start":"2026-02-19T04:03:34.16505Z","end":"2026-02-19T04:03:34.29185Z","steps":["trace[1232573859] 'process raft request' (duration: 78.366469ms)","trace[1232573859] 'compare' (duration: 48.206225ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T04:04:22.511389Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2737} {"level":"info","ts":"2026-02-19T04:04:22.578207Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2737,"took":"64.404629ms","hash":1046897526,"current-db-size-bytes":42016768,"current-db-size":"42 MB","current-db-size-in-use-bytes":31457280,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-02-19T04:04:22.578296Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1046897526,"revision":2737,"compact-revision":-1} {"level":"warn","ts":"2026-02-19T04:08:46.70525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.294884ms","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-02-19T04:08:46.705464Z","caller":"traceutil/trace.go:171","msg":"trace[376688632] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7547; }","duration":"407.544698ms","start":"2026-02-19T04:08:46.297891Z","end":"2026-02-19T04:08:46.705436Z","steps":["trace[376688632] 'range keys from in-memory index tree' (duration: 406.909847ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:08:46.705547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T04:08:46.297871Z","time spent":"407.657831ms","remote":"127.0.0.1:34686","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-02-19T04:08:46.705689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.88558ms","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-02-19T04:08:46.705805Z","caller":"traceutil/trace.go:171","msg":"trace[1696905560] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7547; }","duration":"713.048832ms","start":"2026-02-19T04:08:45.992735Z","end":"2026-02-19T04:08:46.705784Z","steps":["trace[1696905560] 'range keys from in-memory index tree' (duration: 712.060954ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:08:46.705901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T04:08:45.992716Z","time spent":"713.124195ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-19T04:08:54.681374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.138691ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T04:08:54.681592Z","caller":"traceutil/trace.go:171","msg":"trace[1659113188] transaction","detail":"{read_only:false; response_revision:7586; number_of_response:1; }","duration":"192.503215ms","start":"2026-02-19T04:08:54.489076Z","end":"2026-02-19T04:08:54.68158Z","steps":["trace[1659113188] 'process raft request' (duration: 17.086747ms)","trace[1659113188] 'compare' (duration: 175.05187ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T04:08:55.49125Z","caller":"traceutil/trace.go:171","msg":"trace[212445633] transaction","detail":"{read_only:false; response_revision:7590; number_of_response:1; }","duration":"464.442889ms","start":"2026-02-19T04:08:55.026781Z","end":"2026-02-19T04:08:55.491224Z","steps":["trace[212445633] 'process raft request' (duration: 463.772135ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:08:55.4914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T04:08:55.026753Z","time spent":"464.577132ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":553,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T04:08:55.496811Z","caller":"traceutil/trace.go:171","msg":"trace[1331119713] linearizableReadLoop","detail":"{readStateIndex:7872; appliedIndex:7870; }","duration":"252.270015ms","start":"2026-02-19T04:08:55.24452Z","end":"2026-02-19T04:08:55.49679Z","steps":["trace[1331119713] 'read index received' (duration: 246.024871ms)","trace[1331119713] 'applied index is now lower than readState.Index' (duration: 6.244134ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T04:08:55.496938Z","caller":"traceutil/trace.go:171","msg":"trace[1426380403] transaction","detail":"{read_only:false; response_revision:7591; number_of_response:1; }","duration":"255.255624ms","start":"2026-02-19T04:08:55.241595Z","end":"2026-02-19T04:08:55.49685Z","steps":["trace[1426380403] 'process raft request' (duration: 255.070441ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:08:55.497082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.905385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T04:08:55.49707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.53456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-19T04:08:55.497112Z","caller":"traceutil/trace.go:171","msg":"trace[476230299] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:7591; }","duration":"225.980086ms","start":"2026-02-19T04:08:55.271123Z","end":"2026-02-19T04:08:55.497103Z","steps":["trace[476230299] 'agreement among raft nodes before linearized reading' (duration: 225.893455ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:08:55.49714Z","caller":"traceutil/trace.go:171","msg":"trace[100214803] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7591; }","duration":"252.644943ms","start":"2026-02-19T04:08:55.244479Z","end":"2026-02-19T04:08:55.497123Z","steps":["trace[100214803] 'agreement among raft nodes before linearized reading' (duration: 252.428769ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:08:55.497186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.643227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xmjqj\" ","response":"range_response_count:1 size:6288"} {"level":"info","ts":"2026-02-19T04:08:55.497293Z","caller":"traceutil/trace.go:171","msg":"trace[21086806] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xmjqj; range_end:; response_count:1; response_revision:7591; }","duration":"150.79775ms","start":"2026-02-19T04:08:55.346469Z","end":"2026-02-19T04:08:55.497267Z","steps":["trace[21086806] 'agreement among raft nodes before linearized reading' (duration: 150.556156ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:08:57.651682Z","caller":"traceutil/trace.go:171","msg":"trace[2049029316] linearizableReadLoop","detail":"{readStateIndex:7883; appliedIndex:7881; }","duration":"133.621721ms","start":"2026-02-19T04:08:57.518036Z","end":"2026-02-19T04:08:57.651657Z","steps":["trace[2049029316] 'read index received' (duration: 6.972198ms)","trace[2049029316] 'applied index is now lower than readState.Index' (duration: 126.648473ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T04:08:57.651818Z","caller":"traceutil/trace.go:171","msg":"trace[170919797] transaction","detail":"{read_only:false; response_revision:7601; number_of_response:1; }","duration":"149.470983ms","start":"2026-02-19T04:08:57.502306Z","end":"2026-02-19T04:08:57.651777Z","steps":["trace[170919797] 'process raft request' (duration: 149.182268ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:08:57.651916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.856975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-19T04:08:57.651952Z","caller":"traceutil/trace.go:171","msg":"trace[1177220299] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7601; }","duration":"133.943468ms","start":"2026-02-19T04:08:57.517996Z","end":"2026-02-19T04:08:57.65194Z","steps":["trace[1177220299] 'agreement among raft nodes before linearized reading' (duration: 133.788734ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:08:57.810454Z","caller":"traceutil/trace.go:171","msg":"trace[1199520039] transaction","detail":"{read_only:false; response_revision:7602; number_of_response:1; }","duration":"283.31587ms","start":"2026-02-19T04:08:57.527113Z","end":"2026-02-19T04:08:57.810428Z","steps":["trace[1199520039] 'process raft request' (duration: 258.973929ms)","trace[1199520039] 'compare' (duration: 24.126036ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T04:08:57.810521Z","caller":"traceutil/trace.go:171","msg":"trace[1392904578] linearizableReadLoop","detail":"{readStateIndex:7884; appliedIndex:7883; }","duration":"158.757648ms","start":"2026-02-19T04:08:57.651756Z","end":"2026-02-19T04:08:57.810514Z","steps":["trace[1392904578] 'read index received' (duration: 134.278034ms)","trace[1392904578] 'applied index is now lower than readState.Index' (duration: 24.478824ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T04:08:57.81047Z","caller":"traceutil/trace.go:171","msg":"trace[2006153574] transaction","detail":"{read_only:false; response_revision:7603; number_of_response:1; }","duration":"154.452754ms","start":"2026-02-19T04:08:57.656Z","end":"2026-02-19T04:08:57.810453Z","steps":["trace[2006153574] 'process raft request' (duration: 154.381991ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:08:57.81089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.969501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xmjqj\" ","response":"range_response_count:1 size:6288"} {"level":"info","ts":"2026-02-19T04:08:57.811012Z","caller":"traceutil/trace.go:171","msg":"trace[651671073] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xmjqj; range_end:; response_count:1; response_revision:7603; }","duration":"291.144844ms","start":"2026-02-19T04:08:57.51984Z","end":"2026-02-19T04:08:57.810985Z","steps":["trace[651671073] 'agreement among raft nodes before linearized reading' (duration: 290.730246ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:08:59.394936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.264303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5541"} {"level":"info","ts":"2026-02-19T04:08:59.395014Z","caller":"traceutil/trace.go:171","msg":"trace[182128483] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:7610; }","duration":"134.404466ms","start":"2026-02-19T04:08:59.260589Z","end":"2026-02-19T04:08:59.394993Z","steps":["trace[182128483] 'range keys from in-memory index tree' (duration: 134.092411ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:09:21.38038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.999935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:17461"} {"level":"info","ts":"2026-02-19T04:09:21.380446Z","caller":"traceutil/trace.go:171","msg":"trace[304674956] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:7767; }","duration":"190.113308ms","start":"2026-02-19T04:09:21.190317Z","end":"2026-02-19T04:09:21.38043Z","steps":["trace[304674956] 'range keys from in-memory index tree' (duration: 189.841562ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:09:21.380581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.848982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-mon-endpoints\" ","response":"range_response_count:1 size:389"} {"level":"info","ts":"2026-02-19T04:09:21.380657Z","caller":"traceutil/trace.go:171","msg":"trace[1324171481] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-mon-endpoints; range_end:; response_count:1; response_revision:7767; }","duration":"191.078756ms","start":"2026-02-19T04:09:21.189559Z","end":"2026-02-19T04:09:21.380638Z","steps":["trace[1324171481] 'range keys from in-memory index tree' (duration: 190.655058ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:09:22.517846Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5754} {"level":"info","ts":"2026-02-19T04:09:22.597738Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5754,"took":"77.657205ms","hash":1732644040,"current-db-size-bytes":42016768,"current-db-size":"42 MB","current-db-size-in-use-bytes":22970368,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-02-19T04:09:22.5978Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1732644040,"revision":5754,"compact-revision":2737} {"level":"info","ts":"2026-02-19T04:09:25.293565Z","caller":"traceutil/trace.go:171","msg":"trace[119505427] transaction","detail":"{read_only:false; response_revision:7788; number_of_response:1; }","duration":"297.636201ms","start":"2026-02-19T04:09:24.995902Z","end":"2026-02-19T04:09:25.293538Z","steps":["trace[119505427] 'process raft request' (duration: 297.488769ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:09:25.751474Z","caller":"traceutil/trace.go:171","msg":"trace[1885624853] transaction","detail":"{read_only:false; response_revision:7789; number_of_response:1; }","duration":"752.387979ms","start":"2026-02-19T04:09:24.999049Z","end":"2026-02-19T04:09:25.751437Z","steps":["trace[1885624853] 'process raft request' (duration: 750.347168ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:09:25.751536Z","caller":"traceutil/trace.go:171","msg":"trace[507244439] linearizableReadLoop","detail":"{readStateIndex:8079; appliedIndex:8077; }","duration":"751.450892ms","start":"2026-02-19T04:09:25.000069Z","end":"2026-02-19T04:09:25.75152Z","steps":["trace[507244439] 'read index received' (duration: 293.396569ms)","trace[507244439] 'applied index is now lower than readState.Index' (duration: 458.053783ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T04:09:25.751602Z","caller":"traceutil/trace.go:171","msg":"trace[1465412365] transaction","detail":"{read_only:false; response_revision:7790; number_of_response:1; }","duration":"128.417238ms","start":"2026-02-19T04:09:25.623179Z","end":"2026-02-19T04:09:25.751596Z","steps":["trace[1465412365] 'process raft request' (duration: 128.168883ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:09:25.751689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T04:09:24.999037Z","time spent":"752.538883ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T04:09:25.751775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.697006ms","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-02-19T04:09:25.7518Z","caller":"traceutil/trace.go:171","msg":"trace[380516719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7791; }","duration":"751.746647ms","start":"2026-02-19T04:09:25.000048Z","end":"2026-02-19T04:09:25.751795Z","steps":["trace[380516719] 'agreement among raft nodes before linearized reading' (duration: 751.637545ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:09:25.751816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T04:09:25.000042Z","time spent":"751.770347ms","remote":"127.0.0.1:34686","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-02-19T04:09:25.751897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.342391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.49\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-19T04:09:25.751917Z","caller":"traceutil/trace.go:171","msg":"trace[1138221062] range","detail":"{range_begin:/registry/masterleases/162.253.55.49; range_end:; response_count:1; response_revision:7791; }","duration":"279.364031ms","start":"2026-02-19T04:09:25.47255Z","end":"2026-02-19T04:09:25.751914Z","steps":["trace[1138221062] 'agreement among raft nodes before linearized reading' (duration: 279.31669ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:09:25.751928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.248192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T04:09:25.751949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-19T04:09:25.751984Z","caller":"traceutil/trace.go:171","msg":"trace[1220891668] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7791; }","duration":"140.345543ms","start":"2026-02-19T04:09:25.611624Z","end":"2026-02-19T04:09:25.751969Z","steps":["trace[1220891668] 'agreement among raft nodes before linearized reading' (duration: 140.255822ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:09:25.752Z","caller":"traceutil/trace.go:171","msg":"trace[1421409235] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:7791; }","duration":"222.752913ms","start":"2026-02-19T04:09:25.529234Z","end":"2026-02-19T04:09:25.751987Z","steps":["trace[1421409235] 'agreement among raft nodes before linearized reading' (duration: 222.654451ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:09:37.643075Z","caller":"traceutil/trace.go:171","msg":"trace[956932191] transaction","detail":"{read_only:false; response_revision:7889; number_of_response:1; }","duration":"115.323039ms","start":"2026-02-19T04:09:37.527725Z","end":"2026-02-19T04:09:37.643048Z","steps":["trace[956932191] 'process raft request' (duration: 115.177956ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:09:38.332744Z","caller":"traceutil/trace.go:171","msg":"trace[1309108228] transaction","detail":"{read_only:false; response_revision:7897; number_of_response:1; }","duration":"149.448914ms","start":"2026-02-19T04:09:38.183265Z","end":"2026-02-19T04:09:38.332714Z","steps":["trace[1309108228] 'process raft request' (duration: 149.26936ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:09:38.731136Z","caller":"traceutil/trace.go:171","msg":"trace[683844363] linearizableReadLoop","detail":"{readStateIndex:8194; appliedIndex:8193; }","duration":"210.98417ms","start":"2026-02-19T04:09:38.520113Z","end":"2026-02-19T04:09:38.731097Z","steps":["trace[683844363] 'read index received' (duration: 210.845087ms)","trace[683844363] 'applied index is now lower than readState.Index' (duration: 137.803µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T04:09:38.731186Z","caller":"traceutil/trace.go:171","msg":"trace[1351438057] transaction","detail":"{read_only:false; response_revision:7898; number_of_response:1; }","duration":"220.757863ms","start":"2026-02-19T04:09:38.510391Z","end":"2026-02-19T04:09:38.731149Z","steps":["trace[1351438057] 'process raft request' (duration: 220.532478ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:09:38.731312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.43366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T04:09:38.731348Z","caller":"traceutil/trace.go:171","msg":"trace[1164805099] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7898; }","duration":"120.522771ms","start":"2026-02-19T04:09:38.610814Z","end":"2026-02-19T04:09:38.731336Z","steps":["trace[1164805099] 'agreement among raft nodes before linearized reading' (duration: 120.45043ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:09:38.731423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.292896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5124"} {"level":"info","ts":"2026-02-19T04:09:38.731522Z","caller":"traceutil/trace.go:171","msg":"trace[1459190482] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:7898; }","duration":"211.426518ms","start":"2026-02-19T04:09:38.520076Z","end":"2026-02-19T04:09:38.731503Z","steps":["trace[1459190482] 'agreement among raft nodes before linearized reading' (duration: 211.166313ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:09:39.362075Z","caller":"traceutil/trace.go:171","msg":"trace[1578396600] transaction","detail":"{read_only:false; response_revision:7901; number_of_response:1; }","duration":"199.689856ms","start":"2026-02-19T04:09:39.162362Z","end":"2026-02-19T04:09:39.362052Z","steps":["trace[1578396600] 'process raft request' (duration: 199.523033ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:09:39.416311Z","caller":"traceutil/trace.go:171","msg":"trace[1577772834] linearizableReadLoop","detail":"{readStateIndex:8198; appliedIndex:8196; }","duration":"232.240249ms","start":"2026-02-19T04:09:39.18404Z","end":"2026-02-19T04:09:39.41628Z","steps":["trace[1577772834] 'read index received' (duration: 177.887064ms)","trace[1577772834] 'applied index is now lower than readState.Index' (duration: 54.351975ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T04:09:39.416373Z","caller":"traceutil/trace.go:171","msg":"trace[73739087] transaction","detail":"{read_only:false; response_revision:7902; number_of_response:1; }","duration":"232.756331ms","start":"2026-02-19T04:09:39.18359Z","end":"2026-02-19T04:09:39.416347Z","steps":["trace[73739087] 'process raft request' (duration: 232.546976ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:09:39.416577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.911455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T04:09:39.416633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.566046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-x7plr\" ","response":"range_response_count:1 size:4523"} {"level":"info","ts":"2026-02-19T04:09:39.416666Z","caller":"traceutil/trace.go:171","msg":"trace[1231895960] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:7902; }","duration":"228.043738ms","start":"2026-02-19T04:09:39.1886Z","end":"2026-02-19T04:09:39.416643Z","steps":["trace[1231895960] 'agreement among raft nodes before linearized reading' (duration: 227.865704ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:09:39.416694Z","caller":"traceutil/trace.go:171","msg":"trace[135509995] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-x7plr; range_end:; response_count:1; response_revision:7902; }","duration":"232.668228ms","start":"2026-02-19T04:09:39.18401Z","end":"2026-02-19T04:09:39.416678Z","steps":["trace[135509995] 'agreement among raft nodes before linearized reading' (duration: 232.425404ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:10:02.675359Z","caller":"traceutil/trace.go:171","msg":"trace[207201526] transaction","detail":"{read_only:false; response_revision:8158; number_of_response:1; }","duration":"186.869996ms","start":"2026-02-19T04:10:02.488463Z","end":"2026-02-19T04:10:02.675333Z","steps":["trace[207201526] 'process raft request' (duration: 186.798864ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:10:02.675421Z","caller":"traceutil/trace.go:171","msg":"trace[786483166] transaction","detail":"{read_only:false; response_revision:8157; number_of_response:1; }","duration":"187.081782ms","start":"2026-02-19T04:10:02.488295Z","end":"2026-02-19T04:10:02.675377Z","steps":["trace[786483166] 'process raft request' (duration: 186.645223ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:10:02.675776Z","caller":"traceutil/trace.go:171","msg":"trace[471628096] transaction","detail":"{read_only:false; response_revision:8159; number_of_response:1; }","duration":"186.215053ms","start":"2026-02-19T04:10:02.489545Z","end":"2026-02-19T04:10:02.67576Z","steps":["trace[471628096] 'process raft request' (duration: 185.988809ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:10:02.675745Z","caller":"traceutil/trace.go:171","msg":"trace[1070525635] linearizableReadLoop","detail":"{readStateIndex:8464; appliedIndex:8461; }","duration":"160.430952ms","start":"2026-02-19T04:10:02.515285Z","end":"2026-02-19T04:10:02.675716Z","steps":["trace[1070525635] 'read index received' (duration: 159.637397ms)","trace[1070525635] 'applied index is now lower than readState.Index' (duration: 791.935µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T04:10:02.675966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.657746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1857"} {"level":"info","ts":"2026-02-19T04:10:02.67603Z","caller":"traceutil/trace.go:171","msg":"trace[545693838] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:8159; }","duration":"160.778719ms","start":"2026-02-19T04:10:02.515237Z","end":"2026-02-19T04:10:02.676015Z","steps":["trace[545693838] 'agreement among raft nodes before linearized reading' (duration: 160.571415ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:10:55.491109Z","caller":"traceutil/trace.go:171","msg":"trace[1882456366] transaction","detail":"{read_only:false; response_revision:8610; number_of_response:1; }","duration":"213.75818ms","start":"2026-02-19T04:10:55.277322Z","end":"2026-02-19T04:10:55.49108Z","steps":["trace[1882456366] 'process raft request' (duration: 213.539376ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:10:55.657154Z","caller":"traceutil/trace.go:171","msg":"trace[438279168] linearizableReadLoop","detail":"{readStateIndex:8928; appliedIndex:8927; }","duration":"141.325312ms","start":"2026-02-19T04:10:55.515803Z","end":"2026-02-19T04:10:55.657128Z","steps":["trace[438279168] 'read index received' (duration: 109.748706ms)","trace[438279168] 'applied index is now lower than readState.Index' (duration: 31.575366ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T04:10:55.657205Z","caller":"traceutil/trace.go:171","msg":"trace[104859444] transaction","detail":"{read_only:false; response_revision:8611; number_of_response:1; }","duration":"146.512786ms","start":"2026-02-19T04:10:55.510653Z","end":"2026-02-19T04:10:55.657166Z","steps":["trace[104859444] 'process raft request' (duration: 114.93025ms)","trace[104859444] 'compare' (duration: 31.424023ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T04:10:55.657388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.557617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-19T04:10:55.657435Z","caller":"traceutil/trace.go:171","msg":"trace[1498129304] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:8611; }","duration":"141.627958ms","start":"2026-02-19T04:10:55.515792Z","end":"2026-02-19T04:10:55.65742Z","steps":["trace[1498129304] 'agreement among raft nodes before linearized reading' (duration: 141.475605ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:13:20.65118Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6a9ba61e55fef5be","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-02-19T04:13:20.656369Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-02-19T04:13:20.656452Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-02-19T04:14:21.078163Z","caller":"traceutil/trace.go:171","msg":"trace[107822455] transaction","detail":"{read_only:false; response_revision:10258; number_of_response:1; }","duration":"182.378676ms","start":"2026-02-19T04:14:20.895759Z","end":"2026-02-19T04:14:21.078138Z","steps":["trace[107822455] 'process raft request' (duration: 182.213513ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:14:21.090095Z","caller":"traceutil/trace.go:171","msg":"trace[355451247] transaction","detail":"{read_only:false; response_revision:10259; number_of_response:1; }","duration":"190.06384ms","start":"2026-02-19T04:14:20.899993Z","end":"2026-02-19T04:14:21.090057Z","steps":["trace[355451247] 'process raft request' (duration: 189.705033ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:14:21.090416Z","caller":"traceutil/trace.go:171","msg":"trace[1437115410] transaction","detail":"{read_only:false; response_revision:10260; number_of_response:1; }","duration":"164.246536ms","start":"2026-02-19T04:14:20.92615Z","end":"2026-02-19T04:14:21.090396Z","steps":["trace[1437115410] 'process raft request' (duration: 163.797777ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:14:21.090664Z","caller":"traceutil/trace.go:171","msg":"trace[662139312] linearizableReadLoop","detail":"{readStateIndex:10627; appliedIndex:10624; }","duration":"164.198765ms","start":"2026-02-19T04:14:20.926446Z","end":"2026-02-19T04:14:21.090644Z","steps":["trace[662139312] 'read index received' (duration: 151.461012ms)","trace[662139312] 'applied index is now lower than readState.Index' (duration: 12.736513ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T04:14:21.090831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.364319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-02-19T04:14:21.090869Z","caller":"traceutil/trace.go:171","msg":"trace[1630122107] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:10261; }","duration":"164.453501ms","start":"2026-02-19T04:14:20.926404Z","end":"2026-02-19T04:14:21.090858Z","steps":["trace[1630122107] 'agreement among raft nodes before linearized reading' (duration: 164.305997ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:14:22.199302Z","caller":"traceutil/trace.go:171","msg":"trace[362203702] linearizableReadLoop","detail":"{readStateIndex:10634; appliedIndex:10633; }","duration":"304.819322ms","start":"2026-02-19T04:14:21.894458Z","end":"2026-02-19T04:14:22.199277Z","steps":["trace[362203702] 'read index received' (duration: 304.604868ms)","trace[362203702] 'applied index is now lower than readState.Index' (duration: 213.334µs)"],"step_count":2} {"level":"info","ts":"2026-02-19T04:14:22.199368Z","caller":"traceutil/trace.go:171","msg":"trace[720542773] transaction","detail":"{read_only:false; response_revision:10267; number_of_response:1; }","duration":"343.162383ms","start":"2026-02-19T04:14:21.856172Z","end":"2026-02-19T04:14:22.199335Z","steps":["trace[720542773] 'process raft request' (duration: 342.904618ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:14:22.199513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.019576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T04:14:22.199598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T04:14:21.856156Z","time spent":"343.352528ms","remote":"127.0.0.1:34686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T04:14:22.199619Z","caller":"traceutil/trace.go:171","msg":"trace[1341521009] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:10267; }","duration":"305.176209ms","start":"2026-02-19T04:14:21.894417Z","end":"2026-02-19T04:14:22.199593Z","steps":["trace[1341521009] 'agreement among raft nodes before linearized reading' (duration: 304.988996ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T04:14:22.19968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T04:14:21.894401Z","time spent":"305.260131ms","remote":"127.0.0.1:55552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true "} {"level":"warn","ts":"2026-02-19T04:14:22.199736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.520852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xmjqj\" ","response":"range_response_count:1 size:6288"} {"level":"info","ts":"2026-02-19T04:14:22.199882Z","caller":"traceutil/trace.go:171","msg":"trace[2121814151] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xmjqj; range_end:; response_count:1; response_revision:10267; }","duration":"245.697635ms","start":"2026-02-19T04:14:21.954129Z","end":"2026-02-19T04:14:22.199827Z","steps":["trace[2121814151] 'agreement among raft nodes before linearized reading' (duration: 245.405509ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:14:22.524474Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7778} {"level":"info","ts":"2026-02-19T04:14:22.591432Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7778,"took":"64.778868ms","hash":3044961829,"current-db-size-bytes":42016768,"current-db-size":"42 MB","current-db-size-in-use-bytes":27373568,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-02-19T04:14:22.591493Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3044961829,"revision":7778,"compact-revision":5754} {"level":"warn","ts":"2026-02-19T04:14:43.94737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.862766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T04:14:43.947483Z","caller":"traceutil/trace.go:171","msg":"trace[1097680938] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:10378; }","duration":"101.999798ms","start":"2026-02-19T04:14:43.845462Z","end":"2026-02-19T04:14:43.947462Z","steps":["trace[1097680938] 'count revisions from in-memory index tree' (duration: 101.729563ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:14:45.306517Z","caller":"traceutil/trace.go:171","msg":"trace[1088891209] transaction","detail":"{read_only:false; response_revision:10380; number_of_response:1; }","duration":"131.498115ms","start":"2026-02-19T04:14:45.174985Z","end":"2026-02-19T04:14:45.306483Z","steps":["trace[1088891209] 'process raft request' (duration: 81.415669ms)","trace[1088891209] 'compare' (duration: 49.863441ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T04:14:45.306691Z","caller":"traceutil/trace.go:171","msg":"trace[1948666784] transaction","detail":"{read_only:false; response_revision:10381; number_of_response:1; }","duration":"110.395216ms","start":"2026-02-19T04:14:45.196265Z","end":"2026-02-19T04:14:45.30666Z","steps":["trace[1948666784] 'process raft request' (duration: 110.171082ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T04:19:22.530611Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10268} {"level":"info","ts":"2026-02-19T04:19:22.611929Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10268,"took":"78.908963ms","hash":210399981,"current-db-size-bytes":42016768,"current-db-size":"42 MB","current-db-size-in-use-bytes":24383488,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-02-19T04:19:22.611997Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":210399981,"revision":10268,"compact-revision":7778} {"level":"info","ts":"2026-02-19T04:21:20.885207Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000033e5.wal"}