{"level":"warn","ts":"2026-03-20T10:12:41.027763Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-20T10:12:41.027837Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.140: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.140:2380","--initial-cluster=instance=https://162.253.55.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.140:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-03-20T10:12:41.027893Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-20T10:12:41.027907Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.140:2380"]} {"level":"info","ts":"2026-03-20T10:12:41.027923Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-03-20T10:12:41.02853Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"]} {"level":"info","ts":"2026-03-20T10:12:41.028601Z","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.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.140:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-03-20T10:12:41.032752Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.945033ms"} {"level":"info","ts":"2026-03-20T10:12:41.039325Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf809824ab95ac81","cluster-id":"6f89f5fbef18dc61"} {"level":"info","ts":"2026-03-20T10:12:41.039437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=()"} {"level":"info","ts":"2026-03-20T10:12:41.039478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 0"} {"level":"info","ts":"2026-03-20T10:12:41.039515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf809824ab95ac81 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-20T10:12:41.03953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 1"} {"level":"info","ts":"2026-03-20T10:12:41.039594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"warn","ts":"2026-03-20T10:12:41.049384Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-20T10:12:41.051153Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-20T10:12:41.053641Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-03-20T10:12:41.056962Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf809824ab95ac81","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-20T10:12:41.057376Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf809824ab95ac81","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-20T10:12:41.057471Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-20T10:12:41.057582Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-20T10:12:41.057594Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-20T10:12:41.059479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"info","ts":"2026-03-20T10:12:41.059681Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","added-peer-id":"cf809824ab95ac81","added-peer-peer-urls":["https://162.253.55.140:2380"]} {"level":"info","ts":"2026-03-20T10:12:41.06521Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-03-20T10:12:41.065362Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-03-20T10:12:41.065415Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-03-20T10:12:41.065719Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf809824ab95ac81","initial-advertise-peer-urls":["https://162.253.55.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-20T10:12:41.0658Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-20T10:12:42.03987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 is starting a new election at term 1"} {"level":"info","ts":"2026-03-20T10:12:42.039974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-20T10:12:42.040063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgPreVoteResp from cf809824ab95ac81 at term 1"} {"level":"info","ts":"2026-03-20T10:12:42.040104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became candidate at term 2"} {"level":"info","ts":"2026-03-20T10:12:42.040124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgVoteResp from cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-03-20T10:12:42.04015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became leader at term 2"} {"level":"info","ts":"2026-03-20T10:12:42.040174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf809824ab95ac81 elected leader cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-03-20T10:12:42.041242Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T10:12:42.043436Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-20T10:12:42.043441Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf809824ab95ac81","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.140:2379]}","request-path":"/0/members/cf809824ab95ac81/attributes","cluster-id":"6f89f5fbef18dc61","publish-timeout":"7s"} {"level":"info","ts":"2026-03-20T10:12:42.043494Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-20T10:12:42.043874Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T10:12:42.043863Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-20T10:12:42.044003Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-20T10:12:42.044014Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T10:12:42.044047Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T10:12:42.046831Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.140:2379"} {"level":"info","ts":"2026-03-20T10:12:42.048074Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-20T10:12:57.930485Z","caller":"traceutil/trace.go:171","msg":"trace[2135779590] linearizableReadLoop","detail":"{readStateIndex:386; appliedIndex:385; }","duration":"160.523269ms","start":"2026-03-20T10:12:57.769933Z","end":"2026-03-20T10:12:57.930456Z","steps":["trace[2135779590] 'read index received' (duration: 154.93492ms)","trace[2135779590] 'applied index is now lower than readState.Index' (duration: 5.587009ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:12:57.930888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.732714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:12:57.930995Z","caller":"traceutil/trace.go:171","msg":"trace[676544812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:372; }","duration":"161.119322ms","start":"2026-03-20T10:12:57.76986Z","end":"2026-03-20T10:12:57.930979Z","steps":["trace[676544812] 'agreement among raft nodes before linearized reading' (duration: 160.764345ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:12:57.931202Z","caller":"traceutil/trace.go:171","msg":"trace[1012346891] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"312.540267ms","start":"2026-03-20T10:12:57.618589Z","end":"2026-03-20T10:12:57.93113Z","steps":["trace[1012346891] 'process raft request' (duration: 306.234744ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:12:57.931863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:12:57.618573Z","time spent":"312.728542ms","remote":"127.0.0.1:60438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T10:13:12.120282Z","caller":"traceutil/trace.go:171","msg":"trace[456353646] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"121.729923ms","start":"2026-03-20T10:13:11.998529Z","end":"2026-03-20T10:13:12.120259Z","steps":["trace[456353646] 'process raft request' (duration: 121.5797ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:13:17.880329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.213535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-03-20T10:13:17.880423Z","caller":"traceutil/trace.go:171","msg":"trace[2130473896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:507; }","duration":"238.352848ms","start":"2026-03-20T10:13:17.64205Z","end":"2026-03-20T10:13:17.880403Z","steps":["trace[2130473896] 'range keys from in-memory index tree' (duration: 238.049461ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:13:18.071126Z","caller":"traceutil/trace.go:171","msg":"trace[105902723] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"172.185038ms","start":"2026-03-20T10:13:17.898909Z","end":"2026-03-20T10:13:18.071095Z","steps":["trace[105902723] 'process raft request' (duration: 172.036845ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:13:19.10231Z","caller":"traceutil/trace.go:171","msg":"trace[993717239] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"102.30402ms","start":"2026-03-20T10:13:18.999977Z","end":"2026-03-20T10:13:19.102281Z","steps":["trace[993717239] 'process raft request' (duration: 101.995973ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:13:19.102372Z","caller":"traceutil/trace.go:171","msg":"trace[979338188] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"100.88102ms","start":"2026-03-20T10:13:19.00146Z","end":"2026-03-20T10:13:19.102341Z","steps":["trace[979338188] 'process raft request' (duration: 100.643304ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:13:48.427044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.378484ms","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-03-20T10:13:48.427157Z","caller":"traceutil/trace.go:171","msg":"trace[1089295525] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:916; }","duration":"140.567748ms","start":"2026-03-20T10:13:48.286564Z","end":"2026-03-20T10:13:48.427131Z","steps":["trace[1089295525] 'range keys from in-memory index tree' (duration: 140.117807ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:14:14.363722Z","caller":"traceutil/trace.go:171","msg":"trace[1467467902] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"129.896701ms","start":"2026-03-20T10:14:14.233781Z","end":"2026-03-20T10:14:14.363678Z","steps":["trace[1467467902] 'process raft request' (duration: 129.549554ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:14:37.635515Z","caller":"traceutil/trace.go:171","msg":"trace[1580738986] linearizableReadLoop","detail":"{readStateIndex:1641; appliedIndex:1640; }","duration":"247.066433ms","start":"2026-03-20T10:14:37.388418Z","end":"2026-03-20T10:14:37.635484Z","steps":["trace[1580738986] 'read index received' (duration: 171.722892ms)","trace[1580738986] 'applied index is now lower than readState.Index' (duration: 75.342131ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:14:37.635938Z","caller":"traceutil/trace.go:171","msg":"trace[365679018] transaction","detail":"{read_only:false; response_revision:1579; number_of_response:1; }","duration":"303.192028ms","start":"2026-03-20T10:14:37.332711Z","end":"2026-03-20T10:14:37.635903Z","steps":["trace[365679018] 'process raft request' (duration: 227.56746ms)","trace[365679018] 'compare' (duration: 75.073026ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:14:37.635992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.092322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:14:37.636056Z","caller":"traceutil/trace.go:171","msg":"trace[124772921] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1579; }","duration":"189.255605ms","start":"2026-03-20T10:14:37.446787Z","end":"2026-03-20T10:14:37.636042Z","steps":["trace[124772921] 'agreement among raft nodes before linearized reading' (duration: 189.097272ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:14:37.636117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:14:37.332682Z","time spent":"303.363732ms","remote":"127.0.0.1:60346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T10:14:37.636422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.981213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6a97a6b7-73a9-41b8-9cbb-e2da4099a43c\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-03-20T10:14:37.636477Z","caller":"traceutil/trace.go:171","msg":"trace[118738639] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6a97a6b7-73a9-41b8-9cbb-e2da4099a43c; range_end:; response_count:1; response_revision:1579; }","duration":"248.095125ms","start":"2026-03-20T10:14:37.388367Z","end":"2026-03-20T10:14:37.636462Z","steps":["trace[118738639] 'agreement among raft nodes before linearized reading' (duration: 247.498813ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:14:37.790035Z","caller":"traceutil/trace.go:171","msg":"trace[803178413] transaction","detail":"{read_only:false; response_revision:1581; number_of_response:1; }","duration":"148.776686ms","start":"2026-03-20T10:14:37.641226Z","end":"2026-03-20T10:14:37.790002Z","steps":["trace[803178413] 'process raft request' (duration: 133.866806ms)","trace[803178413] 'compare' (duration: 14.672174ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:14:37.790178Z","caller":"traceutil/trace.go:171","msg":"trace[475486104] transaction","detail":"{read_only:false; response_revision:1584; number_of_response:1; }","duration":"147.05469ms","start":"2026-03-20T10:14:37.643094Z","end":"2026-03-20T10:14:37.790148Z","steps":["trace[475486104] 'process raft request' (duration: 146.990529ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:14:37.790255Z","caller":"traceutil/trace.go:171","msg":"trace[1355861305] transaction","detail":"{read_only:false; response_revision:1582; number_of_response:1; }","duration":"147.473269ms","start":"2026-03-20T10:14:37.64276Z","end":"2026-03-20T10:14:37.790234Z","steps":["trace[1355861305] 'process raft request' (duration: 147.165303ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:14:37.79031Z","caller":"traceutil/trace.go:171","msg":"trace[1850684514] transaction","detail":"{read_only:false; response_revision:1583; number_of_response:1; }","duration":"147.277345ms","start":"2026-03-20T10:14:37.643013Z","end":"2026-03-20T10:14:37.79029Z","steps":["trace[1850684514] 'process raft request' (duration: 146.988229ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:14:37.84439Z","caller":"traceutil/trace.go:171","msg":"trace[973245109] transaction","detail":"{read_only:false; response_revision:1585; number_of_response:1; }","duration":"148.804015ms","start":"2026-03-20T10:14:37.695565Z","end":"2026-03-20T10:14:37.844369Z","steps":["trace[973245109] 'process raft request' (duration: 148.627432ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:15:16.039469Z","caller":"traceutil/trace.go:171","msg":"trace[1557944075] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"149.326087ms","start":"2026-03-20T10:15:15.890097Z","end":"2026-03-20T10:15:16.039423Z","steps":["trace[1557944075] 'process raft request' (duration: 121.617613ms)","trace[1557944075] 'compare' (duration: 27.447999ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:15:21.440329Z","caller":"traceutil/trace.go:171","msg":"trace[702221267] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"107.124411ms","start":"2026-03-20T10:15:21.333169Z","end":"2026-03-20T10:15:21.440294Z","steps":["trace[702221267] 'process raft request' (duration: 106.890276ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:15:21.55492Z","caller":"traceutil/trace.go:171","msg":"trace[984838504] linearizableReadLoop","detail":"{readStateIndex:1925; appliedIndex:1924; }","duration":"100.347101ms","start":"2026-03-20T10:15:21.454551Z","end":"2026-03-20T10:15:21.554898Z","steps":["trace[984838504] 'read index received' (duration: 91.800284ms)","trace[984838504] 'applied index is now lower than readState.Index' (duration: 8.545647ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:15:21.554994Z","caller":"traceutil/trace.go:171","msg":"trace[1799490134] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"111.145325ms","start":"2026-03-20T10:15:21.443814Z","end":"2026-03-20T10:15:21.55496Z","steps":["trace[1799490134] 'process raft request' (duration: 102.493525ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:15:21.555061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.488464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-20T10:15:21.555116Z","caller":"traceutil/trace.go:171","msg":"trace[685150258] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1852; }","duration":"100.591767ms","start":"2026-03-20T10:15:21.454514Z","end":"2026-03-20T10:15:21.555106Z","steps":["trace[685150258] 'agreement among raft nodes before linearized reading' (duration: 100.473144ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:15:22.263676Z","caller":"traceutil/trace.go:171","msg":"trace[981174165] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"155.859152ms","start":"2026-03-20T10:15:22.10779Z","end":"2026-03-20T10:15:22.263649Z","steps":["trace[981174165] 'process raft request' (duration: 155.701269ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:15:27.808298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.88893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-03-20T10:15:27.808374Z","caller":"traceutil/trace.go:171","msg":"trace[601084817] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1880; }","duration":"124.006552ms","start":"2026-03-20T10:15:27.684348Z","end":"2026-03-20T10:15:27.808354Z","steps":["trace[601084817] 'range keys from in-memory index tree' (duration: 123.726496ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:15:28.164706Z","caller":"traceutil/trace.go:171","msg":"trace[220582401] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"165.167274ms","start":"2026-03-20T10:15:27.999509Z","end":"2026-03-20T10:15:28.164677Z","steps":["trace[220582401] 'process raft request' (duration: 164.986701ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:15:28.397594Z","caller":"traceutil/trace.go:171","msg":"trace[1321560493] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"106.447795ms","start":"2026-03-20T10:15:28.29112Z","end":"2026-03-20T10:15:28.397568Z","steps":["trace[1321560493] 'process raft request' (duration: 106.297332ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:15:28.455772Z","caller":"traceutil/trace.go:171","msg":"trace[387033886] linearizableReadLoop","detail":"{readStateIndex:1957; appliedIndex:1955; }","duration":"161.533717ms","start":"2026-03-20T10:15:28.294211Z","end":"2026-03-20T10:15:28.455745Z","steps":["trace[387033886] 'read index received' (duration: 103.239498ms)","trace[387033886] 'applied index is now lower than readState.Index' (duration: 58.292739ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:15:28.456018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.786342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-20T10:15:28.45606Z","caller":"traceutil/trace.go:171","msg":"trace[1739313784] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1883; }","duration":"161.879225ms","start":"2026-03-20T10:15:28.29417Z","end":"2026-03-20T10:15:28.456049Z","steps":["trace[1739313784] 'agreement among raft nodes before linearized reading' (duration: 161.686991ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:15:28.456071Z","caller":"traceutil/trace.go:171","msg":"trace[842497317] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"162.494848ms","start":"2026-03-20T10:15:28.29352Z","end":"2026-03-20T10:15:28.456015Z","steps":["trace[842497317] 'process raft request' (duration: 162.10874ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:16:50.688842Z","caller":"traceutil/trace.go:171","msg":"trace[1815829943] transaction","detail":"{read_only:false; response_revision:2480; number_of_response:1; }","duration":"107.003172ms","start":"2026-03-20T10:16:50.58181Z","end":"2026-03-20T10:16:50.688813Z","steps":["trace[1815829943] 'process raft request' (duration: 106.837939ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:16:50.914345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.890113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:16:50.914455Z","caller":"traceutil/trace.go:171","msg":"trace[1719376622] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2480; }","duration":"145.031527ms","start":"2026-03-20T10:16:50.7694Z","end":"2026-03-20T10:16:50.914431Z","steps":["trace[1719376622] 'range keys from in-memory index tree' (duration: 144.788342ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:18:47.611129Z","caller":"traceutil/trace.go:171","msg":"trace[67245593] transaction","detail":"{read_only:false; number_of_response:1; response_revision:3071; }","duration":"140.888485ms","start":"2026-03-20T10:18:47.470208Z","end":"2026-03-20T10:18:47.611097Z","steps":["trace[67245593] 'process raft request' (duration: 140.64299ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:20:52.424857Z","caller":"traceutil/trace.go:171","msg":"trace[299448389] linearizableReadLoop","detail":"{readStateIndex:4496; appliedIndex:4495; }","duration":"132.056453ms","start":"2026-03-20T10:20:52.292757Z","end":"2026-03-20T10:20:52.424814Z","steps":["trace[299448389] 'read index received' (duration: 126.462085ms)","trace[299448389] 'applied index is now lower than readState.Index' (duration: 5.592098ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:20:52.425444Z","caller":"traceutil/trace.go:171","msg":"trace[1182967394] transaction","detail":"{read_only:false; response_revision:4322; number_of_response:1; }","duration":"135.396535ms","start":"2026-03-20T10:20:52.289996Z","end":"2026-03-20T10:20:52.425393Z","steps":["trace[1182967394] 'process raft request' (duration: 129.251864ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:20:52.42551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.718808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-03-20T10:20:52.425712Z","caller":"traceutil/trace.go:171","msg":"trace[1060637318] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4322; }","duration":"132.976253ms","start":"2026-03-20T10:20:52.292705Z","end":"2026-03-20T10:20:52.425681Z","steps":["trace[1060637318] 'agreement among raft nodes before linearized reading' (duration: 132.595395ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:20:52.42735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.824111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:49 size:1957116"} {"level":"info","ts":"2026-03-20T10:20:52.427438Z","caller":"traceutil/trace.go:171","msg":"trace[586956348] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:49; response_revision:4322; }","duration":"125.981625ms","start":"2026-03-20T10:20:52.301436Z","end":"2026-03-20T10:20:52.427418Z","steps":["trace[586956348] 'agreement among raft nodes before linearized reading' (duration: 124.186297ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:21:00.967153Z","caller":"traceutil/trace.go:171","msg":"trace[692254103] linearizableReadLoop","detail":"{readStateIndex:4777; appliedIndex:4776; }","duration":"110.114175ms","start":"2026-03-20T10:21:00.857009Z","end":"2026-03-20T10:21:00.967123Z","steps":["trace[692254103] 'read index received' (duration: 109.830679ms)","trace[692254103] 'applied index is now lower than readState.Index' (duration: 282.496µs)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:21:00.967242Z","caller":"traceutil/trace.go:171","msg":"trace[1096882220] transaction","detail":"{read_only:false; response_revision:4594; number_of_response:1; }","duration":"161.922903ms","start":"2026-03-20T10:21:00.805275Z","end":"2026-03-20T10:21:00.967198Z","steps":["trace[1096882220] 'process raft request' (duration: 161.658027ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:21:00.967469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.438362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"} {"level":"info","ts":"2026-03-20T10:21:00.967537Z","caller":"traceutil/trace.go:171","msg":"trace[188537391] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:4594; }","duration":"110.578905ms","start":"2026-03-20T10:21:00.856938Z","end":"2026-03-20T10:21:00.967516Z","steps":["trace[188537391] 'agreement among raft nodes before linearized reading' (duration: 110.34984ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:21:12.482355Z","caller":"traceutil/trace.go:171","msg":"trace[1659641572] transaction","detail":"{read_only:false; response_revision:4813; number_of_response:1; }","duration":"149.256904ms","start":"2026-03-20T10:21:12.333064Z","end":"2026-03-20T10:21:12.482321Z","steps":["trace[1659641572] 'process raft request' (duration: 117.890799ms)","trace[1659641572] 'compare' (duration: 31.149001ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:21:12.482693Z","caller":"traceutil/trace.go:171","msg":"trace[1553693582] transaction","detail":"{read_only:false; response_revision:4814; number_of_response:1; }","duration":"125.045761ms","start":"2026-03-20T10:21:12.357622Z","end":"2026-03-20T10:21:12.482667Z","steps":["trace[1553693582] 'process raft request' (duration: 124.652012ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:21:13.114152Z","caller":"traceutil/trace.go:171","msg":"trace[1020723517] transaction","detail":"{read_only:false; response_revision:4827; number_of_response:1; }","duration":"107.762085ms","start":"2026-03-20T10:21:13.006359Z","end":"2026-03-20T10:21:13.114122Z","steps":["trace[1020723517] 'process raft request' (duration: 107.641933ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:21:13.114203Z","caller":"traceutil/trace.go:171","msg":"trace[1359346070] linearizableReadLoop","detail":"{readStateIndex:5015; appliedIndex:5014; }","duration":"279.570327ms","start":"2026-03-20T10:21:12.834599Z","end":"2026-03-20T10:21:13.114169Z","steps":["trace[1359346070] 'read index received' (duration: 266.862918ms)","trace[1359346070] 'applied index is now lower than readState.Index' (duration: 12.705929ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:21:13.114515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.883255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-s642x\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-03-20T10:21:13.11457Z","caller":"traceutil/trace.go:171","msg":"trace[231741620] range","detail":"{range_begin:/registry/pods/openstack/keepalived-s642x; range_end:; response_count:1; response_revision:4827; }","duration":"280.022507ms","start":"2026-03-20T10:21:12.834533Z","end":"2026-03-20T10:21:13.114556Z","steps":["trace[231741620] 'agreement among raft nodes before linearized reading' (duration: 279.750922ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:21:13.114279Z","caller":"traceutil/trace.go:171","msg":"trace[1686574461] transaction","detail":"{read_only:false; response_revision:4826; number_of_response:1; }","duration":"281.583231ms","start":"2026-03-20T10:21:12.832608Z","end":"2026-03-20T10:21:13.114191Z","steps":["trace[1686574461] 'process raft request' (duration: 268.83794ms)","trace[1686574461] 'compare' (duration: 12.099737ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:21:21.146783Z","caller":"traceutil/trace.go:171","msg":"trace[1237450960] transaction","detail":"{read_only:false; response_revision:5000; number_of_response:1; }","duration":"100.222475ms","start":"2026-03-20T10:21:21.046518Z","end":"2026-03-20T10:21:21.14674Z","steps":["trace[1237450960] 'process raft request' (duration: 99.98861ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:21:21.323525Z","caller":"traceutil/trace.go:171","msg":"trace[997886100] linearizableReadLoop","detail":"{readStateIndex:5194; appliedIndex:5193; }","duration":"162.106767ms","start":"2026-03-20T10:21:21.161382Z","end":"2026-03-20T10:21:21.323489Z","steps":["trace[997886100] 'read index received' (duration: 65.452098ms)","trace[997886100] 'applied index is now lower than readState.Index' (duration: 96.653109ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:21:21.323689Z","caller":"traceutil/trace.go:171","msg":"trace[1728665385] transaction","detail":"{read_only:false; response_revision:5001; number_of_response:1; }","duration":"183.239195ms","start":"2026-03-20T10:21:21.140436Z","end":"2026-03-20T10:21:21.323675Z","steps":["trace[1728665385] 'process raft request' (duration: 86.373121ms)","trace[1728665385] 'compare' (duration: 96.440785ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:21:21.323878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.994233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-s642x\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-03-20T10:21:21.323979Z","caller":"traceutil/trace.go:171","msg":"trace[632683876] range","detail":"{range_begin:/registry/pods/openstack/keepalived-s642x; range_end:; response_count:1; response_revision:5001; }","duration":"161.112265ms","start":"2026-03-20T10:21:21.162832Z","end":"2026-03-20T10:21:21.323944Z","steps":["trace[632683876] 'agreement among raft nodes before linearized reading' (duration: 160.882911ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:21:21.324225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.824864ms","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-03-20T10:21:21.324368Z","caller":"traceutil/trace.go:171","msg":"trace[1986288009] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5001; }","duration":"163.029948ms","start":"2026-03-20T10:21:21.161314Z","end":"2026-03-20T10:21:21.324344Z","steps":["trace[1986288009] 'agreement among raft nodes before linearized reading' (duration: 162.615168ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:21:21.324268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.2136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d4764e78-45f1-41d2-ab0b-d51e4bba0dc3\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-03-20T10:21:21.324849Z","caller":"traceutil/trace.go:171","msg":"trace[2002906856] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d4764e78-45f1-41d2-ab0b-d51e4bba0dc3; range_end:; response_count:1; response_revision:5001; }","duration":"112.895615ms","start":"2026-03-20T10:21:21.211927Z","end":"2026-03-20T10:21:21.324823Z","steps":["trace[2002906856] 'agreement among raft nodes before linearized reading' (duration: 112.046556ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:21:21.83076Z","caller":"traceutil/trace.go:171","msg":"trace[515404544] linearizableReadLoop","detail":"{readStateIndex:5196; appliedIndex:5195; }","duration":"167.782527ms","start":"2026-03-20T10:21:21.662947Z","end":"2026-03-20T10:21:21.83073Z","steps":["trace[515404544] 'read index received' (duration: 167.43316ms)","trace[515404544] 'applied index is now lower than readState.Index' (duration: 347.847µs)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:21:21.830845Z","caller":"traceutil/trace.go:171","msg":"trace[1199094734] transaction","detail":"{read_only:false; response_revision:5003; number_of_response:1; }","duration":"173.872397ms","start":"2026-03-20T10:21:21.656918Z","end":"2026-03-20T10:21:21.83079Z","steps":["trace[1199094734] 'process raft request' (duration: 173.583811ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:21:21.831076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.908212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-03-20T10:21:21.831121Z","caller":"traceutil/trace.go:171","msg":"trace[448003082] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5003; }","duration":"161.003953ms","start":"2026-03-20T10:21:21.670101Z","end":"2026-03-20T10:21:21.831105Z","steps":["trace[448003082] 'agreement among raft nodes before linearized reading' (duration: 160.811559ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:21:21.831158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.162705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-03-20T10:21:21.831266Z","caller":"traceutil/trace.go:171","msg":"trace[822675530] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5003; }","duration":"168.31968ms","start":"2026-03-20T10:21:21.662919Z","end":"2026-03-20T10:21:21.831239Z","steps":["trace[822675530] 'agreement among raft nodes before linearized reading' (duration: 167.977102ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:22:42.069319Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2736} {"level":"info","ts":"2026-03-20T10:22:42.133541Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2736,"took":"62.781413ms","hash":3104030476,"current-db-size-bytes":40677376,"current-db-size":"41 MB","current-db-size-in-use-bytes":30765056,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-03-20T10:22:42.133616Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3104030476,"revision":2736,"compact-revision":-1} {"level":"info","ts":"2026-03-20T10:27:40.07798Z","caller":"traceutil/trace.go:171","msg":"trace[1988808531] linearizableReadLoop","detail":"{readStateIndex:7981; appliedIndex:7980; }","duration":"204.958934ms","start":"2026-03-20T10:27:39.87299Z","end":"2026-03-20T10:27:40.077949Z","steps":["trace[1988808531] 'read index received' (duration: 204.725449ms)","trace[1988808531] 'applied index is now lower than readState.Index' (duration: 232.475µs)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:27:40.078123Z","caller":"traceutil/trace.go:171","msg":"trace[2142201193] transaction","detail":"{read_only:false; response_revision:7696; number_of_response:1; }","duration":"246.287625ms","start":"2026-03-20T10:27:39.831784Z","end":"2026-03-20T10:27:40.078071Z","steps":["trace[2142201193] 'process raft request' (duration: 246.000279ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:27:40.078205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.188029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-s642x\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-03-20T10:27:40.078284Z","caller":"traceutil/trace.go:171","msg":"trace[102011665] range","detail":"{range_begin:/registry/pods/openstack/keepalived-s642x; range_end:; response_count:1; response_revision:7696; }","duration":"205.305901ms","start":"2026-03-20T10:27:39.872963Z","end":"2026-03-20T10:27:40.078269Z","steps":["trace[102011665] 'agreement among raft nodes before linearized reading' (duration: 205.106457ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:27:42.093874Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5684} {"level":"info","ts":"2026-03-20T10:27:42.329735Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5684,"took":"233.513525ms","hash":206687153,"current-db-size-bytes":43073536,"current-db-size":"43 MB","current-db-size-in-use-bytes":23367680,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-03-20T10:27:42.329787Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":206687153,"revision":5684,"compact-revision":2736} {"level":"info","ts":"2026-03-20T10:27:51.45587Z","caller":"traceutil/trace.go:171","msg":"trace[1685609234] transaction","detail":"{read_only:false; response_revision:7752; number_of_response:1; }","duration":"108.654193ms","start":"2026-03-20T10:27:51.347186Z","end":"2026-03-20T10:27:51.45584Z","steps":["trace[1685609234] 'process raft request' (duration: 108.213093ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:27:52.390922Z","caller":"traceutil/trace.go:171","msg":"trace[1690393116] linearizableReadLoop","detail":"{readStateIndex:8042; appliedIndex:8041; }","duration":"195.068295ms","start":"2026-03-20T10:27:52.195825Z","end":"2026-03-20T10:27:52.390893Z","steps":["trace[1690393116] 'read index received' (duration: 194.976063ms)","trace[1690393116] 'applied index is now lower than readState.Index' (duration: 90.732µs)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:27:52.390969Z","caller":"traceutil/trace.go:171","msg":"trace[915629341] transaction","detail":"{read_only:false; response_revision:7753; number_of_response:1; }","duration":"198.944356ms","start":"2026-03-20T10:27:52.191994Z","end":"2026-03-20T10:27:52.390938Z","steps":["trace[915629341] 'process raft request' (duration: 198.730752ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:27:52.391135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.298389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-s642x\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-03-20T10:27:52.391181Z","caller":"traceutil/trace.go:171","msg":"trace[1082111332] range","detail":"{range_begin:/registry/pods/openstack/keepalived-s642x; range_end:; response_count:1; response_revision:7753; }","duration":"195.418443ms","start":"2026-03-20T10:27:52.195749Z","end":"2026-03-20T10:27:52.391167Z","steps":["trace[1082111332] 'agreement among raft nodes before linearized reading' (duration: 195.246779ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:27:52.536975Z","caller":"traceutil/trace.go:171","msg":"trace[291660455] linearizableReadLoop","detail":"{readStateIndex:8043; appliedIndex:8042; }","duration":"141.425682ms","start":"2026-03-20T10:27:52.395519Z","end":"2026-03-20T10:27:52.536945Z","steps":["trace[291660455] 'read index received' (duration: 130.631485ms)","trace[291660455] 'applied index is now lower than readState.Index' (duration: 10.792877ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:27:52.537135Z","caller":"traceutil/trace.go:171","msg":"trace[510793522] transaction","detail":"{read_only:false; response_revision:7754; number_of_response:1; }","duration":"293.987231ms","start":"2026-03-20T10:27:52.243133Z","end":"2026-03-20T10:27:52.53712Z","steps":["trace[510793522] 'process raft request' (duration: 283.04166ms)","trace[510793522] 'compare' (duration: 10.631775ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:27:52.537728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.162797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:224145"} {"level":"info","ts":"2026-03-20T10:27:52.537881Z","caller":"traceutil/trace.go:171","msg":"trace[2102417690] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:7754; }","duration":"142.346852ms","start":"2026-03-20T10:27:52.395477Z","end":"2026-03-20T10:27:52.537824Z","steps":["trace[2102417690] 'agreement among raft nodes before linearized reading' (duration: 141.650957ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:27:52.559321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.059893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:27:52.559404Z","caller":"traceutil/trace.go:171","msg":"trace[138883027] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:7755; }","duration":"121.169856ms","start":"2026-03-20T10:27:52.438211Z","end":"2026-03-20T10:27:52.559381Z","steps":["trace[138883027] 'agreement among raft nodes before linearized reading' (duration: 120.998132ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:27:52.559441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.242267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:27:52.559475Z","caller":"traceutil/trace.go:171","msg":"trace[1362608796] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:7755; }","duration":"121.301228ms","start":"2026-03-20T10:27:52.438164Z","end":"2026-03-20T10:27:52.559465Z","steps":["trace[1362608796] 'agreement among raft nodes before linearized reading' (duration: 121.212886ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:27:52.559575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.525603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:27:52.559605Z","caller":"traceutil/trace.go:171","msg":"trace[566226061] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:7755; }","duration":"140.561415ms","start":"2026-03-20T10:27:52.419034Z","end":"2026-03-20T10:27:52.559596Z","steps":["trace[566226061] 'agreement among raft nodes before linearized reading' (duration: 140.523794ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:27:52.559544Z","caller":"traceutil/trace.go:171","msg":"trace[334942799] transaction","detail":"{read_only:false; response_revision:7755; number_of_response:1; }","duration":"150.418663ms","start":"2026-03-20T10:27:52.409049Z","end":"2026-03-20T10:27:52.559468Z","steps":["trace[334942799] 'process raft request' (duration: 149.871732ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:27:52.559318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.758778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:27:52.559693Z","caller":"traceutil/trace.go:171","msg":"trace[268416602] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:7755; }","duration":"141.169317ms","start":"2026-03-20T10:27:52.418511Z","end":"2026-03-20T10:27:52.559681Z","steps":["trace[268416602] 'agreement among raft nodes before linearized reading' (duration: 140.740078ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:27:52.55981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.612086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:27:52.559837Z","caller":"traceutil/trace.go:171","msg":"trace[1636911453] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:7755; }","duration":"104.674197ms","start":"2026-03-20T10:27:52.455157Z","end":"2026-03-20T10:27:52.559831Z","steps":["trace[1636911453] 'agreement among raft nodes before linearized reading' (duration: 104.622946ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:27:52.55981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.239847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:27:52.559943Z","caller":"traceutil/trace.go:171","msg":"trace[1624131143] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:7755; }","duration":"121.40443ms","start":"2026-03-20T10:27:52.438519Z","end":"2026-03-20T10:27:52.559924Z","steps":["trace[1624131143] 'agreement among raft nodes before linearized reading' (duration: 121.141574ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:27:52.560128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.981774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:27:52.560192Z","caller":"traceutil/trace.go:171","msg":"trace[853010076] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:7755; }","duration":"105.074665ms","start":"2026-03-20T10:27:52.455104Z","end":"2026-03-20T10:27:52.560179Z","steps":["trace[853010076] 'agreement among raft nodes before linearized reading' (duration: 104.988973ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:27:52.559997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.489813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-20T10:27:52.560305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.468624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-03-20T10:27:52.560334Z","caller":"traceutil/trace.go:171","msg":"trace[1394158705] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:7755; }","duration":"104.829841ms","start":"2026-03-20T10:27:52.455471Z","end":"2026-03-20T10:27:52.560301Z","steps":["trace[1394158705] 'agreement among raft nodes before linearized reading' (duration: 104.503624ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:27:52.560371Z","caller":"traceutil/trace.go:171","msg":"trace[228278314] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7755; }","duration":"142.556156ms","start":"2026-03-20T10:27:52.417801Z","end":"2026-03-20T10:27:52.560357Z","steps":["trace[228278314] 'agreement among raft nodes before linearized reading' (duration: 142.391262ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:27:52.561033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.467704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:27:52.561105Z","caller":"traceutil/trace.go:171","msg":"trace[1542873382] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:7755; }","duration":"142.610738ms","start":"2026-03-20T10:27:52.418475Z","end":"2026-03-20T10:27:52.561086Z","steps":["trace[1542873382] 'agreement among raft nodes before linearized reading' (duration: 141.446133ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:27:53.650911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.450838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-03-20T10:27:53.650999Z","caller":"traceutil/trace.go:171","msg":"trace[615796420] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7760; }","duration":"309.58753ms","start":"2026-03-20T10:27:53.341388Z","end":"2026-03-20T10:27:53.650976Z","steps":["trace[615796420] 'range keys from in-memory index tree' (duration: 309.262983ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:27:53.651045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:27:53.341372Z","time spent":"309.663352ms","remote":"127.0.0.1:60346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-03-20T10:27:53.675493Z","caller":"traceutil/trace.go:171","msg":"trace[2139114271] transaction","detail":"{read_only:false; response_revision:7761; number_of_response:1; }","duration":"215.317091ms","start":"2026-03-20T10:27:53.460137Z","end":"2026-03-20T10:27:53.675454Z","steps":["trace[2139114271] 'process raft request' (duration: 215.020634ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:27:54.704974Z","caller":"traceutil/trace.go:171","msg":"trace[487087793] transaction","detail":"{read_only:false; response_revision:7763; number_of_response:1; }","duration":"137.885028ms","start":"2026-03-20T10:27:54.567059Z","end":"2026-03-20T10:27:54.704944Z","steps":["trace[487087793] 'process raft request' (duration: 120.259347ms)","trace[487087793] 'compare' (duration: 17.221413ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:27:54.705026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.906212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-s642x\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-03-20T10:27:54.705095Z","caller":"traceutil/trace.go:171","msg":"trace[1053507736] range","detail":"{range_begin:/registry/pods/openstack/keepalived-s642x; range_end:; response_count:1; response_revision:7762; }","duration":"159.036915ms","start":"2026-03-20T10:27:54.546041Z","end":"2026-03-20T10:27:54.705077Z","steps":["trace[1053507736] 'range keys from in-memory index tree' (duration: 158.34735ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:27:54.742269Z","caller":"traceutil/trace.go:171","msg":"trace[658338300] linearizableReadLoop","detail":"{readStateIndex:8053; appliedIndex:8051; }","duration":"132.565725ms","start":"2026-03-20T10:27:54.609659Z","end":"2026-03-20T10:27:54.742224Z","steps":["trace[658338300] 'read index received' (duration: 77.810011ms)","trace[658338300] 'applied index is now lower than readState.Index' (duration: 54.753634ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:27:54.742293Z","caller":"traceutil/trace.go:171","msg":"trace[1303396787] transaction","detail":"{read_only:false; response_revision:7764; number_of_response:1; }","duration":"160.449734ms","start":"2026-03-20T10:27:54.581806Z","end":"2026-03-20T10:27:54.742256Z","steps":["trace[1303396787] 'process raft request' (duration: 160.26674ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:27:54.742572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.883063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-03-20T10:27:54.742677Z","caller":"traceutil/trace.go:171","msg":"trace[391801230] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7764; }","duration":"133.026055ms","start":"2026-03-20T10:27:54.609623Z","end":"2026-03-20T10:27:54.742649Z","steps":["trace[391801230] 'agreement among raft nodes before linearized reading' (duration: 132.703968ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:27:54.877446Z","caller":"traceutil/trace.go:171","msg":"trace[279579674] linearizableReadLoop","detail":"{readStateIndex:8054; appliedIndex:8053; }","duration":"107.262883ms","start":"2026-03-20T10:27:54.770158Z","end":"2026-03-20T10:27:54.87742Z","steps":["trace[279579674] 'read index received' (duration: 107.011567ms)","trace[279579674] 'applied index is now lower than readState.Index' (duration: 250.256µs)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:27:54.877704Z","caller":"traceutil/trace.go:171","msg":"trace[1276239939] transaction","detail":"{read_only:false; response_revision:7765; number_of_response:1; }","duration":"130.250087ms","start":"2026-03-20T10:27:54.747442Z","end":"2026-03-20T10:27:54.877692Z","steps":["trace[1276239939] 'process raft request' (duration: 129.817548ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:27:54.87782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.650091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:27:54.877879Z","caller":"traceutil/trace.go:171","msg":"trace[2093656434] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7765; }","duration":"107.755393ms","start":"2026-03-20T10:27:54.770109Z","end":"2026-03-20T10:27:54.877864Z","steps":["trace[2093656434] 'agreement among raft nodes before linearized reading' (duration: 107.64047ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:27:54.954321Z","caller":"traceutil/trace.go:171","msg":"trace[1122405282] transaction","detail":"{read_only:false; response_revision:7766; number_of_response:1; }","duration":"134.632169ms","start":"2026-03-20T10:27:54.819654Z","end":"2026-03-20T10:27:54.954286Z","steps":["trace[1122405282] 'process raft request' (duration: 134.405965ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:27:54.954494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.426118ms","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-03-20T10:27:54.954589Z","caller":"traceutil/trace.go:171","msg":"trace[428745888] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7767; }","duration":"118.58131ms","start":"2026-03-20T10:27:54.835986Z","end":"2026-03-20T10:27:54.954567Z","steps":["trace[428745888] 'agreement among raft nodes before linearized reading' (duration: 118.330075ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:27:55.072226Z","caller":"traceutil/trace.go:171","msg":"trace[509469028] transaction","detail":"{read_only:false; response_revision:7768; number_of_response:1; }","duration":"112.561004ms","start":"2026-03-20T10:27:54.959604Z","end":"2026-03-20T10:27:55.072165Z","steps":["trace[509469028] 'process raft request' (duration: 39.432091ms)","trace[509469028] 'compare' (duration: 72.820996ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:28:19.834899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.407809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-20T10:28:19.835007Z","caller":"traceutil/trace.go:171","msg":"trace[1875611344] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:7944; }","duration":"119.580853ms","start":"2026-03-20T10:28:19.715403Z","end":"2026-03-20T10:28:19.834984Z","steps":["trace[1875611344] 'count revisions from in-memory index tree' (duration: 119.294946ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:28:23.362203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.064478ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T10:28:23.362301Z","caller":"traceutil/trace.go:171","msg":"trace[1459463715] linearizableReadLoop","detail":"{readStateIndex:8255; appliedIndex:8254; }","duration":"454.511416ms","start":"2026-03-20T10:28:22.907774Z","end":"2026-03-20T10:28:23.362286Z","steps":["trace[1459463715] 'read index received' (duration: 165.006569ms)","trace[1459463715] 'applied index is now lower than readState.Index' (duration: 289.503567ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:28:23.36238Z","caller":"traceutil/trace.go:171","msg":"trace[231545632] transaction","detail":"{read_only:false; response_revision:7958; number_of_response:1; }","duration":"497.912402ms","start":"2026-03-20T10:28:22.864459Z","end":"2026-03-20T10:28:23.362371Z","steps":["trace[231545632] 'process raft request' (duration: 208.436125ms)","trace[231545632] 'compare' (duration: 288.868404ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:28:23.362433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:28:22.864433Z","time spent":"497.975444ms","remote":"127.0.0.1:60438","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-03-20T10:28:23.362658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.452295ms","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-03-20T10:28:23.36272Z","caller":"traceutil/trace.go:171","msg":"trace[409292030] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7958; }","duration":"316.557237ms","start":"2026-03-20T10:28:23.046146Z","end":"2026-03-20T10:28:23.362703Z","steps":["trace[409292030] 'agreement among raft nodes before linearized reading' (duration: 316.356563ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:28:23.362728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.989603ms","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-03-20T10:28:23.36276Z","caller":"traceutil/trace.go:171","msg":"trace[1590092306] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:7958; }","duration":"231.023654ms","start":"2026-03-20T10:28:23.13173Z","end":"2026-03-20T10:28:23.362754Z","steps":["trace[1590092306] 'agreement among raft nodes before linearized reading' (duration: 230.960343ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:28:23.36277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:28:23.046107Z","time spent":"316.648399ms","remote":"127.0.0.1:60438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-20T10:28:23.36282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.599263ms","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-03-20T10:28:23.362909Z","caller":"traceutil/trace.go:171","msg":"trace[502226435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7958; }","duration":"147.748046ms","start":"2026-03-20T10:28:23.215127Z","end":"2026-03-20T10:28:23.362875Z","steps":["trace[502226435] 'agreement among raft nodes before linearized reading' (duration: 147.46544ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:28:23.362882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.962446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-s642x\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-03-20T10:28:23.36322Z","caller":"traceutil/trace.go:171","msg":"trace[2001126991] range","detail":"{range_begin:/registry/pods/openstack/keepalived-s642x; range_end:; response_count:1; response_revision:7958; }","duration":"455.471897ms","start":"2026-03-20T10:28:22.907722Z","end":"2026-03-20T10:28:23.363194Z","steps":["trace[2001126991] 'agreement among raft nodes before linearized reading' (duration: 454.839764ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:28:23.363311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:28:22.907698Z","time spent":"455.598129ms","remote":"127.0.0.1:60346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6554,"request content":"key:\"/registry/pods/openstack/keepalived-s642x\" "} {"level":"info","ts":"2026-03-20T10:28:23.526682Z","caller":"traceutil/trace.go:171","msg":"trace[48335144] transaction","detail":"{read_only:false; response_revision:7961; number_of_response:1; }","duration":"158.842679ms","start":"2026-03-20T10:28:23.367817Z","end":"2026-03-20T10:28:23.52666Z","steps":["trace[48335144] 'process raft request' (duration: 158.776818ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:28:23.526827Z","caller":"traceutil/trace.go:171","msg":"trace[1345309439] linearizableReadLoop","detail":"{readStateIndex:8258; appliedIndex:8255; }","duration":"154.876837ms","start":"2026-03-20T10:28:23.371924Z","end":"2026-03-20T10:28:23.526801Z","steps":["trace[1345309439] 'read index received' (duration: 44.707673ms)","trace[1345309439] 'applied index is now lower than readState.Index' (duration: 110.167674ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:28:23.526892Z","caller":"traceutil/trace.go:171","msg":"trace[1646814237] transaction","detail":"{read_only:false; response_revision:7962; number_of_response:1; }","duration":"132.033166ms","start":"2026-03-20T10:28:23.394852Z","end":"2026-03-20T10:28:23.526885Z","steps":["trace[1646814237] 'process raft request' (duration: 131.776229ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:28:23.526827Z","caller":"traceutil/trace.go:171","msg":"trace[697365416] transaction","detail":"{read_only:false; response_revision:7960; number_of_response:1; }","duration":"159.272579ms","start":"2026-03-20T10:28:23.367528Z","end":"2026-03-20T10:28:23.526801Z","steps":["trace[697365416] 'process raft request' (duration: 157.882869ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:28:23.527232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.284946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228876"} {"level":"info","ts":"2026-03-20T10:28:23.527265Z","caller":"traceutil/trace.go:171","msg":"trace[928820159] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:7962; }","duration":"155.391838ms","start":"2026-03-20T10:28:23.371863Z","end":"2026-03-20T10:28:23.527255Z","steps":["trace[928820159] 'agreement among raft nodes before linearized reading' (duration: 155.058012ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:28:26.967546Z","caller":"traceutil/trace.go:171","msg":"trace[1780397547] transaction","detail":"{read_only:false; response_revision:7979; number_of_response:1; }","duration":"100.4932ms","start":"2026-03-20T10:28:26.867028Z","end":"2026-03-20T10:28:26.967521Z","steps":["trace[1780397547] 'process raft request' (duration: 100.342957ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:28:36.068442Z","caller":"traceutil/trace.go:171","msg":"trace[169182497] linearizableReadLoop","detail":"{readStateIndex:8368; appliedIndex:8367; }","duration":"138.864979ms","start":"2026-03-20T10:28:35.929546Z","end":"2026-03-20T10:28:36.068411Z","steps":["trace[169182497] 'read index received' (duration: 130.883421ms)","trace[169182497] 'applied index is now lower than readState.Index' (duration: 7.980118ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:28:36.068695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.129005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-npqqc\" ","response":"range_response_count:1 size:2804"} {"level":"info","ts":"2026-03-20T10:28:36.068741Z","caller":"traceutil/trace.go:171","msg":"trace[147330696] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-npqqc; range_end:; response_count:1; response_revision:8065; }","duration":"139.256627ms","start":"2026-03-20T10:28:35.929468Z","end":"2026-03-20T10:28:36.068725Z","steps":["trace[147330696] 'agreement among raft nodes before linearized reading' (duration: 139.064203ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:28:36.0688Z","caller":"traceutil/trace.go:171","msg":"trace[7737093] transaction","detail":"{read_only:false; response_revision:8065; number_of_response:1; }","duration":"141.939504ms","start":"2026-03-20T10:28:35.926832Z","end":"2026-03-20T10:28:36.068772Z","steps":["trace[7737093] 'process raft request' (duration: 133.67832ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:28:36.685968Z","caller":"traceutil/trace.go:171","msg":"trace[1093323145] transaction","detail":"{read_only:false; response_revision:8069; number_of_response:1; }","duration":"192.614473ms","start":"2026-03-20T10:28:36.493328Z","end":"2026-03-20T10:28:36.685942Z","steps":["trace[1093323145] 'process raft request' (duration: 192.44185ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:28:36.95387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.64527ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T10:28:36.953995Z","caller":"traceutil/trace.go:171","msg":"trace[1871197461] linearizableReadLoop","detail":"{readStateIndex:8373; appliedIndex:8372; }","duration":"184.41826ms","start":"2026-03-20T10:28:36.769557Z","end":"2026-03-20T10:28:36.953975Z","steps":["trace[1871197461] 'read index received' (duration: 31.523584ms)","trace[1871197461] 'applied index is now lower than readState.Index' (duration: 152.892926ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:28:36.954076Z","caller":"traceutil/trace.go:171","msg":"trace[1635649790] transaction","detail":"{read_only:false; response_revision:8070; number_of_response:1; }","duration":"226.11627ms","start":"2026-03-20T10:28:36.727917Z","end":"2026-03-20T10:28:36.954033Z","steps":["trace[1635649790] 'process raft request' (duration: 73.203164ms)","trace[1635649790] 'compare' (duration: 152.402314ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:28:36.954133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.582943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:28:36.954183Z","caller":"traceutil/trace.go:171","msg":"trace[1443287552] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8070; }","duration":"184.681695ms","start":"2026-03-20T10:28:36.769488Z","end":"2026-03-20T10:28:36.954169Z","steps":["trace[1443287552] 'agreement among raft nodes before linearized reading' (duration: 184.568512ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:28:37.115248Z","caller":"traceutil/trace.go:171","msg":"trace[1217808136] linearizableReadLoop","detail":"{readStateIndex:8374; appliedIndex:8373; }","duration":"161.192309ms","start":"2026-03-20T10:28:36.954023Z","end":"2026-03-20T10:28:37.115215Z","steps":["trace[1217808136] 'read index received' (duration: 160.923614ms)","trace[1217808136] 'applied index is now lower than readState.Index' (duration: 266.365µs)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:28:37.115261Z","caller":"traceutil/trace.go:171","msg":"trace[447614277] transaction","detail":"{read_only:false; response_revision:8071; number_of_response:1; }","duration":"203.510441ms","start":"2026-03-20T10:28:36.911707Z","end":"2026-03-20T10:28:37.115218Z","steps":["trace[447614277] 'process raft request' (duration: 203.168644ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:28:37.115556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.203096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"} {"level":"info","ts":"2026-03-20T10:28:37.115657Z","caller":"traceutil/trace.go:171","msg":"trace[627811395] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:8071; }","duration":"277.37399ms","start":"2026-03-20T10:28:36.838258Z","end":"2026-03-20T10:28:37.115632Z","steps":["trace[627811395] 'agreement among raft nodes before linearized reading' (duration: 277.087184ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:28:37.126598Z","caller":"traceutil/trace.go:171","msg":"trace[1718457944] transaction","detail":"{read_only:false; response_revision:8072; number_of_response:1; }","duration":"117.955928ms","start":"2026-03-20T10:28:37.008629Z","end":"2026-03-20T10:28:37.126585Z","steps":["trace[1718457944] 'process raft request' (duration: 117.720193ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:28:37.126833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.253602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:28:37.126878Z","caller":"traceutil/trace.go:171","msg":"trace[1871748826] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8072; }","duration":"171.338294ms","start":"2026-03-20T10:28:36.955528Z","end":"2026-03-20T10:28:37.126867Z","steps":["trace[1871748826] 'agreement among raft nodes before linearized reading' (duration: 171.257982ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:28:37.700589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.220289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-03-20T10:28:37.700671Z","caller":"traceutil/trace.go:171","msg":"trace[756920751] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8075; }","duration":"104.358512ms","start":"2026-03-20T10:28:37.596295Z","end":"2026-03-20T10:28:37.700654Z","steps":["trace[756920751] 'range keys from in-memory index tree' (duration: 104.021244ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:28:37.701415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.404338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2210989"} {"level":"warn","ts":"2026-03-20T10:28:37.701421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.798953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-03-20T10:28:37.701474Z","caller":"traceutil/trace.go:171","msg":"trace[830698055] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:8075; }","duration":"220.50449ms","start":"2026-03-20T10:28:37.480953Z","end":"2026-03-20T10:28:37.701457Z","steps":["trace[830698055] 'range keys from in-memory index tree' (duration: 219.447259ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:28:37.701502Z","caller":"traceutil/trace.go:171","msg":"trace[209381063] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8075; }","duration":"217.941906ms","start":"2026-03-20T10:28:37.48354Z","end":"2026-03-20T10:28:37.701482Z","steps":["trace[209381063] 'range keys from in-memory index tree' (duration: 217.627459ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:28:37.701781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.919117ms","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-03-20T10:28:37.70183Z","caller":"traceutil/trace.go:171","msg":"trace[1438280171] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8075; }","duration":"108.022908ms","start":"2026-03-20T10:28:37.593792Z","end":"2026-03-20T10:28:37.701815Z","steps":["trace[1438280171] 'range keys from in-memory index tree' (duration: 107.819024ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:28:37.701432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.69876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-03-20T10:28:37.702023Z","caller":"traceutil/trace.go:171","msg":"trace[1079974151] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8075; }","duration":"107.290704ms","start":"2026-03-20T10:28:37.594723Z","end":"2026-03-20T10:28:37.702014Z","steps":["trace[1079974151] 'range keys from in-memory index tree' (duration: 105.699319ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:28:37.870023Z","caller":"traceutil/trace.go:171","msg":"trace[578473006] transaction","detail":"{read_only:false; response_revision:8077; number_of_response:1; }","duration":"163.07762ms","start":"2026-03-20T10:28:37.706902Z","end":"2026-03-20T10:28:37.86998Z","steps":["trace[578473006] 'process raft request' (duration: 162.732502ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:28:37.870352Z","caller":"traceutil/trace.go:171","msg":"trace[221440659] transaction","detail":"{read_only:false; response_revision:8078; number_of_response:1; }","duration":"162.522598ms","start":"2026-03-20T10:28:37.7078Z","end":"2026-03-20T10:28:37.870323Z","steps":["trace[221440659] 'process raft request' (duration: 162.12688ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:28:37.870385Z","caller":"traceutil/trace.go:171","msg":"trace[1018281786] linearizableReadLoop","detail":"{readStateIndex:8381; appliedIndex:8378; }","duration":"160.047566ms","start":"2026-03-20T10:28:37.710304Z","end":"2026-03-20T10:28:37.870352Z","steps":["trace[1018281786] 'read index received' (duration: 62.226293ms)","trace[1018281786] 'applied index is now lower than readState.Index' (duration: 97.819823ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:28:37.870479Z","caller":"traceutil/trace.go:171","msg":"trace[2010386337] transaction","detail":"{read_only:false; response_revision:8079; number_of_response:1; }","duration":"159.687699ms","start":"2026-03-20T10:28:37.710737Z","end":"2026-03-20T10:28:37.870424Z","steps":["trace[2010386337] 'process raft request' (duration: 159.483724ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:28:37.87065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.799725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:28:37.870753Z","caller":"traceutil/trace.go:171","msg":"trace[1667102311] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8079; }","duration":"100.962609ms","start":"2026-03-20T10:28:37.769775Z","end":"2026-03-20T10:28:37.870737Z","steps":["trace[1667102311] 'agreement among raft nodes before linearized reading' (duration: 100.801786ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:28:37.870798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.388404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-03-20T10:28:37.870897Z","caller":"traceutil/trace.go:171","msg":"trace[1775830248] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:8079; }","duration":"134.546318ms","start":"2026-03-20T10:28:37.736326Z","end":"2026-03-20T10:28:37.870872Z","steps":["trace[1775830248] 'agreement among raft nodes before linearized reading' (duration: 134.236011ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:28:37.870945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.617888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228791"} {"level":"info","ts":"2026-03-20T10:28:37.871009Z","caller":"traceutil/trace.go:171","msg":"trace[1568818533] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8079; }","duration":"160.720389ms","start":"2026-03-20T10:28:37.710273Z","end":"2026-03-20T10:28:37.870994Z","steps":["trace[1568818533] 'agreement among raft nodes before linearized reading' (duration: 160.221669ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:29:56.720211Z","caller":"traceutil/trace.go:171","msg":"trace[1724984632] linearizableReadLoop","detail":"{readStateIndex:9123; appliedIndex:9122; }","duration":"134.223581ms","start":"2026-03-20T10:29:56.585954Z","end":"2026-03-20T10:29:56.720178Z","steps":["trace[1724984632] 'read index received' (duration: 100.309466ms)","trace[1724984632] 'applied index is now lower than readState.Index' (duration: 33.912585ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:29:56.72056Z","caller":"traceutil/trace.go:171","msg":"trace[1047705550] transaction","detail":"{read_only:false; response_revision:8799; number_of_response:1; }","duration":"161.516746ms","start":"2026-03-20T10:29:56.559018Z","end":"2026-03-20T10:29:56.720535Z","steps":["trace[1047705550] 'process raft request' (duration: 127.281215ms)","trace[1047705550] 'compare' (duration: 33.352732ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:29:56.720703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.733541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:414470"} {"level":"info","ts":"2026-03-20T10:29:56.720742Z","caller":"traceutil/trace.go:171","msg":"trace[366250626] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:8799; }","duration":"134.831534ms","start":"2026-03-20T10:29:56.5859Z","end":"2026-03-20T10:29:56.720731Z","steps":["trace[366250626] 'agreement among raft nodes before linearized reading' (duration: 134.390214ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:32:11.500637Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf809824ab95ac81","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-20T10:32:11.508652Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-20T10:32:11.508776Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-20T10:32:42.100773Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7706} {"level":"info","ts":"2026-03-20T10:32:42.169239Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7706,"took":"66.360207ms","hash":3637051072,"current-db-size-bytes":43073536,"current-db-size":"43 MB","current-db-size-in-use-bytes":25427968,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-03-20T10:32:42.169349Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3637051072,"revision":7706,"compact-revision":5684} {"level":"info","ts":"2026-03-20T10:37:42.107892Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9785} {"level":"info","ts":"2026-03-20T10:37:42.177642Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9785,"took":"67.503807ms","hash":2391122901,"current-db-size-bytes":43073536,"current-db-size":"43 MB","current-db-size-in-use-bytes":18038784,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-03-20T10:37:42.177711Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2391122901,"revision":9785,"compact-revision":7706}