{"level":"warn","ts":"2026-06-16T00:34:46.125526Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-16T00:34:46.125656Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.138:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.138:2380","--initial-cluster=instance=https://199.19.213.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.138: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-06-16T00:34:46.125749Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-16T00:34:46.125767Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.138:2380"]} {"level":"info","ts":"2026-06-16T00:34:46.125791Z","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-06-16T00:34:46.126635Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.138:2379"]} {"level":"info","ts":"2026-06-16T00:34:46.126727Z","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://199.19.213.138:2380"],"listen-peer-urls":["https://199.19.213.138:2380"],"advertise-client-urls":["https://199.19.213.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.138: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-06-16T00:34:46.129256Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.257164ms"} {"level":"info","ts":"2026-06-16T00:34:46.13429Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2062be27cfb43adb","cluster-id":"f353072e75ed4d57"} {"level":"info","ts":"2026-06-16T00:34:46.134432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb switched to configuration voters=()"} {"level":"info","ts":"2026-06-16T00:34:46.134477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became follower at term 0"} {"level":"info","ts":"2026-06-16T00:34:46.134505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2062be27cfb43adb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-16T00:34:46.134519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became follower at term 1"} {"level":"info","ts":"2026-06-16T00:34:46.134579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb switched to configuration voters=(2333636635129035483)"} {"level":"warn","ts":"2026-06-16T00:34:46.138897Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-16T00:34:46.141426Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-16T00:34:46.144194Z","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-06-16T00:34:46.147011Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2062be27cfb43adb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-16T00:34:46.147278Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2062be27cfb43adb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-16T00:34:46.147609Z","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-06-16T00:34:46.147943Z","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-06-16T00:34:46.147981Z","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-06-16T00:34:46.148273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb switched to configuration voters=(2333636635129035483)"} {"level":"info","ts":"2026-06-16T00:34:46.148395Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f353072e75ed4d57","local-member-id":"2062be27cfb43adb","added-peer-id":"2062be27cfb43adb","added-peer-peer-urls":["https://199.19.213.138:2380"]} {"level":"info","ts":"2026-06-16T00:34:46.154066Z","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-06-16T00:34:46.154615Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2062be27cfb43adb","initial-advertise-peer-urls":["https://199.19.213.138:2380"],"listen-peer-urls":["https://199.19.213.138:2380"],"advertise-client-urls":["https://199.19.213.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-16T00:34:46.1547Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-16T00:34:46.154922Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.138:2380"} {"level":"info","ts":"2026-06-16T00:34:46.154984Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.138:2380"} {"level":"info","ts":"2026-06-16T00:34:47.035109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb is starting a new election at term 1"} {"level":"info","ts":"2026-06-16T00:34:47.035194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became pre-candidate at term 1"} {"level":"info","ts":"2026-06-16T00:34:47.035236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb received MsgPreVoteResp from 2062be27cfb43adb at term 1"} {"level":"info","ts":"2026-06-16T00:34:47.035257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became candidate at term 2"} {"level":"info","ts":"2026-06-16T00:34:47.035269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb received MsgVoteResp from 2062be27cfb43adb at term 2"} {"level":"info","ts":"2026-06-16T00:34:47.035291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became leader at term 2"} {"level":"info","ts":"2026-06-16T00:34:47.035304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2062be27cfb43adb elected leader 2062be27cfb43adb at term 2"} {"level":"info","ts":"2026-06-16T00:34:47.036097Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T00:34:47.036872Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2062be27cfb43adb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.138:2379]}","request-path":"/0/members/2062be27cfb43adb/attributes","cluster-id":"f353072e75ed4d57","publish-timeout":"7s"} {"level":"info","ts":"2026-06-16T00:34:47.036887Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-16T00:34:47.036931Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-16T00:34:47.037259Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-16T00:34:47.037316Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-16T00:34:47.040713Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.138:2379"} {"level":"info","ts":"2026-06-16T00:34:47.041246Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f353072e75ed4d57","local-member-id":"2062be27cfb43adb","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T00:34:47.041356Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T00:34:47.041468Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T00:34:47.04177Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-16T00:35:06.644477Z","caller":"traceutil/trace.go:171","msg":"trace[464335322] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"117.274008ms","start":"2026-06-16T00:35:06.527153Z","end":"2026-06-16T00:35:06.644427Z","steps":["trace[464335322] 'process raft request' (duration: 116.955793ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:35:11.992376Z","caller":"traceutil/trace.go:171","msg":"trace[506482880] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"108.99916ms","start":"2026-06-16T00:35:11.883352Z","end":"2026-06-16T00:35:11.992351Z","steps":["trace[506482880] 'process raft request' (duration: 108.866718ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:35:23.735649Z","caller":"traceutil/trace.go:171","msg":"trace[1623358213] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"106.1085ms","start":"2026-06-16T00:35:23.629509Z","end":"2026-06-16T00:35:23.735618Z","steps":["trace[1623358213] 'process raft request' (duration: 105.708003ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:35:23.741197Z","caller":"traceutil/trace.go:171","msg":"trace[1532136792] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"109.415812ms","start":"2026-06-16T00:35:23.631763Z","end":"2026-06-16T00:35:23.741179Z","steps":["trace[1532136792] 'process raft request' (duration: 109.145607ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:35:23.741309Z","caller":"traceutil/trace.go:171","msg":"trace[459132329] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"109.368922ms","start":"2026-06-16T00:35:23.631928Z","end":"2026-06-16T00:35:23.741297Z","steps":["trace[459132329] 'process raft request' (duration: 109.141447ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:35:23.741403Z","caller":"traceutil/trace.go:171","msg":"trace[2101148361] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"109.258419ms","start":"2026-06-16T00:35:23.632136Z","end":"2026-06-16T00:35:23.741395Z","steps":["trace[2101148361] 'process raft request' (duration: 109.006765ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:35:23.741499Z","caller":"traceutil/trace.go:171","msg":"trace[1878931097] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"109.29075ms","start":"2026-06-16T00:35:23.632197Z","end":"2026-06-16T00:35:23.741488Z","steps":["trace[1878931097] 'process raft request' (duration: 108.985004ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:35:23.741528Z","caller":"traceutil/trace.go:171","msg":"trace[1200757435] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"109.226019ms","start":"2026-06-16T00:35:23.632265Z","end":"2026-06-16T00:35:23.741491Z","steps":["trace[1200757435] 'process raft request' (duration: 108.971814ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:35:23.741581Z","caller":"traceutil/trace.go:171","msg":"trace[866300903] transaction","detail":"{read_only:false; number_of_response:1; response_revision:500; }","duration":"107.644369ms","start":"2026-06-16T00:35:23.633927Z","end":"2026-06-16T00:35:23.741572Z","steps":["trace[866300903] 'process raft request' (duration: 107.455835ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:35:29.590175Z","caller":"traceutil/trace.go:171","msg":"trace[1109296694] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"165.519425ms","start":"2026-06-16T00:35:29.424627Z","end":"2026-06-16T00:35:29.590147Z","steps":["trace[1109296694] 'process raft request' (duration: 159.021543ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:35:29.678384Z","caller":"traceutil/trace.go:171","msg":"trace[489600276] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"104.501399ms","start":"2026-06-16T00:35:29.573837Z","end":"2026-06-16T00:35:29.678338Z","steps":["trace[489600276] 'process raft request' (duration: 22.133989ms)","trace[489600276] 'compare' (duration: 81.988633ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:35:29.948767Z","caller":"traceutil/trace.go:171","msg":"trace[203486742] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"251.359601ms","start":"2026-06-16T00:35:29.697368Z","end":"2026-06-16T00:35:29.948727Z","steps":["trace[203486742] 'process raft request' (duration: 228.63211ms)","trace[203486742] 'compare' (duration: 22.266152ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:35:30.461274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.63511ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T00:35:30.461558Z","caller":"traceutil/trace.go:171","msg":"trace[1210478229] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"421.597146ms","start":"2026-06-16T00:35:30.039915Z","end":"2026-06-16T00:35:30.461513Z","steps":["trace[1210478229] 'process raft request' (duration: 77.939976ms)","trace[1210478229] 'compare' (duration: 342.389876ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:35:30.461774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:35:30.039898Z","time spent":"421.745288ms","remote":"127.0.0.1:50556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:35:30.462413Z","caller":"traceutil/trace.go:171","msg":"trace[122205181] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:615; }","duration":"261.36192ms","start":"2026-06-16T00:35:30.201028Z","end":"2026-06-16T00:35:30.46239Z","steps":["trace[122205181] 'read index received' (duration: 257.957146ms)","trace[122205181] 'applied index is now lower than readState.Index' (duration: 3.402244ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:35:30.46261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.581255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-16T00:35:30.462649Z","caller":"traceutil/trace.go:171","msg":"trace[711111971] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:592; }","duration":"261.676256ms","start":"2026-06-16T00:35:30.200963Z","end":"2026-06-16T00:35:30.462639Z","steps":["trace[711111971] 'agreement among raft nodes before linearized reading' (duration: 261.506492ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:35:30.462997Z","caller":"traceutil/trace.go:171","msg":"trace[1245338913] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"371.60623ms","start":"2026-06-16T00:35:30.091375Z","end":"2026-06-16T00:35:30.462981Z","steps":["trace[1245338913] 'process raft request' (duration: 370.319185ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:35:30.463094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:35:30.091345Z","time spent":"371.688031ms","remote":"127.0.0.1:50644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T00:35:44.971858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.048378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-16T00:35:44.971886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.525915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-f6pz9\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-16T00:35:44.971954Z","caller":"traceutil/trace.go:171","msg":"trace[318917870] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:751; }","duration":"220.16486ms","start":"2026-06-16T00:35:44.751767Z","end":"2026-06-16T00:35:44.971932Z","steps":["trace[318917870] 'range keys from in-memory index tree' (duration: 220.009117ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:35:44.971986Z","caller":"traceutil/trace.go:171","msg":"trace[85322359] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-f6pz9; range_end:; response_count:1; response_revision:751; }","duration":"230.712389ms","start":"2026-06-16T00:35:44.741249Z","end":"2026-06-16T00:35:44.971961Z","steps":["trace[85322359] 'range keys from in-memory index tree' (duration: 230.384573ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:37:15.206745Z","caller":"traceutil/trace.go:171","msg":"trace[1489261177] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"102.499428ms","start":"2026-06-16T00:37:15.104212Z","end":"2026-06-16T00:37:15.206712Z","steps":["trace[1489261177] 'process raft request' (duration: 102.009578ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:37:57.863625Z","caller":"traceutil/trace.go:171","msg":"trace[1805941843] linearizableReadLoop","detail":"{readStateIndex:2260; appliedIndex:2259; }","duration":"108.974412ms","start":"2026-06-16T00:37:57.754628Z","end":"2026-06-16T00:37:57.863603Z","steps":["trace[1805941843] 'read index received' (duration: 57.255757ms)","trace[1805941843] 'applied index is now lower than readState.Index' (duration: 51.717435ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:37:57.864097Z","caller":"traceutil/trace.go:171","msg":"trace[961092552] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"160.796669ms","start":"2026-06-16T00:37:57.703281Z","end":"2026-06-16T00:37:57.864078Z","steps":["trace[961092552] 'process raft request' (duration: 108.569164ms)","trace[961092552] 'compare' (duration: 51.535562ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:37:57.86415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.512322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:37:57.864233Z","caller":"traceutil/trace.go:171","msg":"trace[1000513831] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2174; }","duration":"109.646405ms","start":"2026-06-16T00:37:57.754569Z","end":"2026-06-16T00:37:57.864216Z","steps":["trace[1000513831] 'agreement among raft nodes before linearized reading' (duration: 109.503302ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:37:58.077669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.385969ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T00:37:58.078096Z","caller":"traceutil/trace.go:171","msg":"trace[1773725501] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"202.089402ms","start":"2026-06-16T00:37:57.87597Z","end":"2026-06-16T00:37:58.078059Z","steps":["trace[1773725501] 'process raft request' (duration: 201.828056ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:37:58.078104Z","caller":"traceutil/trace.go:171","msg":"trace[1700644665] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"203.253395ms","start":"2026-06-16T00:37:57.874788Z","end":"2026-06-16T00:37:58.078041Z","steps":["trace[1700644665] 'process raft request' (duration: 95.367916ms)","trace[1700644665] 'compare' (duration: 107.180215ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:37:58.282062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.318057ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T00:37:58.282246Z","caller":"traceutil/trace.go:171","msg":"trace[958642301] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"199.399417ms","start":"2026-06-16T00:37:58.082827Z","end":"2026-06-16T00:37:58.282227Z","steps":["trace[958642301] 'process raft request' (duration: 199.342776ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:37:58.282335Z","caller":"traceutil/trace.go:171","msg":"trace[777858219] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"258.926641ms","start":"2026-06-16T00:37:58.023343Z","end":"2026-06-16T00:37:58.282269Z","steps":["trace[777858219] 'process raft request' (duration: 156.302408ms)","trace[777858219] 'compare' (duration: 102.198645ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:43:27.598953Z","caller":"traceutil/trace.go:171","msg":"trace[2071125708] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"109.165738ms","start":"2026-06-16T00:43:27.489756Z","end":"2026-06-16T00:43:27.598922Z","steps":["trace[2071125708] 'process raft request' (duration: 109.055496ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:43:27.740592Z","caller":"traceutil/trace.go:171","msg":"trace[1126102876] transaction","detail":"{read_only:false; response_revision:5038; number_of_response:1; }","duration":"203.199147ms","start":"2026-06-16T00:43:27.537363Z","end":"2026-06-16T00:43:27.740562Z","steps":["trace[1126102876] 'process raft request' (duration: 189.509117ms)","trace[1126102876] 'compare' (duration: 13.482765ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:43:27.74096Z","caller":"traceutil/trace.go:171","msg":"trace[292531365] transaction","detail":"{read_only:false; response_revision:5039; number_of_response:1; }","duration":"191.906912ms","start":"2026-06-16T00:43:27.549027Z","end":"2026-06-16T00:43:27.740934Z","steps":["trace[292531365] 'process raft request' (duration: 191.488345ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:43:41.898341Z","caller":"traceutil/trace.go:171","msg":"trace[522165185] transaction","detail":"{read_only:false; response_revision:5310; number_of_response:1; }","duration":"246.076563ms","start":"2026-06-16T00:43:41.652232Z","end":"2026-06-16T00:43:41.898309Z","steps":["trace[522165185] 'process raft request' (duration: 176.271244ms)","trace[522165185] 'compare' (duration: 69.518684ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:43:41.898413Z","caller":"traceutil/trace.go:171","msg":"trace[1333494987] linearizableReadLoop","detail":"{readStateIndex:5515; appliedIndex:5514; }","duration":"143.561596ms","start":"2026-06-16T00:43:41.754818Z","end":"2026-06-16T00:43:41.89838Z","steps":["trace[1333494987] 'read index received' (duration: 73.682465ms)","trace[1333494987] 'applied index is now lower than readState.Index' (duration: 69.877471ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:43:41.898539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.7142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:43:41.898571Z","caller":"traceutil/trace.go:171","msg":"trace[2035544877] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5312; }","duration":"143.815512ms","start":"2026-06-16T00:43:41.754745Z","end":"2026-06-16T00:43:41.898561Z","steps":["trace[2035544877] 'agreement among raft nodes before linearized reading' (duration: 143.74196ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:43:42.639918Z","caller":"traceutil/trace.go:171","msg":"trace[503943185] transaction","detail":"{read_only:false; response_revision:5327; number_of_response:1; }","duration":"116.895711ms","start":"2026-06-16T00:43:42.522996Z","end":"2026-06-16T00:43:42.639892Z","steps":["trace[503943185] 'process raft request' (duration: 116.716467ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:43:50.216417Z","caller":"traceutil/trace.go:171","msg":"trace[575289885] transaction","detail":"{read_only:false; response_revision:5504; number_of_response:1; }","duration":"104.2248ms","start":"2026-06-16T00:43:50.112156Z","end":"2026-06-16T00:43:50.216381Z","steps":["trace[575289885] 'process raft request' (duration: 95.257213ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:43:50.224298Z","caller":"traceutil/trace.go:171","msg":"trace[4205775] transaction","detail":"{read_only:false; response_revision:5506; number_of_response:1; }","duration":"107.895642ms","start":"2026-06-16T00:43:50.116376Z","end":"2026-06-16T00:43:50.224272Z","steps":["trace[4205775] 'process raft request' (duration: 107.79096ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:43:50.224368Z","caller":"traceutil/trace.go:171","msg":"trace[804645522] transaction","detail":"{read_only:false; response_revision:5507; number_of_response:1; }","duration":"107.74164ms","start":"2026-06-16T00:43:50.116566Z","end":"2026-06-16T00:43:50.224308Z","steps":["trace[804645522] 'process raft request' (duration: 107.646818ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:43:50.224428Z","caller":"traceutil/trace.go:171","msg":"trace[1069357497] transaction","detail":"{read_only:false; response_revision:5505; number_of_response:1; }","duration":"108.634907ms","start":"2026-06-16T00:43:50.115742Z","end":"2026-06-16T00:43:50.224377Z","steps":["trace[1069357497] 'process raft request' (duration: 108.24342ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:43:50.22461Z","caller":"traceutil/trace.go:171","msg":"trace[1754403529] linearizableReadLoop","detail":"{readStateIndex:5715; appliedIndex:5713; }","duration":"108.379951ms","start":"2026-06-16T00:43:50.116209Z","end":"2026-06-16T00:43:50.224589Z","steps":["trace[1754403529] 'read index received' (duration: 91.226083ms)","trace[1754403529] 'applied index is now lower than readState.Index' (duration: 16.817922ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:43:50.224762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.524515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:4791"} {"level":"info","ts":"2026-06-16T00:43:50.22484Z","caller":"traceutil/trace.go:171","msg":"trace[272210021] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:5507; }","duration":"108.660447ms","start":"2026-06-16T00:43:50.11616Z","end":"2026-06-16T00:43:50.22482Z","steps":["trace[272210021] 'agreement among raft nodes before linearized reading' (duration: 108.414732ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:43:50.745106Z","caller":"traceutil/trace.go:171","msg":"trace[854758807] transaction","detail":"{read_only:false; response_revision:5509; number_of_response:1; }","duration":"158.79956ms","start":"2026-06-16T00:43:50.586271Z","end":"2026-06-16T00:43:50.745071Z","steps":["trace[854758807] 'process raft request' (duration: 120.40223ms)","trace[854758807] 'compare' (duration: 37.974761ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:43:50.745188Z","caller":"traceutil/trace.go:171","msg":"trace[2068626419] linearizableReadLoop","detail":"{readStateIndex:5719; appliedIndex:5718; }","duration":"158.202617ms","start":"2026-06-16T00:43:50.586946Z","end":"2026-06-16T00:43:50.745149Z","steps":["trace[2068626419] 'read index received' (duration: 119.877359ms)","trace[2068626419] 'applied index is now lower than readState.Index' (duration: 38.318608ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:43:50.745321Z","caller":"traceutil/trace.go:171","msg":"trace[726700832] transaction","detail":"{read_only:false; response_revision:5510; number_of_response:1; }","duration":"157.577045ms","start":"2026-06-16T00:43:50.587674Z","end":"2026-06-16T00:43:50.745251Z","steps":["trace[726700832] 'process raft request' (duration: 157.416702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:43:50.745499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.536003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ded49298-61fa-47b2-94ad-b4f22dbf7e5a\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-16T00:43:50.745552Z","caller":"traceutil/trace.go:171","msg":"trace[57114646] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ded49298-61fa-47b2-94ad-b4f22dbf7e5a; range_end:; response_count:1; response_revision:5510; }","duration":"158.654365ms","start":"2026-06-16T00:43:50.586882Z","end":"2026-06-16T00:43:50.745537Z","steps":["trace[57114646] 'agreement among raft nodes before linearized reading' (duration: 158.37712ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:44:32.301863Z","caller":"traceutil/trace.go:171","msg":"trace[1692366722] transaction","detail":"{read_only:false; response_revision:5916; number_of_response:1; }","duration":"415.294159ms","start":"2026-06-16T00:44:31.886546Z","end":"2026-06-16T00:44:32.30184Z","steps":["trace[1692366722] 'process raft request' (duration: 415.150976ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:44:32.302016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:44:31.886527Z","time spent":"415.423562ms","remote":"127.0.0.1:50620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":736,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-16T00:44:32.437866Z","caller":"traceutil/trace.go:171","msg":"trace[606744206] transaction","detail":"{read_only:false; response_revision:5918; number_of_response:1; }","duration":"319.633437ms","start":"2026-06-16T00:44:32.118205Z","end":"2026-06-16T00:44:32.437839Z","steps":["trace[606744206] 'process raft request' (duration: 319.541916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:44:32.438044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:44:32.118177Z","time spent":"319.784291ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:44:32.437866Z","caller":"traceutil/trace.go:171","msg":"trace[1995097299] transaction","detail":"{read_only:false; response_revision:5917; number_of_response:1; }","duration":"534.729647ms","start":"2026-06-16T00:44:31.903108Z","end":"2026-06-16T00:44:32.437837Z","steps":["trace[1995097299] 'process raft request' (duration: 534.474653ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:44:32.438316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:44:31.903083Z","time spent":"535.195107ms","remote":"127.0.0.1:50730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12124,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:44:32.438286Z","caller":"traceutil/trace.go:171","msg":"trace[556121681] transaction","detail":"{read_only:false; response_revision:5919; number_of_response:1; }","duration":"319.975934ms","start":"2026-06-16T00:44:32.118279Z","end":"2026-06-16T00:44:32.438255Z","steps":["trace[556121681] 'process raft request' (duration: 319.523565ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:44:32.438503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T00:44:32.118243Z","time spent":"320.130248ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T00:44:32.438612Z","caller":"traceutil/trace.go:171","msg":"trace[1511487126] linearizableReadLoop","detail":"{readStateIndex:6140; appliedIndex:6135; }","duration":"260.962928ms","start":"2026-06-16T00:44:32.177611Z","end":"2026-06-16T00:44:32.438574Z","steps":["trace[1511487126] 'read index received' (duration: 124.15058ms)","trace[1511487126] 'applied index is now lower than readState.Index' (duration: 136.810638ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:44:32.438737Z","caller":"traceutil/trace.go:171","msg":"trace[1530919571] transaction","detail":"{read_only:false; response_revision:5920; number_of_response:1; }","duration":"286.606221ms","start":"2026-06-16T00:44:32.152104Z","end":"2026-06-16T00:44:32.43871Z","steps":["trace[1530919571] 'process raft request' (duration: 286.01432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:44:32.43886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.217653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:44:32.438918Z","caller":"traceutil/trace.go:171","msg":"trace[1764244956] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:5920; }","duration":"261.345326ms","start":"2026-06-16T00:44:32.177555Z","end":"2026-06-16T00:44:32.4389Z","steps":["trace[1764244956] 'agreement among raft nodes before linearized reading' (duration: 261.215923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:44:32.439092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.720682ms","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-06-16T00:44:32.439214Z","caller":"traceutil/trace.go:171","msg":"trace[1815593336] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5920; }","duration":"194.880395ms","start":"2026-06-16T00:44:32.244312Z","end":"2026-06-16T00:44:32.439193Z","steps":["trace[1815593336] 'agreement among raft nodes before linearized reading' (duration: 194.555719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:44:32.439285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.217806ms","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-06-16T00:44:32.439367Z","caller":"traceutil/trace.go:171","msg":"trace[300323067] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5920; }","duration":"186.353089ms","start":"2026-06-16T00:44:32.252995Z","end":"2026-06-16T00:44:32.439348Z","steps":["trace[300323067] 'agreement among raft nodes before linearized reading' (duration: 185.91691ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:44:47.075898Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2965} {"level":"info","ts":"2026-06-16T00:44:47.149494Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2965,"took":"72.00143ms","hash":3632010050,"current-db-size-bytes":57036800,"current-db-size":"57 MB","current-db-size-in-use-bytes":33689600,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-16T00:44:47.149553Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3632010050,"revision":2965,"compact-revision":-1} {"level":"info","ts":"2026-06-16T00:49:47.081966Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6019} {"level":"info","ts":"2026-06-16T00:49:47.182608Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6019,"took":"98.527592ms","hash":2519955879,"current-db-size-bytes":57036800,"current-db-size":"57 MB","current-db-size-in-use-bytes":21917696,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-06-16T00:49:47.182664Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2519955879,"revision":6019,"compact-revision":2965} {"level":"info","ts":"2026-06-16T00:50:00.466607Z","caller":"traceutil/trace.go:171","msg":"trace[238221155] linearizableReadLoop","detail":"{readStateIndex:8633; appliedIndex:8632; }","duration":"248.009959ms","start":"2026-06-16T00:50:00.218573Z","end":"2026-06-16T00:50:00.466583Z","steps":["trace[238221155] 'read index received' (duration: 247.789005ms)","trace[238221155] 'applied index is now lower than readState.Index' (duration: 220.204µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:50:00.466682Z","caller":"traceutil/trace.go:171","msg":"trace[1957859184] transaction","detail":"{read_only:false; response_revision:8333; number_of_response:1; }","duration":"297.212814ms","start":"2026-06-16T00:50:00.169442Z","end":"2026-06-16T00:50:00.466654Z","steps":["trace[1957859184] 'process raft request' (duration: 296.965179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:50:00.466858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.007702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-16T00:50:00.466894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.305037ms","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-06-16T00:50:00.466994Z","caller":"traceutil/trace.go:171","msg":"trace[1852580249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8333; }","duration":"248.45573ms","start":"2026-06-16T00:50:00.218518Z","end":"2026-06-16T00:50:00.466973Z","steps":["trace[1852580249] 'agreement among raft nodes before linearized reading' (duration: 248.176834ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:50:00.466925Z","caller":"traceutil/trace.go:171","msg":"trace[382945238] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8333; }","duration":"245.131235ms","start":"2026-06-16T00:50:00.221778Z","end":"2026-06-16T00:50:00.46691Z","steps":["trace[382945238] 'agreement among raft nodes before linearized reading' (duration: 244.93916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:50:00.467512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.766473ms","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-06-16T00:50:00.467577Z","caller":"traceutil/trace.go:171","msg":"trace[1072105583] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8333; }","duration":"213.885446ms","start":"2026-06-16T00:50:00.25368Z","end":"2026-06-16T00:50:00.467565Z","steps":["trace[1072105583] 'agreement among raft nodes before linearized reading' (duration: 213.08233ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:50:00.607689Z","caller":"traceutil/trace.go:171","msg":"trace[1481898707] transaction","detail":"{read_only:false; response_revision:8334; number_of_response:1; }","duration":"135.165793ms","start":"2026-06-16T00:50:00.472492Z","end":"2026-06-16T00:50:00.607658Z","steps":["trace[1481898707] 'process raft request' (duration: 133.605463ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:50:00.610202Z","caller":"traceutil/trace.go:171","msg":"trace[1764520032] transaction","detail":"{read_only:false; response_revision:8335; number_of_response:1; }","duration":"137.58049ms","start":"2026-06-16T00:50:00.472602Z","end":"2026-06-16T00:50:00.610182Z","steps":["trace[1764520032] 'process raft request' (duration: 137.442957ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:50:00.610376Z","caller":"traceutil/trace.go:171","msg":"trace[1486132020] transaction","detail":"{read_only:false; response_revision:8336; number_of_response:1; }","duration":"137.649961ms","start":"2026-06-16T00:50:00.472708Z","end":"2026-06-16T00:50:00.610358Z","steps":["trace[1486132020] 'process raft request' (duration: 137.446377ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:50:41.789545Z","caller":"traceutil/trace.go:171","msg":"trace[554663341] transaction","detail":"{read_only:false; response_revision:8606; number_of_response:1; }","duration":"226.259621ms","start":"2026-06-16T00:50:41.563262Z","end":"2026-06-16T00:50:41.789521Z","steps":["trace[554663341] 'process raft request' (duration: 225.808283ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:50:41.996208Z","caller":"traceutil/trace.go:171","msg":"trace[118343395] linearizableReadLoop","detail":"{readStateIndex:8918; appliedIndex:8917; }","duration":"105.526562ms","start":"2026-06-16T00:50:41.890641Z","end":"2026-06-16T00:50:41.996168Z","steps":["trace[118343395] 'read index received' (duration: 93.335119ms)","trace[118343395] 'applied index is now lower than readState.Index' (duration: 12.190113ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T00:50:41.99644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.778286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-mt62l\" ","response":"range_response_count:1 size:6522"} {"level":"info","ts":"2026-06-16T00:50:41.996493Z","caller":"traceutil/trace.go:171","msg":"trace[1696736925] range","detail":"{range_begin:/registry/pods/openstack/keepalived-mt62l; range_end:; response_count:1; response_revision:8607; }","duration":"105.888708ms","start":"2026-06-16T00:50:41.890592Z","end":"2026-06-16T00:50:41.996481Z","steps":["trace[1696736925] 'agreement among raft nodes before linearized reading' (duration: 105.689934ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:50:41.996744Z","caller":"traceutil/trace.go:171","msg":"trace[1227593066] transaction","detail":"{read_only:false; response_revision:8607; number_of_response:1; }","duration":"126.186105ms","start":"2026-06-16T00:50:41.870031Z","end":"2026-06-16T00:50:41.996217Z","steps":["trace[1227593066] 'process raft request' (duration: 113.88426ms)","trace[1227593066] 'compare' (duration: 11.948397ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:50:44.945452Z","caller":"traceutil/trace.go:171","msg":"trace[1770747694] transaction","detail":"{read_only:false; response_revision:8621; number_of_response:1; }","duration":"187.244187ms","start":"2026-06-16T00:50:44.758171Z","end":"2026-06-16T00:50:44.945415Z","steps":["trace[1770747694] 'process raft request' (duration: 119.64575ms)","trace[1770747694] 'compare' (duration: 67.262931ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:50:44.945609Z","caller":"traceutil/trace.go:171","msg":"trace[1584050064] linearizableReadLoop","detail":"{readStateIndex:8933; appliedIndex:8931; }","duration":"107.706182ms","start":"2026-06-16T00:50:44.837878Z","end":"2026-06-16T00:50:44.945584Z","steps":["trace[1584050064] 'read index received' (duration: 39.956172ms)","trace[1584050064] 'applied index is now lower than readState.Index' (duration: 67.74771ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:50:44.945704Z","caller":"traceutil/trace.go:171","msg":"trace[852205509] transaction","detail":"{read_only:false; response_revision:8622; number_of_response:1; }","duration":"150.443135ms","start":"2026-06-16T00:50:44.795205Z","end":"2026-06-16T00:50:44.945649Z","steps":["trace[852205509] 'process raft request' (duration: 150.14998ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:50:44.945855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.954417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-16T00:50:44.945933Z","caller":"traceutil/trace.go:171","msg":"trace[1584979470] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8622; }","duration":"108.081738ms","start":"2026-06-16T00:50:44.837836Z","end":"2026-06-16T00:50:44.945917Z","steps":["trace[1584979470] 'agreement among raft nodes before linearized reading' (duration: 107.860574ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:50:45.058722Z","caller":"traceutil/trace.go:171","msg":"trace[661606209] transaction","detail":"{read_only:false; response_revision:8625; number_of_response:1; }","duration":"107.58123ms","start":"2026-06-16T00:50:44.95112Z","end":"2026-06-16T00:50:45.058702Z","steps":["trace[661606209] 'process raft request' (duration: 107.551539ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:50:45.058746Z","caller":"traceutil/trace.go:171","msg":"trace[1351564169] transaction","detail":"{read_only:false; response_revision:8624; number_of_response:1; }","duration":"107.650821ms","start":"2026-06-16T00:50:44.95107Z","end":"2026-06-16T00:50:45.058721Z","steps":["trace[1351564169] 'process raft request' (duration: 107.479308ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:50:55.307389Z","caller":"traceutil/trace.go:171","msg":"trace[1363118375] transaction","detail":"{read_only:false; response_revision:8720; number_of_response:1; }","duration":"201.370867ms","start":"2026-06-16T00:50:55.105951Z","end":"2026-06-16T00:50:55.307321Z","steps":["trace[1363118375] 'process raft request' (duration: 172.183371ms)","trace[1363118375] 'compare' (duration: 28.782498ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:50:55.3075Z","caller":"traceutil/trace.go:171","msg":"trace[1663806487] linearizableReadLoop","detail":"{readStateIndex:9036; appliedIndex:9035; }","duration":"196.015995ms","start":"2026-06-16T00:50:55.111455Z","end":"2026-06-16T00:50:55.307471Z","steps":["trace[1663806487] 'read index received' (duration: 166.768408ms)","trace[1663806487] 'applied index is now lower than readState.Index' (duration: 29.245887ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:50:55.307484Z","caller":"traceutil/trace.go:171","msg":"trace[928412046] transaction","detail":"{read_only:false; response_revision:8721; number_of_response:1; }","duration":"195.573307ms","start":"2026-06-16T00:50:55.111879Z","end":"2026-06-16T00:50:55.307452Z","steps":["trace[928412046] 'process raft request' (duration: 195.403324ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:50:55.307873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.398182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-bsk8j\" ","response":"range_response_count:1 size:4653"} {"level":"info","ts":"2026-06-16T00:50:55.307987Z","caller":"traceutil/trace.go:171","msg":"trace[80031633] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-bsk8j; range_end:; response_count:1; response_revision:8721; }","duration":"196.745138ms","start":"2026-06-16T00:50:55.111217Z","end":"2026-06-16T00:50:55.307962Z","steps":["trace[80031633] 'agreement among raft nodes before linearized reading' (duration: 196.370681ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T00:50:55.375592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.395989ms","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-06-16T00:50:55.37579Z","caller":"traceutil/trace.go:171","msg":"trace[619297902] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8721; }","duration":"262.621843ms","start":"2026-06-16T00:50:55.113145Z","end":"2026-06-16T00:50:55.375767Z","steps":["trace[619297902] 'agreement among raft nodes before linearized reading' (duration: 262.261167ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:50:55.522621Z","caller":"traceutil/trace.go:171","msg":"trace[1495908641] transaction","detail":"{read_only:false; response_revision:8723; number_of_response:1; }","duration":"134.298828ms","start":"2026-06-16T00:50:55.388265Z","end":"2026-06-16T00:50:55.522564Z","steps":["trace[1495908641] 'process raft request' (duration: 124.646644ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:51:11.997552Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023f6.wal"} {"level":"warn","ts":"2026-06-16T00:52:12.539151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.228354ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T00:52:12.539301Z","caller":"traceutil/trace.go:171","msg":"trace[770000056] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:9472; }","duration":"180.394047ms","start":"2026-06-16T00:52:12.358883Z","end":"2026-06-16T00:52:12.539278Z","steps":["trace[770000056] 'range keys from in-memory index tree' (duration: 180.204243ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:52:12.539512Z","caller":"traceutil/trace.go:171","msg":"trace[199564911] transaction","detail":"{read_only:false; response_revision:9473; number_of_response:1; }","duration":"227.511024ms","start":"2026-06-16T00:52:12.311958Z","end":"2026-06-16T00:52:12.539469Z","steps":["trace[199564911] 'process raft request' (duration: 210.369347ms)","trace[199564911] 'compare' (duration: 16.697499ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:52:12.632733Z","caller":"traceutil/trace.go:171","msg":"trace[2054174889] transaction","detail":"{read_only:false; response_revision:9474; number_of_response:1; }","duration":"280.683678ms","start":"2026-06-16T00:52:12.351977Z","end":"2026-06-16T00:52:12.632661Z","steps":["trace[2054174889] 'process raft request' (duration: 280.413933ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:52:12.632808Z","caller":"traceutil/trace.go:171","msg":"trace[411408557] transaction","detail":"{read_only:false; response_revision:9475; number_of_response:1; }","duration":"278.511686ms","start":"2026-06-16T00:52:12.35426Z","end":"2026-06-16T00:52:12.632772Z","steps":["trace[411408557] 'process raft request' (duration: 278.315662ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T00:52:36.348663Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2062be27cfb43adb","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-16T00:52:36.35408Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-16T00:52:36.354162Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-16T00:54:47.087489Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8125} {"level":"info","ts":"2026-06-16T00:54:47.148791Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8125,"took":"59.248216ms","hash":3121716555,"current-db-size-bytes":57036800,"current-db-size":"57 MB","current-db-size-in-use-bytes":28348416,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-16T00:54:47.148864Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3121716555,"revision":8125,"compact-revision":6019} {"level":"info","ts":"2026-06-16T00:57:51.254604Z","caller":"traceutil/trace.go:171","msg":"trace[1485986460] transaction","detail":"{read_only:false; response_revision:11907; number_of_response:1; }","duration":"103.541507ms","start":"2026-06-16T00:57:51.151023Z","end":"2026-06-16T00:57:51.254564Z","steps":["trace[1485986460] 'process raft request' (duration: 82.075215ms)","trace[1485986460] 'compare' (duration: 21.303999ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T00:59:47.093862Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10489} {"level":"info","ts":"2026-06-16T00:59:47.182237Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10489,"took":"85.742225ms","hash":1958225104,"current-db-size-bytes":57036800,"current-db-size":"57 MB","current-db-size-in-use-bytes":26120192,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-16T00:59:47.182296Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1958225104,"revision":10489,"compact-revision":8125} {"level":"info","ts":"2026-06-16T01:03:41.834923Z","caller":"traceutil/trace.go:171","msg":"trace[549293657] transaction","detail":"{read_only:false; response_revision:14299; number_of_response:1; }","duration":"103.853072ms","start":"2026-06-16T01:03:41.731048Z","end":"2026-06-16T01:03:41.834902Z","steps":["trace[549293657] 'process raft request' (duration: 103.70956ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:04:03.769327Z","caller":"traceutil/trace.go:171","msg":"trace[1672131236] transaction","detail":"{read_only:false; response_revision:14417; number_of_response:1; }","duration":"100.389836ms","start":"2026-06-16T01:04:03.668918Z","end":"2026-06-16T01:04:03.769308Z","steps":["trace[1672131236] 'process raft request' (duration: 100.203883ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:04:21.376418Z","caller":"traceutil/trace.go:171","msg":"trace[1270938076] transaction","detail":"{read_only:false; response_revision:14518; number_of_response:1; }","duration":"418.587021ms","start":"2026-06-16T01:04:20.957793Z","end":"2026-06-16T01:04:21.37638Z","steps":["trace[1270938076] 'process raft request' (duration: 418.346327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:04:21.3769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:04:20.957731Z","time spent":"418.804945ms","remote":"127.0.0.1:50730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12483,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:04:21.377371Z","caller":"traceutil/trace.go:171","msg":"trace[1092094511] linearizableReadLoop","detail":"{readStateIndex:15027; appliedIndex:15027; }","duration":"311.328733ms","start":"2026-06-16T01:04:21.066028Z","end":"2026-06-16T01:04:21.377357Z","steps":["trace[1092094511] 'read index received' (duration: 311.321853ms)","trace[1092094511] 'applied index is now lower than readState.Index' (duration: 5.45µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:04:21.37758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.561428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-06-16T01:04:21.377623Z","caller":"traceutil/trace.go:171","msg":"trace[685137429] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:14518; }","duration":"311.66115ms","start":"2026-06-16T01:04:21.065951Z","end":"2026-06-16T01:04:21.377612Z","steps":["trace[685137429] 'agreement among raft nodes before linearized reading' (duration: 311.489547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:04:21.377655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:04:21.065916Z","time spent":"311.731391ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":552,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-06-16T01:04:21.387487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.461458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-16T01:04:21.387625Z","caller":"traceutil/trace.go:171","msg":"trace[297495917] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14521; }","duration":"166.690983ms","start":"2026-06-16T01:04:21.220902Z","end":"2026-06-16T01:04:21.387593Z","steps":["trace[297495917] 'agreement among raft nodes before linearized reading' (duration: 166.251935ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:04:21.387893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.820516ms","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-06-16T01:04:21.388322Z","caller":"traceutil/trace.go:171","msg":"trace[278181368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14521; }","duration":"167.01324ms","start":"2026-06-16T01:04:21.221025Z","end":"2026-06-16T01:04:21.388038Z","steps":["trace[278181368] 'agreement among raft nodes before linearized reading' (duration: 166.760454ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:04:29.396234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.396653ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T01:04:29.396586Z","caller":"traceutil/trace.go:171","msg":"trace[2025760676] transaction","detail":"{read_only:false; response_revision:14632; number_of_response:1; }","duration":"281.065885ms","start":"2026-06-16T01:04:29.115495Z","end":"2026-06-16T01:04:29.396561Z","steps":["trace[2025760676] 'process raft request' (duration: 132.242094ms)","trace[2025760676] 'compare' (duration: 148.280751ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:04:29.396642Z","caller":"traceutil/trace.go:171","msg":"trace[864031716] transaction","detail":"{read_only:false; response_revision:14633; number_of_response:1; }","duration":"281.015304ms","start":"2026-06-16T01:04:29.115601Z","end":"2026-06-16T01:04:29.396617Z","steps":["trace[864031716] 'process raft request' (duration: 280.846151ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:04:29.396873Z","caller":"traceutil/trace.go:171","msg":"trace[156940543] transaction","detail":"{read_only:false; response_revision:14634; number_of_response:1; }","duration":"278.10248ms","start":"2026-06-16T01:04:29.11876Z","end":"2026-06-16T01:04:29.396862Z","steps":["trace[156940543] 'process raft request' (duration: 277.784433ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:04:29.396973Z","caller":"traceutil/trace.go:171","msg":"trace[986690173] transaction","detail":"{read_only:false; response_revision:14635; number_of_response:1; }","duration":"276.406208ms","start":"2026-06-16T01:04:29.120557Z","end":"2026-06-16T01:04:29.396963Z","steps":["trace[986690173] 'process raft request' (duration: 276.206424ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:04:29.397026Z","caller":"traceutil/trace.go:171","msg":"trace[1857164543] linearizableReadLoop","detail":"{readStateIndex:15145; appliedIndex:15142; }","duration":"276.641863ms","start":"2026-06-16T01:04:29.120378Z","end":"2026-06-16T01:04:29.39702Z","steps":["trace[1857164543] 'read index received' (duration: 127.431104ms)","trace[1857164543] 'applied index is now lower than readState.Index' (duration: 149.209729ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:04:29.397074Z","caller":"traceutil/trace.go:171","msg":"trace[1747477881] transaction","detail":"{read_only:false; response_revision:14638; number_of_response:1; }","duration":"268.325353ms","start":"2026-06-16T01:04:29.128714Z","end":"2026-06-16T01:04:29.39704Z","steps":["trace[1747477881] 'process raft request' (duration: 268.200931ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:04:29.397185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.783745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-06-16T01:04:29.397232Z","caller":"traceutil/trace.go:171","msg":"trace[796028663] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:14639; }","duration":"276.873746ms","start":"2026-06-16T01:04:29.120344Z","end":"2026-06-16T01:04:29.397218Z","steps":["trace[796028663] 'agreement among raft nodes before linearized reading' (duration: 276.707013ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:04:29.397093Z","caller":"traceutil/trace.go:171","msg":"trace[1309955928] transaction","detail":"{read_only:false; response_revision:14637; number_of_response:1; }","duration":"275.631513ms","start":"2026-06-16T01:04:29.12133Z","end":"2026-06-16T01:04:29.396962Z","steps":["trace[1309955928] 'process raft request' (duration: 275.552091ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:04:29.39795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.401915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:90 size:990547"} {"level":"info","ts":"2026-06-16T01:04:29.398042Z","caller":"traceutil/trace.go:171","msg":"trace[1561997856] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:90; response_revision:14639; }","duration":"233.553498ms","start":"2026-06-16T01:04:29.164469Z","end":"2026-06-16T01:04:29.398022Z","steps":["trace[1561997856] 'agreement among raft nodes before linearized reading' (duration: 232.601781ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:04:29.400458Z","caller":"traceutil/trace.go:171","msg":"trace[494464556] transaction","detail":"{read_only:false; response_revision:14636; number_of_response:1; }","duration":"276.319947ms","start":"2026-06-16T01:04:29.120633Z","end":"2026-06-16T01:04:29.396953Z","steps":["trace[494464556] 'process raft request' (duration: 276.205474ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:04:29.401232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.308338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2224963"} {"level":"info","ts":"2026-06-16T01:04:29.401324Z","caller":"traceutil/trace.go:171","msg":"trace[1069322211] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:14639; }","duration":"151.445441ms","start":"2026-06-16T01:04:29.249857Z","end":"2026-06-16T01:04:29.401302Z","steps":["trace[1069322211] 'agreement among raft nodes before linearized reading' (duration: 147.335843ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:04:40.192875Z","caller":"traceutil/trace.go:171","msg":"trace[627094621] transaction","detail":"{read_only:false; response_revision:14880; number_of_response:1; }","duration":"186.425619ms","start":"2026-06-16T01:04:40.006375Z","end":"2026-06-16T01:04:40.192801Z","steps":["trace[627094621] 'process raft request' (duration: 186.087743ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:04:40.193898Z","caller":"traceutil/trace.go:171","msg":"trace[1010976650] transaction","detail":"{read_only:false; response_revision:14881; number_of_response:1; }","duration":"153.45416ms","start":"2026-06-16T01:04:40.040405Z","end":"2026-06-16T01:04:40.19386Z","steps":["trace[1010976650] 'process raft request' (duration: 153.164824ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:04:47.10023Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12683} {"level":"info","ts":"2026-06-16T01:04:47.176229Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12683,"took":"73.538095ms","hash":1420277571,"current-db-size-bytes":57036800,"current-db-size":"57 MB","current-db-size-in-use-bytes":28975104,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-16T01:04:47.176314Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1420277571,"revision":12683,"compact-revision":10489} {"level":"info","ts":"2026-06-16T01:06:00.121025Z","caller":"traceutil/trace.go:171","msg":"trace[1317725537] linearizableReadLoop","detail":"{readStateIndex:16298; appliedIndex:16297; }","duration":"112.073799ms","start":"2026-06-16T01:06:00.008928Z","end":"2026-06-16T01:06:00.121002Z","steps":["trace[1317725537] 'read index received' (duration: 111.890316ms)","trace[1317725537] 'applied index is now lower than readState.Index' (duration: 182.343µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:06:00.121137Z","caller":"traceutil/trace.go:171","msg":"trace[1773657606] transaction","detail":"{read_only:false; response_revision:15752; number_of_response:1; }","duration":"115.910132ms","start":"2026-06-16T01:06:00.005201Z","end":"2026-06-16T01:06:00.121111Z","steps":["trace[1773657606] 'process raft request' (duration: 115.639186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:06:00.121224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.297104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-06-16T01:06:00.121277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.09458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-8zkp5\" ","response":"range_response_count:1 size:20653"} {"level":"info","ts":"2026-06-16T01:06:00.121314Z","caller":"traceutil/trace.go:171","msg":"trace[2094845604] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15752; }","duration":"112.423877ms","start":"2026-06-16T01:06:00.008868Z","end":"2026-06-16T01:06:00.121292Z","steps":["trace[2094845604] 'agreement among raft nodes before linearized reading' (duration: 112.269204ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:06:00.121342Z","caller":"traceutil/trace.go:171","msg":"trace[248323534] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-8zkp5; range_end:; response_count:1; response_revision:15752; }","duration":"112.225932ms","start":"2026-06-16T01:06:00.009103Z","end":"2026-06-16T01:06:00.121329Z","steps":["trace[248323534] 'agreement among raft nodes before linearized reading' (duration: 112.056269ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:06:00.121592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.12885ms","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-06-16T01:06:00.121652Z","caller":"traceutil/trace.go:171","msg":"trace[1950218228] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15752; }","duration":"112.209822ms","start":"2026-06-16T01:06:00.009427Z","end":"2026-06-16T01:06:00.121637Z","steps":["trace[1950218228] 'agreement among raft nodes before linearized reading' (duration: 112.048549ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:06:00.121723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.850316ms","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-06-16T01:06:00.121773Z","caller":"traceutil/trace.go:171","msg":"trace[471857529] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15752; }","duration":"111.916736ms","start":"2026-06-16T01:06:00.009844Z","end":"2026-06-16T01:06:00.12176Z","steps":["trace[471857529] 'agreement among raft nodes before linearized reading' (duration: 111.794894ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:06:00.274222Z","caller":"traceutil/trace.go:171","msg":"trace[839244144] transaction","detail":"{read_only:false; response_revision:15753; number_of_response:1; }","duration":"149.024955ms","start":"2026-06-16T01:06:00.125166Z","end":"2026-06-16T01:06:00.274191Z","steps":["trace[839244144] 'process raft request' (duration: 148.542296ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:06:00.274591Z","caller":"traceutil/trace.go:171","msg":"trace[498753580] transaction","detail":"{read_only:false; response_revision:15754; number_of_response:1; }","duration":"148.303871ms","start":"2026-06-16T01:06:00.126256Z","end":"2026-06-16T01:06:00.27456Z","steps":["trace[498753580] 'process raft request' (duration: 147.6877ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:06:00.274856Z","caller":"traceutil/trace.go:171","msg":"trace[11748368] linearizableReadLoop","detail":"{readStateIndex:16302; appliedIndex:16298; }","duration":"147.78694ms","start":"2026-06-16T01:06:00.127052Z","end":"2026-06-16T01:06:00.274839Z","steps":["trace[11748368] 'read index received' (duration: 13.529277ms)","trace[11748368] 'applied index is now lower than readState.Index' (duration: 134.256433ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:06:00.275165Z","caller":"traceutil/trace.go:171","msg":"trace[195771743] transaction","detail":"{read_only:false; response_revision:15755; number_of_response:1; }","duration":"148.876733ms","start":"2026-06-16T01:06:00.12627Z","end":"2026-06-16T01:06:00.275146Z","steps":["trace[195771743] 'process raft request' (duration: 148.185499ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:06:00.275879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.79743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:80 size:777010"} {"level":"info","ts":"2026-06-16T01:06:00.275962Z","caller":"traceutil/trace.go:171","msg":"trace[1148188011] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:80; response_revision:15755; }","duration":"148.947622ms","start":"2026-06-16T01:06:00.126998Z","end":"2026-06-16T01:06:00.275945Z","steps":["trace[1148188011] 'agreement among raft nodes before linearized reading' (duration: 147.901032ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:06:00.283994Z","caller":"traceutil/trace.go:171","msg":"trace[1305273515] transaction","detail":"{read_only:false; response_revision:15756; number_of_response:1; }","duration":"142.366558ms","start":"2026-06-16T01:06:00.141609Z","end":"2026-06-16T01:06:00.283975Z","steps":["trace[1305273515] 'process raft request' (duration: 142.246006ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:09:47.106669Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14977} {"level":"info","ts":"2026-06-16T01:09:47.193706Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14977,"took":"82.855229ms","hash":1951632367,"current-db-size-bytes":57036800,"current-db-size":"57 MB","current-db-size-in-use-bytes":30789632,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-16T01:09:47.193779Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1951632367,"revision":14977,"compact-revision":12683} {"level":"warn","ts":"2026-06-16T01:11:46.265675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.258695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-06-16T01:11:46.265819Z","caller":"traceutil/trace.go:171","msg":"trace[1381290640] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18347; }","duration":"117.466399ms","start":"2026-06-16T01:11:46.14833Z","end":"2026-06-16T01:11:46.265797Z","steps":["trace[1381290640] 'range keys from in-memory index tree' (duration: 117.010491ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:11:48.178176Z","caller":"traceutil/trace.go:171","msg":"trace[1270943917] linearizableReadLoop","detail":"{readStateIndex:19004; appliedIndex:19003; }","duration":"102.232309ms","start":"2026-06-16T01:11:48.075915Z","end":"2026-06-16T01:11:48.178147Z","steps":["trace[1270943917] 'read index received' (duration: 102.018095ms)","trace[1270943917] 'applied index is now lower than readState.Index' (duration: 213.224µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:11:48.178475Z","caller":"traceutil/trace.go:171","msg":"trace[2008440891] transaction","detail":"{read_only:false; response_revision:18374; number_of_response:1; }","duration":"140.274084ms","start":"2026-06-16T01:11:48.038187Z","end":"2026-06-16T01:11:48.178461Z","steps":["trace[2008440891] 'process raft request' (duration: 139.812956ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:11:48.178778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.8425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-16T01:11:48.178825Z","caller":"traceutil/trace.go:171","msg":"trace[1690718125] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18374; }","duration":"102.949652ms","start":"2026-06-16T01:11:48.075863Z","end":"2026-06-16T01:11:48.178813Z","steps":["trace[1690718125] 'agreement among raft nodes before linearized reading' (duration: 102.773388ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:11:48.178957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.724889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-16T01:11:48.178988Z","caller":"traceutil/trace.go:171","msg":"trace[1450417791] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18374; }","duration":"102.7719ms","start":"2026-06-16T01:11:48.076203Z","end":"2026-06-16T01:11:48.178974Z","steps":["trace[1450417791] 'agreement among raft nodes before linearized reading' (duration: 102.700918ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:11:53.870553Z","caller":"traceutil/trace.go:171","msg":"trace[2081164304] linearizableReadLoop","detail":"{readStateIndex:19063; appliedIndex:19062; }","duration":"116.306457ms","start":"2026-06-16T01:11:53.754217Z","end":"2026-06-16T01:11:53.870524Z","steps":["trace[2081164304] 'read index received' (duration: 69.132317ms)","trace[2081164304] 'applied index is now lower than readState.Index' (duration: 47.17288ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:11:53.870668Z","caller":"traceutil/trace.go:171","msg":"trace[201921975] transaction","detail":"{read_only:false; response_revision:18432; number_of_response:1; }","duration":"217.270101ms","start":"2026-06-16T01:11:53.653388Z","end":"2026-06-16T01:11:53.870658Z","steps":["trace[201921975] 'process raft request' (duration: 170.02528ms)","trace[201921975] 'compare' (duration: 46.957285ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:11:53.870824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.578692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:11:53.870922Z","caller":"traceutil/trace.go:171","msg":"trace[927635611] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18432; }","duration":"116.751336ms","start":"2026-06-16T01:11:53.754147Z","end":"2026-06-16T01:11:53.870899Z","steps":["trace[927635611] 'agreement among raft nodes before linearized reading' (duration: 116.545322ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:11:53.895151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.160739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T01:11:53.895279Z","caller":"traceutil/trace.go:171","msg":"trace[1129324742] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:18433; }","duration":"100.334822ms","start":"2026-06-16T01:11:53.794919Z","end":"2026-06-16T01:11:53.895254Z","steps":["trace[1129324742] 'agreement among raft nodes before linearized reading' (duration: 100.142498ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:13:29.330688Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2062be27cfb43adb","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-16T01:13:29.337532Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-16T01:13:29.337669Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-16T01:14:47.114029Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17455} {"level":"info","ts":"2026-06-16T01:14:47.206962Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17455,"took":"90.486205ms","hash":4011940515,"current-db-size-bytes":57036800,"current-db-size":"57 MB","current-db-size-in-use-bytes":37998592,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-06-16T01:14:47.207033Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4011940515,"revision":17455,"compact-revision":14977} {"level":"info","ts":"2026-06-16T01:17:37.317301Z","caller":"traceutil/trace.go:171","msg":"trace[38847021] transaction","detail":"{read_only:false; response_revision:21015; number_of_response:1; }","duration":"335.502662ms","start":"2026-06-16T01:17:36.981768Z","end":"2026-06-16T01:17:37.317271Z","steps":["trace[38847021] 'process raft request' (duration: 335.290148ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:17:37.317505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:17:36.981739Z","time spent":"335.660195ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:17:38.015122Z","caller":"traceutil/trace.go:171","msg":"trace[465084442] transaction","detail":"{read_only:false; response_revision:21017; number_of_response:1; }","duration":"117.367157ms","start":"2026-06-16T01:17:37.897712Z","end":"2026-06-16T01:17:38.015079Z","steps":["trace[465084442] 'process raft request' (duration: 117.100802ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:19:47.124164Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19846} {"level":"info","ts":"2026-06-16T01:19:47.245956Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19846,"took":"117.56701ms","hash":2699796798,"current-db-size-bytes":57036800,"current-db-size":"57 MB","current-db-size-in-use-bytes":30531584,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-16T01:19:47.246025Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2699796798,"revision":19846,"compact-revision":17455} {"level":"info","ts":"2026-06-16T01:21:40.15576Z","caller":"traceutil/trace.go:171","msg":"trace[784123215] transaction","detail":"{read_only:false; response_revision:23524; number_of_response:1; }","duration":"161.553088ms","start":"2026-06-16T01:21:39.994179Z","end":"2026-06-16T01:21:40.155732Z","steps":["trace[784123215] 'process raft request' (duration: 161.370495ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:21:40.156407Z","caller":"traceutil/trace.go:171","msg":"trace[1807157559] transaction","detail":"{read_only:false; response_revision:23525; number_of_response:1; }","duration":"124.491102ms","start":"2026-06-16T01:21:40.031889Z","end":"2026-06-16T01:21:40.15638Z","steps":["trace[1807157559] 'process raft request' (duration: 124.314989ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:22:09.554298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.262292ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:18"} {"level":"info","ts":"2026-06-16T01:22:09.554543Z","caller":"traceutil/trace.go:171","msg":"trace[987911025] transaction","detail":"{read_only:false; response_revision:23803; number_of_response:1; }","duration":"180.160473ms","start":"2026-06-16T01:22:09.374365Z","end":"2026-06-16T01:22:09.554526Z","steps":["trace[987911025] 'process raft request' (duration: 180.075982ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:22:09.554498Z","caller":"traceutil/trace.go:171","msg":"trace[1818232523] transaction","detail":"{read_only:false; response_revision:23802; number_of_response:1; }","duration":"254.449368ms","start":"2026-06-16T01:22:09.30001Z","end":"2026-06-16T01:22:09.554459Z","steps":["trace[1818232523] 'process raft request' (duration: 81.947671ms)","trace[1818232523] 'compare' (duration: 172.13787ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:22:09.554624Z","caller":"traceutil/trace.go:171","msg":"trace[1328624140] linearizableReadLoop","detail":"{readStateIndex:24600; appliedIndex:24599; }","duration":"211.891067ms","start":"2026-06-16T01:22:09.342696Z","end":"2026-06-16T01:22:09.554587Z","steps":["trace[1328624140] 'read index received' (duration: 39.272859ms)","trace[1328624140] 'applied index is now lower than readState.Index' (duration: 172.613838ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:22:09.554898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.178542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/capi-system/capi-controller-manager-69f9d56d75\" ","response":"range_response_count:1 size:4667"} {"level":"info","ts":"2026-06-16T01:22:09.55497Z","caller":"traceutil/trace.go:171","msg":"trace[1327086267] range","detail":"{range_begin:/registry/replicasets/capi-system/capi-controller-manager-69f9d56d75; range_end:; response_count:1; response_revision:23803; }","duration":"212.288434ms","start":"2026-06-16T01:22:09.342663Z","end":"2026-06-16T01:22:09.554951Z","steps":["trace[1327086267] 'agreement among raft nodes before linearized reading' (duration: 212.07247ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:23:10.481432Z","caller":"traceutil/trace.go:171","msg":"trace[28209712] linearizableReadLoop","detail":"{readStateIndex:25285; appliedIndex:25282; }","duration":"225.479495ms","start":"2026-06-16T01:23:10.255925Z","end":"2026-06-16T01:23:10.481405Z","steps":["trace[28209712] 'read index received' (duration: 76.258528ms)","trace[28209712] 'applied index is now lower than readState.Index' (duration: 149.219867ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:23:10.481483Z","caller":"traceutil/trace.go:171","msg":"trace[1181479200] transaction","detail":"{read_only:false; response_revision:24470; number_of_response:1; }","duration":"226.304782ms","start":"2026-06-16T01:23:10.255135Z","end":"2026-06-16T01:23:10.48144Z","steps":["trace[1181479200] 'process raft request' (duration: 226.029627ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:23:10.481492Z","caller":"traceutil/trace.go:171","msg":"trace[2138113043] transaction","detail":"{read_only:false; response_revision:24471; number_of_response:1; }","duration":"226.225039ms","start":"2026-06-16T01:23:10.255243Z","end":"2026-06-16T01:23:10.481469Z","steps":["trace[2138113043] 'process raft request' (duration: 226.110287ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:23:10.481689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.74237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-16T01:23:10.481731Z","caller":"traceutil/trace.go:171","msg":"trace[1960044434] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:24471; }","duration":"225.826562ms","start":"2026-06-16T01:23:10.255893Z","end":"2026-06-16T01:23:10.48172Z","steps":["trace[1960044434] 'agreement among raft nodes before linearized reading' (duration: 225.662589ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:23:10.48176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.146177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T01:23:10.481818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.086956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-db-sync\" ","response":"range_response_count:1 size:5082"} {"level":"warn","ts":"2026-06-16T01:23:10.481836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.503774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T01:23:10.481801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.598466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-domain-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:23:10.481907Z","caller":"traceutil/trace.go:171","msg":"trace[1339229108] range","detail":"{range_begin:/registry/jobs/openstack/magnum-db-sync; range_end:; response_count:1; response_revision:24471; }","duration":"156.151867ms","start":"2026-06-16T01:23:10.325712Z","end":"2026-06-16T01:23:10.481864Z","steps":["trace[1339229108] 'agreement among raft nodes before linearized reading' (duration: 155.992865ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:23:10.481968Z","caller":"traceutil/trace.go:171","msg":"trace[1082349296] range","detail":"{range_begin:/registry/jobs/openstack/magnum-domain-ks-user; range_end:; response_count:0; response_revision:24471; }","duration":"156.78728ms","start":"2026-06-16T01:23:10.325155Z","end":"2026-06-16T01:23:10.481942Z","steps":["trace[1082349296] 'agreement among raft nodes before linearized reading' (duration: 156.522695ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:23:10.481827Z","caller":"traceutil/trace.go:171","msg":"trace[1085219667] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-user; range_end:; response_count:0; response_revision:24471; }","duration":"156.229338ms","start":"2026-06-16T01:23:10.325581Z","end":"2026-06-16T01:23:10.48181Z","steps":["trace[1085219667] 'agreement among raft nodes before linearized reading' (duration: 156.111856ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:23:10.48176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.265719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:23:10.48213Z","caller":"traceutil/trace.go:171","msg":"trace[997462941] range","detail":"{range_begin:/registry/jobs/openstack/magnum-rabbit-init; range_end:; response_count:0; response_revision:24471; }","duration":"156.663427ms","start":"2026-06-16T01:23:10.325455Z","end":"2026-06-16T01:23:10.482118Z","steps":["trace[997462941] 'agreement among raft nodes before linearized reading' (duration: 156.261589ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:23:10.48201Z","caller":"traceutil/trace.go:171","msg":"trace[1662140984] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-endpoints; range_end:; response_count:0; response_revision:24471; }","duration":"156.633056ms","start":"2026-06-16T01:23:10.325277Z","end":"2026-06-16T01:23:10.481911Z","steps":["trace[1662140984] 'agreement among raft nodes before linearized reading' (duration: 156.524804ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:24:47.130698Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22063} {"level":"info","ts":"2026-06-16T01:24:47.240787Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22063,"took":"104.610148ms","hash":695423720,"current-db-size-bytes":58740736,"current-db-size":"59 MB","current-db-size-in-use-bytes":45023232,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-06-16T01:24:47.240846Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":695423720,"revision":22063,"compact-revision":19846} {"level":"info","ts":"2026-06-16T01:25:03.573251Z","caller":"traceutil/trace.go:171","msg":"trace[339589382] transaction","detail":"{read_only:false; response_revision:25571; number_of_response:1; }","duration":"131.872856ms","start":"2026-06-16T01:25:03.441359Z","end":"2026-06-16T01:25:03.573232Z","steps":["trace[339589382] 'process raft request' (duration: 131.723684ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:09.148756Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4241158081064863992,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-16T01:25:09.190821Z","caller":"traceutil/trace.go:171","msg":"trace[1601977395] transaction","detail":"{read_only:false; response_revision:25613; number_of_response:1; }","duration":"580.117466ms","start":"2026-06-16T01:25:08.610681Z","end":"2026-06-16T01:25:09.190799Z","steps":["trace[1601977395] 'process raft request' (duration: 580.071625ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:09.190959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:08.610661Z","time spent":"580.216877ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:09.191327Z","caller":"traceutil/trace.go:171","msg":"trace[1853311935] transaction","detail":"{read_only:false; response_revision:25610; number_of_response:1; }","duration":"585.848745ms","start":"2026-06-16T01:25:08.605465Z","end":"2026-06-16T01:25:09.191314Z","steps":["trace[1853311935] 'process raft request' (duration: 585.048729ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:09.191398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:08.605448Z","time spent":"585.915196ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:09.191543Z","caller":"traceutil/trace.go:171","msg":"trace[328666434] transaction","detail":"{read_only:false; response_revision:25611; number_of_response:1; }","duration":"585.679221ms","start":"2026-06-16T01:25:08.605853Z","end":"2026-06-16T01:25:09.191533Z","steps":["trace[328666434] 'process raft request' (duration: 584.822234ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:09.191607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:08.605819Z","time spent":"585.755693ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:09.191843Z","caller":"traceutil/trace.go:171","msg":"trace[33590896] transaction","detail":"{read_only:false; response_revision:25612; number_of_response:1; }","duration":"583.310985ms","start":"2026-06-16T01:25:08.608515Z","end":"2026-06-16T01:25:09.191826Z","steps":["trace[33590896] 'process raft request' (duration: 582.201014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:09.191927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:08.608493Z","time spent":"583.395847ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:25:09.371761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.229698ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T01:25:09.372085Z","caller":"traceutil/trace.go:171","msg":"trace[750930338] linearizableReadLoop","detail":"{readStateIndex:26459; appliedIndex:26454; }","duration":"724.182313ms","start":"2026-06-16T01:25:08.647878Z","end":"2026-06-16T01:25:09.372061Z","steps":["trace[750930338] 'read index received' (duration: 542.657143ms)","trace[750930338] 'applied index is now lower than readState.Index' (duration: 181.52344ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:09.372215Z","caller":"traceutil/trace.go:171","msg":"trace[732890703] transaction","detail":"{read_only:false; response_revision:25615; number_of_response:1; }","duration":"188.984582ms","start":"2026-06-16T01:25:09.183215Z","end":"2026-06-16T01:25:09.372199Z","steps":["trace[732890703] 'process raft request' (duration: 188.695596ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:09.37223Z","caller":"traceutil/trace.go:171","msg":"trace[657433823] transaction","detail":"{read_only:false; response_revision:25614; number_of_response:1; }","duration":"451.360028ms","start":"2026-06-16T01:25:08.920842Z","end":"2026-06-16T01:25:09.372202Z","steps":["trace[657433823] 'process raft request' (duration: 333.548369ms)","trace[657433823] 'compare' (duration: 116.778469ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:25:09.372395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:08.920811Z","time spent":"451.523611ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:25:09.372393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.088001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T01:25:09.372433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.415072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-16T01:25:09.37248Z","caller":"traceutil/trace.go:171","msg":"trace[1810797389] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:25615; }","duration":"674.224033ms","start":"2026-06-16T01:25:08.698237Z","end":"2026-06-16T01:25:09.372461Z","steps":["trace[1810797389] 'agreement among raft nodes before linearized reading' (duration: 674.06576ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:09.37246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.368874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T01:25:09.372518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:08.698219Z","time spent":"674.291124ms","remote":"127.0.0.1:47956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true "} {"level":"info","ts":"2026-06-16T01:25:09.372523Z","caller":"traceutil/trace.go:171","msg":"trace[888608289] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25615; }","duration":"508.553325ms","start":"2026-06-16T01:25:08.863946Z","end":"2026-06-16T01:25:09.372499Z","steps":["trace[888608289] 'agreement among raft nodes before linearized reading' (duration: 508.396062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:09.372512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.163117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-16T01:25:09.37257Z","caller":"traceutil/trace.go:171","msg":"trace[871431390] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25615; }","duration":"616.508677ms","start":"2026-06-16T01:25:08.756031Z","end":"2026-06-16T01:25:09.37254Z","steps":["trace[871431390] 'agreement among raft nodes before linearized reading' (duration: 616.326923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:09.372585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:08.863924Z","time spent":"508.652506ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-16T01:25:09.372552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.468851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-16T01:25:09.372597Z","caller":"traceutil/trace.go:171","msg":"trace[2074631113] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25615; }","duration":"268.301138ms","start":"2026-06-16T01:25:09.104274Z","end":"2026-06-16T01:25:09.372575Z","steps":["trace[2074631113] 'agreement among raft nodes before linearized reading' (duration: 268.045444ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:09.372596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.861227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-16T01:25:09.372628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:08.756014Z","time spent":"616.602998ms","remote":"127.0.0.1:50520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-16T01:25:09.372707Z","caller":"traceutil/trace.go:171","msg":"trace[1241449136] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25615; }","duration":"389.607264ms","start":"2026-06-16T01:25:08.983017Z","end":"2026-06-16T01:25:09.372624Z","steps":["trace[1241449136] 'agreement among raft nodes before linearized reading' (duration: 389.306339ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:09.372657Z","caller":"traceutil/trace.go:171","msg":"trace[1521977344] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:25615; }","duration":"200.970779ms","start":"2026-06-16T01:25:09.171671Z","end":"2026-06-16T01:25:09.372641Z","steps":["trace[1521977344] 'agreement among raft nodes before linearized reading' (duration: 200.840276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:09.372645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.371151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"warn","ts":"2026-06-16T01:25:09.372729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"724.839735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-06-16T01:25:09.372656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.260981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-16T01:25:09.372765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:08.982999Z","time spent":"389.742177ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-16T01:25:09.372794Z","caller":"traceutil/trace.go:171","msg":"trace[160064371] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25615; }","duration":"724.942927ms","start":"2026-06-16T01:25:08.647836Z","end":"2026-06-16T01:25:09.372779Z","steps":["trace[160064371] 'agreement among raft nodes before linearized reading' (duration: 724.679462ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:09.372804Z","caller":"traceutil/trace.go:171","msg":"trace[1418421825] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25615; }","duration":"265.427454ms","start":"2026-06-16T01:25:09.107362Z","end":"2026-06-16T01:25:09.372789Z","steps":["trace[1418421825] 'agreement among raft nodes before linearized reading' (duration: 265.16051ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:09.372806Z","caller":"traceutil/trace.go:171","msg":"trace[1607635610] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25615; }","duration":"358.551454ms","start":"2026-06-16T01:25:09.014217Z","end":"2026-06-16T01:25:09.372768Z","steps":["trace[1607635610] 'agreement among raft nodes before linearized reading' (duration: 358.139376ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:09.372834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:08.647815Z","time spent":"725.010468ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-16T01:25:09.372858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:09.014191Z","time spent":"358.653136ms","remote":"127.0.0.1:50730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-16T01:25:09.636007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.974809ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T01:25:09.636554Z","caller":"traceutil/trace.go:171","msg":"trace[1843279844] transaction","detail":"{read_only:false; response_revision:25616; number_of_response:1; }","duration":"258.537294ms","start":"2026-06-16T01:25:09.377982Z","end":"2026-06-16T01:25:09.636519Z","steps":["trace[1843279844] 'process raft request' (duration: 126.937563ms)","trace[1843279844] 'compare' (duration: 130.513361ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:09.647711Z","caller":"traceutil/trace.go:171","msg":"trace[1715089801] transaction","detail":"{read_only:false; response_revision:25617; number_of_response:1; }","duration":"269.669656ms","start":"2026-06-16T01:25:09.37802Z","end":"2026-06-16T01:25:09.647689Z","steps":["trace[1715089801] 'process raft request' (duration: 269.517103ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:09.648007Z","caller":"traceutil/trace.go:171","msg":"trace[1031266417] linearizableReadLoop","detail":"{readStateIndex:26464; appliedIndex:26460; }","duration":"266.860562ms","start":"2026-06-16T01:25:09.381125Z","end":"2026-06-16T01:25:09.647986Z","steps":["trace[1031266417] 'read index received' (duration: 123.823114ms)","trace[1031266417] 'applied index is now lower than readState.Index' (duration: 143.036508ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:09.648107Z","caller":"traceutil/trace.go:171","msg":"trace[852251521] transaction","detail":"{read_only:false; response_revision:25620; number_of_response:1; }","duration":"266.889363ms","start":"2026-06-16T01:25:09.381205Z","end":"2026-06-16T01:25:09.648095Z","steps":["trace[852251521] 'process raft request' (duration: 266.73526ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:09.648089Z","caller":"traceutil/trace.go:171","msg":"trace[1490998878] transaction","detail":"{read_only:false; response_revision:25618; number_of_response:1; }","duration":"270.064673ms","start":"2026-06-16T01:25:09.377968Z","end":"2026-06-16T01:25:09.648032Z","steps":["trace[1490998878] 'process raft request' (duration: 269.688066ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:09.648044Z","caller":"traceutil/trace.go:171","msg":"trace[876054903] transaction","detail":"{read_only:false; response_revision:25619; number_of_response:1; }","duration":"269.90815ms","start":"2026-06-16T01:25:09.378096Z","end":"2026-06-16T01:25:09.648005Z","steps":["trace[876054903] 'process raft request' (duration: 269.748707ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:09.648272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.126677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18435"} {"level":"info","ts":"2026-06-16T01:25:09.648342Z","caller":"traceutil/trace.go:171","msg":"trace[1294562325] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25620; }","duration":"267.235489ms","start":"2026-06-16T01:25:09.381089Z","end":"2026-06-16T01:25:09.648325Z","steps":["trace[1294562325] 'agreement among raft nodes before linearized reading' (duration: 267.024285ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:09.891504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.724506ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T01:25:09.891662Z","caller":"traceutil/trace.go:171","msg":"trace[63114792] linearizableReadLoop","detail":"{readStateIndex:26466; appliedIndex:26465; }","duration":"243.57013ms","start":"2026-06-16T01:25:09.648061Z","end":"2026-06-16T01:25:09.891631Z","steps":["trace[63114792] 'read index received' (duration: 93.552289ms)","trace[63114792] 'applied index is now lower than readState.Index' (duration: 150.016181ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:09.891756Z","caller":"traceutil/trace.go:171","msg":"trace[418502637] transaction","detail":"{read_only:false; response_revision:25621; number_of_response:1; }","duration":"296.880093ms","start":"2026-06-16T01:25:09.594861Z","end":"2026-06-16T01:25:09.891741Z","steps":["trace[418502637] 'process raft request' (duration: 146.7857ms)","trace[418502637] 'compare' (duration: 149.532132ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:25:09.891875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.234147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T01:25:09.892042Z","caller":"traceutil/trace.go:171","msg":"trace[292509059] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:25621; }","duration":"419.434341ms","start":"2026-06-16T01:25:09.472549Z","end":"2026-06-16T01:25:09.891983Z","steps":["trace[292509059] 'agreement among raft nodes before linearized reading' (duration: 419.206317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:09.892105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:09.472522Z","time spent":"419.569243ms","remote":"127.0.0.1:51024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":19,"response size":31,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-06-16T01:25:09.892096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.271076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"} {"level":"info","ts":"2026-06-16T01:25:09.892176Z","caller":"traceutil/trace.go:171","msg":"trace[873839872] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:25621; }","duration":"320.408599ms","start":"2026-06-16T01:25:09.571747Z","end":"2026-06-16T01:25:09.892156Z","steps":["trace[873839872] 'agreement among raft nodes before linearized reading' (duration: 320.119014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:09.892223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:09.571716Z","time spent":"320.498581ms","remote":"127.0.0.1:50710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1889,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-06-16T01:25:09.892753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.746752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T01:25:09.892834Z","caller":"traceutil/trace.go:171","msg":"trace[1255581474] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:25621; }","duration":"475.879314ms","start":"2026-06-16T01:25:09.416936Z","end":"2026-06-16T01:25:09.892815Z","steps":["trace[1255581474] 'agreement among raft nodes before linearized reading' (duration: 474.850614ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:09.892872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:09.41692Z","time spent":"475.942935ms","remote":"127.0.0.1:34034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":2,"response size":31,"request content":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true "} {"level":"info","ts":"2026-06-16T01:25:09.954187Z","caller":"traceutil/trace.go:171","msg":"trace[730961505] transaction","detail":"{read_only:false; response_revision:25622; number_of_response:1; }","duration":"203.61891ms","start":"2026-06-16T01:25:09.750537Z","end":"2026-06-16T01:25:09.954156Z","steps":["trace[730961505] 'process raft request' (duration: 203.225622ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:09.954708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.912474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:25:09.954786Z","caller":"traceutil/trace.go:171","msg":"trace[1851847204] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25622; }","duration":"246.055907ms","start":"2026-06-16T01:25:09.708711Z","end":"2026-06-16T01:25:09.954766Z","steps":["trace[1851847204] 'agreement among raft nodes before linearized reading' (duration: 245.298523ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:10.246099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.94041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/trunks/\" range_end:\"/registry/openstack.k-orc.cloud/trunks0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:25:10.246197Z","caller":"traceutil/trace.go:171","msg":"trace[1125154810] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/trunks/; range_end:/registry/openstack.k-orc.cloud/trunks0; response_count:0; response_revision:25622; }","duration":"149.091843ms","start":"2026-06-16T01:25:10.097081Z","end":"2026-06-16T01:25:10.246173Z","steps":["trace[1125154810] 'count revisions from in-memory index tree' (duration: 148.783107ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:10.805538Z","caller":"traceutil/trace.go:171","msg":"trace[1281107631] transaction","detail":"{read_only:false; response_revision:25623; number_of_response:1; }","duration":"420.789848ms","start":"2026-06-16T01:25:10.384716Z","end":"2026-06-16T01:25:10.805505Z","steps":["trace[1281107631] 'process raft request' (duration: 420.369629ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:10.805728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:10.384694Z","time spent":"420.9337ms","remote":"127.0.0.1:50556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":121,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:10.830321Z","caller":"traceutil/trace.go:171","msg":"trace[1132950383] transaction","detail":"{read_only:false; response_revision:25624; number_of_response:1; }","duration":"375.936424ms","start":"2026-06-16T01:25:10.454353Z","end":"2026-06-16T01:25:10.830289Z","steps":["trace[1132950383] 'process raft request' (duration: 375.629948ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:10.830348Z","caller":"traceutil/trace.go:171","msg":"trace[1702741960] transaction","detail":"{read_only:false; response_revision:25625; number_of_response:1; }","duration":"188.257318ms","start":"2026-06-16T01:25:10.642061Z","end":"2026-06-16T01:25:10.830319Z","steps":["trace[1702741960] 'process raft request' (duration: 188.135395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:10.830527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:10.454328Z","time spent":"376.079047ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:11.31289Z","caller":"traceutil/trace.go:171","msg":"trace[280347078] transaction","detail":"{read_only:false; response_revision:25626; number_of_response:1; }","duration":"115.451403ms","start":"2026-06-16T01:25:11.197419Z","end":"2026-06-16T01:25:11.312871Z","steps":["trace[280347078] 'process raft request' (duration: 115.31371ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:11.600115Z","caller":"traceutil/trace.go:171","msg":"trace[1049212746] transaction","detail":"{read_only:false; response_revision:25629; number_of_response:1; }","duration":"400.92681ms","start":"2026-06-16T01:25:11.19916Z","end":"2026-06-16T01:25:11.600087Z","steps":["trace[1049212746] 'process raft request' (duration: 400.873559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:11.60026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:11.199153Z","time spent":"401.031981ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:11.600606Z","caller":"traceutil/trace.go:171","msg":"trace[2098892103] transaction","detail":"{read_only:false; response_revision:25627; number_of_response:1; }","duration":"402.069312ms","start":"2026-06-16T01:25:11.198525Z","end":"2026-06-16T01:25:11.600594Z","steps":["trace[2098892103] 'process raft request' (duration: 401.312787ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:11.600672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:11.198506Z","time spent":"402.130114ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:11.600795Z","caller":"traceutil/trace.go:171","msg":"trace[1113915938] linearizableReadLoop","detail":"{readStateIndex:26476; appliedIndex:26472; }","duration":"184.207181ms","start":"2026-06-16T01:25:11.416563Z","end":"2026-06-16T01:25:11.60077Z","steps":["trace[1113915938] 'read index received' (duration: 183.271243ms)","trace[1113915938] 'applied index is now lower than readState.Index' (duration: 934.788µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:11.60088Z","caller":"traceutil/trace.go:171","msg":"trace[17606344] transaction","detail":"{read_only:false; response_revision:25628; number_of_response:1; }","duration":"402.245495ms","start":"2026-06-16T01:25:11.198623Z","end":"2026-06-16T01:25:11.600869Z","steps":["trace[17606344] 'process raft request' (duration: 401.363398ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:11.600904Z","caller":"traceutil/trace.go:171","msg":"trace[2042321861] transaction","detail":"{read_only:false; response_revision:25630; number_of_response:1; }","duration":"221.706714ms","start":"2026-06-16T01:25:11.379186Z","end":"2026-06-16T01:25:11.600893Z","steps":["trace[2042321861] 'process raft request' (duration: 221.412989ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:11.600933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:11.198597Z","time spent":"402.308337ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:25:11.601155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.583968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/magnum-api-6fcd4b8dd5-6rhtw\" ","response":"range_response_count:1 size:8649"} {"level":"info","ts":"2026-06-16T01:25:11.601191Z","caller":"traceutil/trace.go:171","msg":"trace[2012502311] range","detail":"{range_begin:/registry/pods/openstack/magnum-api-6fcd4b8dd5-6rhtw; range_end:; response_count:1; response_revision:25630; }","duration":"184.67397ms","start":"2026-06-16T01:25:11.416508Z","end":"2026-06-16T01:25:11.601182Z","steps":["trace[2012502311] 'agreement among raft nodes before linearized reading' (duration: 184.498536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:11.601395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.361626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T01:25:11.601427Z","caller":"traceutil/trace.go:171","msg":"trace[1745979473] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:25630; }","duration":"111.437557ms","start":"2026-06-16T01:25:11.489978Z","end":"2026-06-16T01:25:11.601416Z","steps":["trace[1745979473] 'agreement among raft nodes before linearized reading' (duration: 111.381586ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:11.871717Z","caller":"traceutil/trace.go:171","msg":"trace[1412510498] linearizableReadLoop","detail":"{readStateIndex:26477; appliedIndex:26476; }","duration":"230.613853ms","start":"2026-06-16T01:25:11.641073Z","end":"2026-06-16T01:25:11.871687Z","steps":["trace[1412510498] 'read index received' (duration: 230.371928ms)","trace[1412510498] 'applied index is now lower than readState.Index' (duration: 240.575µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:11.871783Z","caller":"traceutil/trace.go:171","msg":"trace[2002154567] transaction","detail":"{read_only:false; response_revision:25631; number_of_response:1; }","duration":"260.118804ms","start":"2026-06-16T01:25:11.611629Z","end":"2026-06-16T01:25:11.871747Z","steps":["trace[2002154567] 'process raft request' (duration: 259.856809ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:11.872038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.934478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-16T01:25:11.872076Z","caller":"traceutil/trace.go:171","msg":"trace[1828527118] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25631; }","duration":"231.019ms","start":"2026-06-16T01:25:11.641045Z","end":"2026-06-16T01:25:11.872064Z","steps":["trace[1828527118] 'agreement among raft nodes before linearized reading' (duration: 230.820927ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:11.872155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.872248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-16T01:25:11.872204Z","caller":"traceutil/trace.go:171","msg":"trace[2016110565] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25631; }","duration":"220.011552ms","start":"2026-06-16T01:25:11.652181Z","end":"2026-06-16T01:25:11.872193Z","steps":["trace[2016110565] 'agreement among raft nodes before linearized reading' (duration: 219.803067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:11.872393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.454161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-16T01:25:11.872423Z","caller":"traceutil/trace.go:171","msg":"trace[80182326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25631; }","duration":"219.528422ms","start":"2026-06-16T01:25:11.652887Z","end":"2026-06-16T01:25:11.872415Z","steps":["trace[80182326] 'agreement among raft nodes before linearized reading' (duration: 219.41919ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:11.872402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.008623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-16T01:25:11.872491Z","caller":"traceutil/trace.go:171","msg":"trace[151746096] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25631; }","duration":"219.129465ms","start":"2026-06-16T01:25:11.653344Z","end":"2026-06-16T01:25:11.872473Z","steps":["trace[151746096] 'agreement among raft nodes before linearized reading' (duration: 218.905441ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:11.872503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.168835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-16T01:25:11.872548Z","caller":"traceutil/trace.go:171","msg":"trace[14708554] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25631; }","duration":"220.238106ms","start":"2026-06-16T01:25:11.6523Z","end":"2026-06-16T01:25:11.872538Z","steps":["trace[14708554] 'agreement among raft nodes before linearized reading' (duration: 220.108174ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:11.872663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.94333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:25:11.872713Z","caller":"traceutil/trace.go:171","msg":"trace[1951579333] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25631; }","duration":"119.014712ms","start":"2026-06-16T01:25:11.753689Z","end":"2026-06-16T01:25:11.872704Z","steps":["trace[1951579333] 'agreement among raft nodes before linearized reading' (duration: 118.936631ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:13.6715Z","caller":"traceutil/trace.go:171","msg":"trace[934317111] transaction","detail":"{read_only:false; response_revision:25647; number_of_response:1; }","duration":"363.667002ms","start":"2026-06-16T01:25:13.307804Z","end":"2026-06-16T01:25:13.671471Z","steps":["trace[934317111] 'process raft request' (duration: 363.498628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:13.671664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:13.307782Z","time spent":"363.794684ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:25:14.011121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.463305ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T01:25:14.011416Z","caller":"traceutil/trace.go:171","msg":"trace[2060144661] transaction","detail":"{read_only:false; response_revision:25648; number_of_response:1; }","duration":"693.291296ms","start":"2026-06-16T01:25:13.318044Z","end":"2026-06-16T01:25:14.011336Z","steps":["trace[2060144661] 'process raft request' (duration: 538.509095ms)","trace[2060144661] 'compare' (duration: 154.268462ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:14.011561Z","caller":"traceutil/trace.go:171","msg":"trace[1616691338] transaction","detail":"{read_only:false; response_revision:25650; number_of_response:1; }","duration":"403.422778ms","start":"2026-06-16T01:25:13.608111Z","end":"2026-06-16T01:25:14.011533Z","steps":["trace[1616691338] 'process raft request' (duration: 403.249774ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:14.011674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:13.318025Z","time spent":"693.50034ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:14.011735Z","caller":"traceutil/trace.go:171","msg":"trace[1901602874] transaction","detail":"{read_only:false; response_revision:25649; number_of_response:1; }","duration":"404.05287ms","start":"2026-06-16T01:25:13.607672Z","end":"2026-06-16T01:25:14.011724Z","steps":["trace[1901602874] 'process raft request' (duration: 403.56474ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:14.011791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:13.607656Z","time spent":"404.105231ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:25:14.011688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:13.608104Z","time spent":"403.5193ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:14.012008Z","caller":"traceutil/trace.go:171","msg":"trace[283499936] transaction","detail":"{read_only:false; response_revision:25651; number_of_response:1; }","duration":"403.375686ms","start":"2026-06-16T01:25:13.608584Z","end":"2026-06-16T01:25:14.01196Z","steps":["trace[283499936] 'process raft request' (duration: 402.887186ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:14.012011Z","caller":"traceutil/trace.go:171","msg":"trace[1432588190] linearizableReadLoop","detail":"{readStateIndex:26494; appliedIndex:26493; }","duration":"693.856378ms","start":"2026-06-16T01:25:13.318129Z","end":"2026-06-16T01:25:14.011985Z","steps":["trace[1432588190] 'read index received' (duration: 353.418658ms)","trace[1432588190] 'applied index is now lower than readState.Index' (duration: 340.43674ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:14.012028Z","caller":"traceutil/trace.go:171","msg":"trace[1243081112] transaction","detail":"{read_only:false; response_revision:25652; number_of_response:1; }","duration":"402.566692ms","start":"2026-06-16T01:25:13.609411Z","end":"2026-06-16T01:25:14.011978Z","steps":["trace[1243081112] 'process raft request' (duration: 402.425289ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:14.012088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:13.608577Z","time spent":"403.475628ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:14.012109Z","caller":"traceutil/trace.go:171","msg":"trace[1744065779] transaction","detail":"{read_only:false; response_revision:25653; number_of_response:1; }","duration":"109.035792ms","start":"2026-06-16T01:25:13.903022Z","end":"2026-06-16T01:25:14.012058Z","steps":["trace[1744065779] 'process raft request' (duration: 108.92347ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:14.012233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:13.609402Z","time spent":"402.718774ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:25:14.012228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.065192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T01:25:14.012267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.486353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:25:14.012309Z","caller":"traceutil/trace.go:171","msg":"trace[366606108] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:25653; }","duration":"694.198594ms","start":"2026-06-16T01:25:13.318084Z","end":"2026-06-16T01:25:14.012283Z","steps":["trace[366606108] 'agreement among raft nodes before linearized reading' (duration: 694.020721ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:14.012356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:13.318066Z","time spent":"694.278765ms","remote":"127.0.0.1:55218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-16T01:25:14.012376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.798584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-16T01:25:14.012434Z","caller":"traceutil/trace.go:171","msg":"trace[847486883] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25653; }","duration":"122.862106ms","start":"2026-06-16T01:25:13.889552Z","end":"2026-06-16T01:25:14.012414Z","steps":["trace[847486883] 'agreement among raft nodes before linearized reading' (duration: 122.694303ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:14.012356Z","caller":"traceutil/trace.go:171","msg":"trace[1994427299] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25653; }","duration":"257.613246ms","start":"2026-06-16T01:25:13.754715Z","end":"2026-06-16T01:25:14.012328Z","steps":["trace[1994427299] 'agreement among raft nodes before linearized reading' (duration: 257.450873ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:14.01253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.713662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-16T01:25:14.012573Z","caller":"traceutil/trace.go:171","msg":"trace[731068214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25653; }","duration":"122.765892ms","start":"2026-06-16T01:25:13.889799Z","end":"2026-06-16T01:25:14.012565Z","steps":["trace[731068214] 'agreement among raft nodes before linearized reading' (duration: 122.579739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:14.01261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.183679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-06-16T01:25:14.01253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.10143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-16T01:25:14.012644Z","caller":"traceutil/trace.go:171","msg":"trace[1220596283] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25653; }","duration":"124.212671ms","start":"2026-06-16T01:25:13.888419Z","end":"2026-06-16T01:25:14.012632Z","steps":["trace[1220596283] 'agreement among raft nodes before linearized reading' (duration: 124.134699ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:14.012659Z","caller":"traceutil/trace.go:171","msg":"trace[1883667306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25653; }","duration":"123.257523ms","start":"2026-06-16T01:25:13.889389Z","end":"2026-06-16T01:25:14.012646Z","steps":["trace[1883667306] 'agreement among raft nodes before linearized reading' (duration: 122.992538ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:14.01279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.194047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-16T01:25:14.012837Z","caller":"traceutil/trace.go:171","msg":"trace[610424252] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25653; }","duration":"127.290239ms","start":"2026-06-16T01:25:13.885535Z","end":"2026-06-16T01:25:14.012825Z","steps":["trace[610424252] 'agreement among raft nodes before linearized reading' (duration: 127.048105ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:14.285584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.922896ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T01:25:14.28597Z","caller":"traceutil/trace.go:171","msg":"trace[1340646965] transaction","detail":"{read_only:false; response_revision:25657; number_of_response:1; }","duration":"266.562326ms","start":"2026-06-16T01:25:14.019385Z","end":"2026-06-16T01:25:14.285948Z","steps":["trace[1340646965] 'process raft request' (duration: 266.491795ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:14.286138Z","caller":"traceutil/trace.go:171","msg":"trace[2023268127] transaction","detail":"{read_only:false; response_revision:25654; number_of_response:1; }","duration":"267.676519ms","start":"2026-06-16T01:25:14.018419Z","end":"2026-06-16T01:25:14.286095Z","steps":["trace[2023268127] 'process raft request' (duration: 133.11817ms)","trace[2023268127] 'compare' (duration: 133.469908ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:14.286255Z","caller":"traceutil/trace.go:171","msg":"trace[544397237] transaction","detail":"{read_only:false; response_revision:25655; number_of_response:1; }","duration":"267.265309ms","start":"2026-06-16T01:25:14.018978Z","end":"2026-06-16T01:25:14.286243Z","steps":["trace[544397237] 'process raft request' (duration: 266.755569ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:14.286479Z","caller":"traceutil/trace.go:171","msg":"trace[1781695070] transaction","detail":"{read_only:false; response_revision:25656; number_of_response:1; }","duration":"267.415663ms","start":"2026-06-16T01:25:14.01905Z","end":"2026-06-16T01:25:14.286465Z","steps":["trace[1781695070] 'process raft request' (duration: 266.79443ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:14.286644Z","caller":"traceutil/trace.go:171","msg":"trace[1220900457] transaction","detail":"{read_only:false; response_revision:25658; number_of_response:1; }","duration":"267.099276ms","start":"2026-06-16T01:25:14.019515Z","end":"2026-06-16T01:25:14.286614Z","steps":["trace[1220900457] 'process raft request' (duration: 266.385022ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:24.074269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.849654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T01:25:24.074325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.158086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:25:24.074379Z","caller":"traceutil/trace.go:171","msg":"trace[607236313] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:25729; }","duration":"255.008707ms","start":"2026-06-16T01:25:23.819342Z","end":"2026-06-16T01:25:24.07435Z","steps":["trace[607236313] 'count revisions from in-memory index tree' (duration: 254.720511ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:24.074419Z","caller":"traceutil/trace.go:171","msg":"trace[1259080158] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:25729; }","duration":"248.289529ms","start":"2026-06-16T01:25:23.826088Z","end":"2026-06-16T01:25:24.074378Z","steps":["trace[1259080158] 'count revisions from in-memory index tree' (duration: 248.054175ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:24.666649Z","caller":"traceutil/trace.go:171","msg":"trace[518642226] transaction","detail":"{read_only:false; response_revision:25733; number_of_response:1; }","duration":"605.002789ms","start":"2026-06-16T01:25:24.061617Z","end":"2026-06-16T01:25:24.66662Z","steps":["trace[518642226] 'process raft request' (duration: 604.919877ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:24.666907Z","caller":"traceutil/trace.go:171","msg":"trace[287917089] linearizableReadLoop","detail":"{readStateIndex:26583; appliedIndex:26578; }","duration":"328.86242ms","start":"2026-06-16T01:25:24.338033Z","end":"2026-06-16T01:25:24.666896Z","steps":["trace[287917089] 'read index received' (duration: 328.33387ms)","trace[287917089] 'applied index is now lower than readState.Index' (duration: 527.74µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:24.666929Z","caller":"traceutil/trace.go:171","msg":"trace[73834218] transaction","detail":"{read_only:false; response_revision:25734; number_of_response:1; }","duration":"604.57153ms","start":"2026-06-16T01:25:24.06233Z","end":"2026-06-16T01:25:24.666901Z","steps":["trace[73834218] 'process raft request' (duration: 604.252764ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:24.666945Z","caller":"traceutil/trace.go:171","msg":"trace[584123234] transaction","detail":"{read_only:false; response_revision:25735; number_of_response:1; }","duration":"604.358387ms","start":"2026-06-16T01:25:24.062555Z","end":"2026-06-16T01:25:24.666913Z","steps":["trace[584123234] 'process raft request' (duration: 604.224254ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:24.666915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.061591Z","time spent":"605.237684ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:25:24.667081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.06232Z","time spent":"604.680902ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:24.666653Z","caller":"traceutil/trace.go:171","msg":"trace[194744682] transaction","detail":"{read_only:false; response_revision:25731; number_of_response:1; }","duration":"607.084668ms","start":"2026-06-16T01:25:24.059531Z","end":"2026-06-16T01:25:24.666616Z","steps":["trace[194744682] 'process raft request' (duration: 606.788642ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:24.66711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.062544Z","time spent":"604.478079ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:25:24.667162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.110495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-16T01:25:24.667207Z","caller":"traceutil/trace.go:171","msg":"trace[1982585704] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25735; }","duration":"329.204987ms","start":"2026-06-16T01:25:24.33799Z","end":"2026-06-16T01:25:24.667195Z","steps":["trace[1982585704] 'agreement among raft nodes before linearized reading' (duration: 328.989733ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:24.667247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.33797Z","time spent":"329.268598ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-16T01:25:24.666686Z","caller":"traceutil/trace.go:171","msg":"trace[1350405748] transaction","detail":"{read_only:false; response_revision:25732; number_of_response:1; }","duration":"605.03474ms","start":"2026-06-16T01:25:24.061617Z","end":"2026-06-16T01:25:24.666652Z","steps":["trace[1350405748] 'process raft request' (duration: 604.879186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:24.667277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.059522Z","time spent":"607.647598ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:25:24.667296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.939215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-16T01:25:24.667324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.989911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-06-16T01:25:24.667341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.878354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-16T01:25:24.667389Z","caller":"traceutil/trace.go:171","msg":"trace[1022020834] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25735; }","duration":"326.087478ms","start":"2026-06-16T01:25:24.341281Z","end":"2026-06-16T01:25:24.667369Z","steps":["trace[1022020834] 'agreement among raft nodes before linearized reading' (duration: 325.800763ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:24.667395Z","caller":"traceutil/trace.go:171","msg":"trace[1610535587] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25735; }","duration":"325.939885ms","start":"2026-06-16T01:25:24.341442Z","end":"2026-06-16T01:25:24.667382Z","steps":["trace[1610535587] 'agreement among raft nodes before linearized reading' (duration: 325.756562ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:24.667419Z","caller":"traceutil/trace.go:171","msg":"trace[69764423] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25735; }","duration":"321.117532ms","start":"2026-06-16T01:25:24.346281Z","end":"2026-06-16T01:25:24.667398Z","steps":["trace[69764423] 'agreement among raft nodes before linearized reading' (duration: 320.874388ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:24.667412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.326533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-06-16T01:25:24.66746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.34627Z","time spent":"321.180904ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-16T01:25:24.667326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.061592Z","time spent":"605.698761ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:24.667535Z","caller":"traceutil/trace.go:171","msg":"trace[452265307] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25735; }","duration":"325.556377ms","start":"2026-06-16T01:25:24.341965Z","end":"2026-06-16T01:25:24.667521Z","steps":["trace[452265307] 'agreement among raft nodes before linearized reading' (duration: 325.159109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:24.667446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.341369Z","time spent":"326.067227ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-16T01:25:24.667444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.34126Z","time spent":"326.176049ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-16T01:25:24.667629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.341954Z","time spent":"325.663458ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-16T01:25:25.149049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.19617ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T01:25:25.149185Z","caller":"traceutil/trace.go:171","msg":"trace[300107940] transaction","detail":"{read_only:false; response_revision:25736; number_of_response:1; }","duration":"477.079458ms","start":"2026-06-16T01:25:24.672085Z","end":"2026-06-16T01:25:25.149165Z","steps":["trace[300107940] 'process raft request' (duration: 230.692035ms)","trace[300107940] 'compare' (duration: 245.69953ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:25:25.149245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.672054Z","time spent":"477.162178ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:25:25.744264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.753835ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T01:25:25.74456Z","caller":"traceutil/trace.go:171","msg":"trace[2128028325] transaction","detail":"{read_only:false; response_revision:25739; number_of_response:1; }","duration":"1.071872701s","start":"2026-06-16T01:25:24.672667Z","end":"2026-06-16T01:25:25.744539Z","steps":["trace[2128028325] 'process raft request' (duration: 1.071761259s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:25.74473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.672642Z","time spent":"1.071992813s","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:25.744739Z","caller":"traceutil/trace.go:171","msg":"trace[1723369270] transaction","detail":"{read_only:false; response_revision:25737; number_of_response:1; }","duration":"1.072290199s","start":"2026-06-16T01:25:24.672367Z","end":"2026-06-16T01:25:25.744657Z","steps":["trace[1723369270] 'process raft request' (duration: 800.051865ms)","trace[1723369270] 'compare' (duration: 270.731135ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:25.744751Z","caller":"traceutil/trace.go:171","msg":"trace[1290794922] transaction","detail":"{read_only:false; response_revision:25738; number_of_response:1; }","duration":"1.072284828s","start":"2026-06-16T01:25:24.67238Z","end":"2026-06-16T01:25:25.744665Z","steps":["trace[1290794922] 'process raft request' (duration: 1.071988483s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:25.744904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.672344Z","time spent":"1.072478273s","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:25:25.744927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.672363Z","time spent":"1.072479403s","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:25.745108Z","caller":"traceutil/trace.go:171","msg":"trace[310195281] transaction","detail":"{read_only:false; response_revision:25740; number_of_response:1; }","duration":"1.07228632s","start":"2026-06-16T01:25:24.672784Z","end":"2026-06-16T01:25:25.745071Z","steps":["trace[310195281] 'process raft request' (duration: 1.071681207s)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:25.745253Z","caller":"traceutil/trace.go:171","msg":"trace[660437998] transaction","detail":"{read_only:false; response_revision:25741; number_of_response:1; }","duration":"989.073249ms","start":"2026-06-16T01:25:24.756167Z","end":"2026-06-16T01:25:25.745241Z","steps":["trace[660437998] 'process raft request' (duration: 988.813664ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:25.745236Z","caller":"traceutil/trace.go:171","msg":"trace[1326904343] linearizableReadLoop","detail":"{readStateIndex:26588; appliedIndex:26583; }","duration":"990.858622ms","start":"2026-06-16T01:25:24.754351Z","end":"2026-06-16T01:25:25.74521Z","steps":["trace[1326904343] 'read index received' (duration: 148.445271ms)","trace[1326904343] 'applied index is now lower than readState.Index' (duration: 842.412471ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:25.745271Z","caller":"traceutil/trace.go:171","msg":"trace[2050585239] transaction","detail":"{read_only:false; response_revision:25742; number_of_response:1; }","duration":"864.069512ms","start":"2026-06-16T01:25:24.881172Z","end":"2026-06-16T01:25:25.745242Z","steps":["trace[2050585239] 'process raft request' (duration: 863.938069ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:25.745321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.672776Z","time spent":"1.072417052s","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:25:25.745321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.756152Z","time spent":"989.131309ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:25.745349Z","caller":"traceutil/trace.go:171","msg":"trace[1784278285] transaction","detail":"{read_only:false; response_revision:25743; number_of_response:1; }","duration":"860.76085ms","start":"2026-06-16T01:25:24.884542Z","end":"2026-06-16T01:25:25.745303Z","steps":["trace[1784278285] 'process raft request' (duration: 860.616327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:25.745396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"991.048595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T01:25:25.74542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.881144Z","time spent":"864.193844ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:25.745442Z","caller":"traceutil/trace.go:171","msg":"trace[355128253] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25743; }","duration":"991.137617ms","start":"2026-06-16T01:25:24.754292Z","end":"2026-06-16T01:25:25.74543Z","steps":["trace[355128253] 'agreement among raft nodes before linearized reading' (duration: 991.031605ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:25.745549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.754264Z","time spent":"991.27447ms","remote":"127.0.0.1:50520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-16T01:25:25.745576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.884522Z","time spent":"860.914462ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:25:26.182913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.67022ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T01:25:26.183041Z","caller":"traceutil/trace.go:171","msg":"trace[639402372] transaction","detail":"{read_only:false; response_revision:25744; number_of_response:1; }","duration":"1.215962951s","start":"2026-06-16T01:25:24.967056Z","end":"2026-06-16T01:25:26.183019Z","steps":["trace[639402372] 'process raft request' (duration: 1.05122849s)","trace[639402372] 'compare' (duration: 164.413845ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:25:26.183104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:24.967033Z","time spent":"1.216040242s","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:26.218834Z","caller":"traceutil/trace.go:171","msg":"trace[1221246955] linearizableReadLoop","detail":"{readStateIndex:26593; appliedIndex:26591; }","duration":"473.496489ms","start":"2026-06-16T01:25:25.745302Z","end":"2026-06-16T01:25:26.218799Z","steps":["trace[1221246955] 'read index received' (duration: 272.815125ms)","trace[1221246955] 'applied index is now lower than readState.Index' (duration: 200.678004ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:25:26.219045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.863441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:25:26.219085Z","caller":"traceutil/trace.go:171","msg":"trace[1626286102] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:25745; }","duration":"577.989795ms","start":"2026-06-16T01:25:25.641082Z","end":"2026-06-16T01:25:26.219072Z","steps":["trace[1626286102] 'agreement among raft nodes before linearized reading' (duration: 577.863592ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:26.219073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.258152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T01:25:26.219123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:25.641055Z","time spent":"578.058026ms","remote":"127.0.0.1:34024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true "} {"level":"warn","ts":"2026-06-16T01:25:26.219134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.261576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:25:26.219187Z","caller":"traceutil/trace.go:171","msg":"trace[555601483] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25745; }","duration":"471.359938ms","start":"2026-06-16T01:25:25.747813Z","end":"2026-06-16T01:25:26.219172Z","steps":["trace[555601483] 'agreement among raft nodes before linearized reading' (duration: 471.281716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:26.219206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.684995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routers/\" range_end:\"/registry/openstack.k-orc.cloud/routers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T01:25:26.219225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:25.747784Z","time spent":"471.429099ms","remote":"127.0.0.1:50534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-16T01:25:26.219238Z","caller":"traceutil/trace.go:171","msg":"trace[984031892] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routers/; range_end:/registry/openstack.k-orc.cloud/routers0; response_count:0; response_revision:25745; }","duration":"631.753517ms","start":"2026-06-16T01:25:25.587475Z","end":"2026-06-16T01:25:26.219228Z","steps":["trace[984031892] 'agreement among raft nodes before linearized reading' (duration: 631.698286ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:26.219273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:25.587454Z","time spent":"631.808177ms","remote":"127.0.0.1:45626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/routers/\" range_end:\"/registry/openstack.k-orc.cloud/routers0\" count_only:true "} {"level":"warn","ts":"2026-06-16T01:25:26.219243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.631973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T01:25:26.219342Z","caller":"traceutil/trace.go:171","msg":"trace[1183333065] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:25745; }","duration":"611.788476ms","start":"2026-06-16T01:25:25.607533Z","end":"2026-06-16T01:25:26.219321Z","steps":["trace[1183333065] 'agreement among raft nodes before linearized reading' (duration: 611.631923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:26.219396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:25.607522Z","time spent":"611.862848ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":1,"response size":31,"request content":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true "} {"level":"info","ts":"2026-06-16T01:25:26.219147Z","caller":"traceutil/trace.go:171","msg":"trace[1930535593] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:25745; }","duration":"938.388995ms","start":"2026-06-16T01:25:25.280738Z","end":"2026-06-16T01:25:26.219127Z","steps":["trace[1930535593] 'agreement among raft nodes before linearized reading' (duration: 938.270213ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:26.219501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.015448899s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"warn","ts":"2026-06-16T01:25:26.21956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:25.280713Z","time spent":"938.808143ms","remote":"127.0.0.1:55356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"info","ts":"2026-06-16T01:25:26.219569Z","caller":"traceutil/trace.go:171","msg":"trace[1466983389] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25745; }","duration":"1.015523491s","start":"2026-06-16T01:25:25.204001Z","end":"2026-06-16T01:25:26.219524Z","steps":["trace[1466983389] 'agreement among raft nodes before linearized reading' (duration: 1.015393639s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:26.219603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:25.203979Z","time spent":"1.015615013s","remote":"127.0.0.1:50730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-16T01:25:26.748005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.345206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:25:26.748097Z","caller":"traceutil/trace.go:171","msg":"trace[1843456790] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:25745; }","duration":"382.497859ms","start":"2026-06-16T01:25:26.365581Z","end":"2026-06-16T01:25:26.748079Z","steps":["trace[1843456790] 'count revisions from in-memory index tree' (duration: 382.262835ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:26.74814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:26.365566Z","time spent":"382.563371ms","remote":"127.0.0.1:33988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true "} {"level":"warn","ts":"2026-06-16T01:25:26.748212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.918628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" ","response":"range_response_count:1 size:1864"} {"level":"info","ts":"2026-06-16T01:25:26.748293Z","caller":"traceutil/trace.go:171","msg":"trace[832711929] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0; range_end:; response_count:1; response_revision:25745; }","duration":"131.0576ms","start":"2026-06-16T01:25:26.617217Z","end":"2026-06-16T01:25:26.748274Z","steps":["trace[832711929] 'range keys from in-memory index tree' (duration: 130.732564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:26.748495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.910893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:25:26.748542Z","caller":"traceutil/trace.go:171","msg":"trace[1623530711] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25745; }","duration":"457.005925ms","start":"2026-06-16T01:25:26.291523Z","end":"2026-06-16T01:25:26.748529Z","steps":["trace[1623530711] 'range keys from in-memory index tree' (duration: 456.768171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:26.748575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:26.291501Z","time spent":"457.066196ms","remote":"127.0.0.1:51010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-06-16T01:25:27.251618Z","caller":"traceutil/trace.go:171","msg":"trace[1797953278] transaction","detail":"{read_only:false; response_revision:25746; number_of_response:1; }","duration":"630.388221ms","start":"2026-06-16T01:25:26.621204Z","end":"2026-06-16T01:25:27.251592Z","steps":["trace[1797953278] 'process raft request' (duration: 629.628506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:27.251785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:26.621168Z","time spent":"630.521804ms","remote":"127.0.0.1:33980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418362,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:27.675596Z","caller":"traceutil/trace.go:171","msg":"trace[122039942] transaction","detail":"{read_only:false; response_revision:25747; number_of_response:1; }","duration":"1.001805031s","start":"2026-06-16T01:25:26.673748Z","end":"2026-06-16T01:25:27.675553Z","steps":["trace[122039942] 'process raft request' (duration: 1.000940454s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:27.675801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:26.673729Z","time spent":"1.001978964s","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:27.675577Z","caller":"traceutil/trace.go:171","msg":"trace[756494401] transaction","detail":"{read_only:false; response_revision:25748; number_of_response:1; }","duration":"1.001661568s","start":"2026-06-16T01:25:26.673887Z","end":"2026-06-16T01:25:27.675549Z","steps":["trace[756494401] 'process raft request' (duration: 1.001577725s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:27.675968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:26.673866Z","time spent":"1.002022424s","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:27.675985Z","caller":"traceutil/trace.go:171","msg":"trace[885385098] transaction","detail":"{read_only:false; response_revision:25749; number_of_response:1; }","duration":"1.002064615s","start":"2026-06-16T01:25:26.673889Z","end":"2026-06-16T01:25:27.675953Z","steps":["trace[885385098] 'process raft request' (duration: 1.001618277s)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:27.676081Z","caller":"traceutil/trace.go:171","msg":"trace[1540268743] transaction","detail":"{read_only:false; response_revision:25750; number_of_response:1; }","duration":"1.002149817s","start":"2026-06-16T01:25:26.673891Z","end":"2026-06-16T01:25:27.67604Z","steps":["trace[1540268743] 'process raft request' (duration: 1.001926443s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:27.676133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:26.673863Z","time spent":"1.002195647s","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:27.67602Z","caller":"traceutil/trace.go:171","msg":"trace[784616083] linearizableReadLoop","detail":"{readStateIndex:26600; appliedIndex:26594; }","duration":"920.948554ms","start":"2026-06-16T01:25:26.755035Z","end":"2026-06-16T01:25:27.675984Z","steps":["trace[784616083] 'read index received' (duration: 495.767313ms)","trace[784616083] 'applied index is now lower than readState.Index' (duration: 425.179891ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:25:27.676234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:26.673862Z","time spent":"1.002294559s","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:27.676305Z","caller":"traceutil/trace.go:171","msg":"trace[729403220] transaction","detail":"{read_only:false; response_revision:25751; number_of_response:1; }","duration":"1.002190737s","start":"2026-06-16T01:25:26.674104Z","end":"2026-06-16T01:25:27.676294Z","steps":["trace[729403220] 'process raft request' (duration: 1.001837691s)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:27.676374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:26.674093Z","time spent":"1.002248228s","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:25:27.676516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"920.745058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-573eb672-8b48-4aa6-9e19-557c9eefe2bb\" ","response":"range_response_count:1 size:1324"} {"level":"info","ts":"2026-06-16T01:25:27.676563Z","caller":"traceutil/trace.go:171","msg":"trace[2059437346] range","detail":"{range_begin:/registry/persistentvolumes/pvc-573eb672-8b48-4aa6-9e19-557c9eefe2bb; range_end:; response_count:1; response_revision:25751; }","duration":"920.80213ms","start":"2026-06-16T01:25:26.755739Z","end":"2026-06-16T01:25:27.676541Z","steps":["trace[2059437346] 'agreement among raft nodes before linearized reading' (duration: 920.650797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:27.676594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:26.755723Z","time spent":"920.863921ms","remote":"127.0.0.1:50702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1347,"request content":"key:\"/registry/persistentvolumes/pvc-573eb672-8b48-4aa6-9e19-557c9eefe2bb\" "} {"level":"warn","ts":"2026-06-16T01:25:27.676611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.698296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:25:27.676652Z","caller":"traceutil/trace.go:171","msg":"trace[25780589] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:25751; }","duration":"469.784118ms","start":"2026-06-16T01:25:27.206856Z","end":"2026-06-16T01:25:27.67664Z","steps":["trace[25780589] 'agreement among raft nodes before linearized reading' (duration: 469.702176ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:27.676714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.293431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T01:25:27.676742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:27.206833Z","time spent":"469.89854ms","remote":"127.0.0.1:55284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-16T01:25:27.676782Z","caller":"traceutil/trace.go:171","msg":"trace[1381986341] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25751; }","duration":"919.420924ms","start":"2026-06-16T01:25:26.757342Z","end":"2026-06-16T01:25:27.676763Z","steps":["trace[1381986341] 'agreement among raft nodes before linearized reading' (duration: 919.267661ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:27.676825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:26.757332Z","time spent":"919.484735ms","remote":"127.0.0.1:50736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-16T01:25:27.676834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.263716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-06-16T01:25:27.676855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.193508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:25:27.676918Z","caller":"traceutil/trace.go:171","msg":"trace[1705045788] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:25751; }","duration":"508.318152ms","start":"2026-06-16T01:25:27.168587Z","end":"2026-06-16T01:25:27.676905Z","steps":["trace[1705045788] 'agreement among raft nodes before linearized reading' (duration: 508.200599ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:27.67692Z","caller":"traceutil/trace.go:171","msg":"trace[409608607] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25751; }","duration":"522.38062ms","start":"2026-06-16T01:25:27.154522Z","end":"2026-06-16T01:25:27.676903Z","steps":["trace[409608607] 'agreement among raft nodes before linearized reading' (duration: 522.038462ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:27.676955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:27.168557Z","time spent":"508.388253ms","remote":"127.0.0.1:45792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":128,"response count":0,"response size":29,"request content":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true "} {"level":"warn","ts":"2026-06-16T01:25:27.676957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.537528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T01:25:27.676989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:27.154503Z","time spent":"522.44624ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-16T01:25:27.67702Z","caller":"traceutil/trace.go:171","msg":"trace[408487769] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagerconfigs/; range_end:/registry/monitoring.coreos.com/alertmanagerconfigs0; response_count:0; response_revision:25751; }","duration":"445.639411ms","start":"2026-06-16T01:25:27.231368Z","end":"2026-06-16T01:25:27.677008Z","steps":["trace[408487769] 'agreement among raft nodes before linearized reading' (duration: 445.551959ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:27.677061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:27.231344Z","time spent":"445.706761ms","remote":"127.0.0.1:36490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true "} {"level":"warn","ts":"2026-06-16T01:25:27.67717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.109666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:25:27.678238Z","caller":"traceutil/trace.go:171","msg":"trace[1572817346] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25751; }","duration":"923.246287ms","start":"2026-06-16T01:25:26.754976Z","end":"2026-06-16T01:25:27.678222Z","steps":["trace[1572817346] 'agreement among raft nodes before linearized reading' (duration: 921.354821ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:27.678283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:26.754955Z","time spent":"923.312957ms","remote":"127.0.0.1:50534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-16T01:25:34.874112Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000684d.wal"} {"level":"warn","ts":"2026-06-16T01:25:36.075615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.240913ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T01:25:36.075729Z","caller":"traceutil/trace.go:171","msg":"trace[1995880720] transaction","detail":"{read_only:false; response_revision:25869; number_of_response:1; }","duration":"250.756166ms","start":"2026-06-16T01:25:35.824952Z","end":"2026-06-16T01:25:36.075708Z","steps":["trace[1995880720] 'process raft request' (duration: 127.253489ms)","trace[1995880720] 'compare' (duration: 123.12107ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:36.138398Z","caller":"traceutil/trace.go:171","msg":"trace[1324354436] transaction","detail":"{read_only:false; response_revision:25870; number_of_response:1; }","duration":"313.109142ms","start":"2026-06-16T01:25:35.825252Z","end":"2026-06-16T01:25:36.138362Z","steps":["trace[1324354436] 'process raft request' (duration: 312.806496ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:36.138393Z","caller":"traceutil/trace.go:171","msg":"trace[1268180226] transaction","detail":"{read_only:false; response_revision:25871; number_of_response:1; }","duration":"313.0896ms","start":"2026-06-16T01:25:35.825265Z","end":"2026-06-16T01:25:36.138354Z","steps":["trace[1268180226] 'process raft request' (duration: 312.992299ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:36.138565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:35.825236Z","time spent":"313.244984ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:25:36.138612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:35.825232Z","time spent":"313.266694ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:36.138695Z","caller":"traceutil/trace.go:171","msg":"trace[1380434919] transaction","detail":"{read_only:false; response_revision:25872; number_of_response:1; }","duration":"313.346836ms","start":"2026-06-16T01:25:35.825301Z","end":"2026-06-16T01:25:36.138648Z","steps":["trace[1380434919] 'process raft request' (duration: 313.000989ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:36.138863Z","caller":"traceutil/trace.go:171","msg":"trace[1573252915] linearizableReadLoop","detail":"{readStateIndex:26723; appliedIndex:26719; }","duration":"297.731817ms","start":"2026-06-16T01:25:35.841106Z","end":"2026-06-16T01:25:36.138838Z","steps":["trace[1573252915] 'read index received' (duration: 111.107251ms)","trace[1573252915] 'applied index is now lower than readState.Index' (duration: 186.622996ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:36.138914Z","caller":"traceutil/trace.go:171","msg":"trace[742687358] transaction","detail":"{read_only:false; response_revision:25873; number_of_response:1; }","duration":"259.553842ms","start":"2026-06-16T01:25:35.879348Z","end":"2026-06-16T01:25:36.138902Z","steps":["trace[742687358] 'process raft request' (duration: 259.197896ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:36.138896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:25:35.825276Z","time spent":"313.517328ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:25:36.13913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.603791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-16T01:25:36.139171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.059494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-81d7c420-14b0-4e96-b015-2a4b523c5a59\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-06-16T01:25:36.13918Z","caller":"traceutil/trace.go:171","msg":"trace[405882376] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:25873; }","duration":"251.694212ms","start":"2026-06-16T01:25:35.887475Z","end":"2026-06-16T01:25:36.139169Z","steps":["trace[405882376] 'agreement among raft nodes before linearized reading' (duration: 251.56874ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:36.139223Z","caller":"traceutil/trace.go:171","msg":"trace[1014864817] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-81d7c420-14b0-4e96-b015-2a4b523c5a59; range_end:; response_count:1; response_revision:25873; }","duration":"298.130305ms","start":"2026-06-16T01:25:35.841079Z","end":"2026-06-16T01:25:36.139209Z","steps":["trace[1014864817] 'agreement among raft nodes before linearized reading' (duration: 297.934592ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:36.36509Z","caller":"traceutil/trace.go:171","msg":"trace[75126259] transaction","detail":"{read_only:false; response_revision:25874; number_of_response:1; }","duration":"110.297607ms","start":"2026-06-16T01:25:36.254735Z","end":"2026-06-16T01:25:36.365032Z","steps":["trace[75126259] 'process raft request' (duration: 109.96283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:36.665335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.436334ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T01:25:36.665543Z","caller":"traceutil/trace.go:171","msg":"trace[1951278266] linearizableReadLoop","detail":"{readStateIndex:26726; appliedIndex:26725; }","duration":"223.414355ms","start":"2026-06-16T01:25:36.442107Z","end":"2026-06-16T01:25:36.665522Z","steps":["trace[1951278266] 'read index received' (duration: 67.660895ms)","trace[1951278266] 'applied index is now lower than readState.Index' (duration: 155.75144ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:36.665701Z","caller":"traceutil/trace.go:171","msg":"trace[653209153] transaction","detail":"{read_only:false; response_revision:25875; number_of_response:1; }","duration":"295.327272ms","start":"2026-06-16T01:25:36.370353Z","end":"2026-06-16T01:25:36.665681Z","steps":["trace[653209153] 'process raft request' (duration: 139.43677ms)","trace[653209153] 'compare' (duration: 155.179209ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:25:36.665963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.831265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-81d7c420-14b0-4e96-b015-2a4b523c5a59\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-06-16T01:25:36.666051Z","caller":"traceutil/trace.go:171","msg":"trace[1152457299] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-81d7c420-14b0-4e96-b015-2a4b523c5a59; range_end:; response_count:1; response_revision:25875; }","duration":"223.974186ms","start":"2026-06-16T01:25:36.442056Z","end":"2026-06-16T01:25:36.66603Z","steps":["trace[1152457299] 'agreement among raft nodes before linearized reading' (duration: 223.701642ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:36.817376Z","caller":"traceutil/trace.go:171","msg":"trace[908378900] linearizableReadLoop","detail":"{readStateIndex:26727; appliedIndex:26726; }","duration":"143.395186ms","start":"2026-06-16T01:25:36.673957Z","end":"2026-06-16T01:25:36.817353Z","steps":["trace[908378900] 'read index received' (duration: 143.158621ms)","trace[908378900] 'applied index is now lower than readState.Index' (duration: 235.275µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:36.81748Z","caller":"traceutil/trace.go:171","msg":"trace[68474305] transaction","detail":"{read_only:false; response_revision:25876; number_of_response:1; }","duration":"143.537479ms","start":"2026-06-16T01:25:36.673895Z","end":"2026-06-16T01:25:36.817433Z","steps":["trace[68474305] 'process raft request' (duration: 143.281844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:36.81765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.666481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" ","response":"range_response_count:1 size:1858"} {"level":"info","ts":"2026-06-16T01:25:36.817695Z","caller":"traceutil/trace.go:171","msg":"trace[497624718] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:25876; }","duration":"143.758463ms","start":"2026-06-16T01:25:36.673923Z","end":"2026-06-16T01:25:36.817682Z","steps":["trace[497624718] 'agreement among raft nodes before linearized reading' (duration: 143.571659ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:39.951541Z","caller":"traceutil/trace.go:171","msg":"trace[268553610] transaction","detail":"{read_only:false; response_revision:25893; number_of_response:1; }","duration":"228.282538ms","start":"2026-06-16T01:25:39.72323Z","end":"2026-06-16T01:25:39.951512Z","steps":["trace[268553610] 'process raft request' (duration: 228.067115ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:39.978372Z","caller":"traceutil/trace.go:171","msg":"trace[1381537463] linearizableReadLoop","detail":"{readStateIndex:26748; appliedIndex:26743; }","duration":"224.985175ms","start":"2026-06-16T01:25:39.753369Z","end":"2026-06-16T01:25:39.978354Z","steps":["trace[1381537463] 'read index received' (duration: 197.900861ms)","trace[1381537463] 'applied index is now lower than readState.Index' (duration: 27.083734ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:39.978367Z","caller":"traceutil/trace.go:171","msg":"trace[409285198] transaction","detail":"{read_only:false; response_revision:25894; number_of_response:1; }","duration":"251.693442ms","start":"2026-06-16T01:25:39.726608Z","end":"2026-06-16T01:25:39.978301Z","steps":["trace[409285198] 'process raft request' (duration: 251.458928ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:39.978465Z","caller":"traceutil/trace.go:171","msg":"trace[527836166] transaction","detail":"{read_only:false; response_revision:25895; number_of_response:1; }","duration":"250.786836ms","start":"2026-06-16T01:25:39.727671Z","end":"2026-06-16T01:25:39.978457Z","steps":["trace[527836166] 'process raft request' (duration: 250.516091ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:39.978664Z","caller":"traceutil/trace.go:171","msg":"trace[2036876042] transaction","detail":"{read_only:false; response_revision:25896; number_of_response:1; }","duration":"249.687816ms","start":"2026-06-16T01:25:39.728968Z","end":"2026-06-16T01:25:39.978656Z","steps":["trace[2036876042] 'process raft request' (duration: 249.249717ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:39.978778Z","caller":"traceutil/trace.go:171","msg":"trace[1875554555] transaction","detail":"{read_only:false; response_revision:25897; number_of_response:1; }","duration":"249.287858ms","start":"2026-06-16T01:25:39.729482Z","end":"2026-06-16T01:25:39.97877Z","steps":["trace[1875554555] 'process raft request' (duration: 248.766868ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:39.978844Z","caller":"traceutil/trace.go:171","msg":"trace[1678303563] transaction","detail":"{read_only:false; response_revision:25898; number_of_response:1; }","duration":"162.511148ms","start":"2026-06-16T01:25:39.816327Z","end":"2026-06-16T01:25:39.978838Z","steps":["trace[1678303563] 'process raft request' (duration: 161.958857ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:39.978895Z","caller":"traceutil/trace.go:171","msg":"trace[1346902994] transaction","detail":"{read_only:false; response_revision:25899; number_of_response:1; }","duration":"147.987083ms","start":"2026-06-16T01:25:39.830903Z","end":"2026-06-16T01:25:39.97889Z","steps":["trace[1346902994] 'process raft request' (duration: 147.418402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:39.978983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.604118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:25:39.979006Z","caller":"traceutil/trace.go:171","msg":"trace[1807605439] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25899; }","duration":"225.681729ms","start":"2026-06-16T01:25:39.753317Z","end":"2026-06-16T01:25:39.978999Z","steps":["trace[1807605439] 'agreement among raft nodes before linearized reading' (duration: 225.622158ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:39.979202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.697864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-16T01:25:39.979229Z","caller":"traceutil/trace.go:171","msg":"trace[1816011950] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25899; }","duration":"210.764465ms","start":"2026-06-16T01:25:39.768459Z","end":"2026-06-16T01:25:39.979224Z","steps":["trace[1816011950] 'agreement among raft nodes before linearized reading' (duration: 210.670774ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:39.979477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.256289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T01:25:39.979496Z","caller":"traceutil/trace.go:171","msg":"trace[1683027494] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:25899; }","duration":"207.391071ms","start":"2026-06-16T01:25:39.7721Z","end":"2026-06-16T01:25:39.979491Z","steps":["trace[1683027494] 'agreement among raft nodes before linearized reading' (duration: 207.287379ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:44.536926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.534556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:25:44.537002Z","caller":"traceutil/trace.go:171","msg":"trace[67422372] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:25960; }","duration":"255.664678ms","start":"2026-06-16T01:25:44.281317Z","end":"2026-06-16T01:25:44.536982Z","steps":["trace[67422372] 'count revisions from in-memory index tree' (duration: 254.939525ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:44.537571Z","caller":"traceutil/trace.go:171","msg":"trace[1301292044] transaction","detail":"{read_only:false; response_revision:25961; number_of_response:1; }","duration":"143.931585ms","start":"2026-06-16T01:25:44.393608Z","end":"2026-06-16T01:25:44.53754Z","steps":["trace[1301292044] 'process raft request' (duration: 81.925806ms)","trace[1301292044] 'compare' (duration: 61.305456ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:25:44.901122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.33028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:25:44.901237Z","caller":"traceutil/trace.go:171","msg":"trace[23998206] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25961; }","duration":"146.525724ms","start":"2026-06-16T01:25:44.754685Z","end":"2026-06-16T01:25:44.901211Z","steps":["trace[23998206] 'range keys from in-memory index tree' (duration: 146.201368ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:44.901375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.262556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"info","ts":"2026-06-16T01:25:44.901474Z","caller":"traceutil/trace.go:171","msg":"trace[132388439] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25961; }","duration":"261.414349ms","start":"2026-06-16T01:25:44.640033Z","end":"2026-06-16T01:25:44.901447Z","steps":["trace[132388439] 'range keys from in-memory index tree' (duration: 261.03621ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:46.764615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.604325ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T01:25:46.764992Z","caller":"traceutil/trace.go:171","msg":"trace[40441124] transaction","detail":"{read_only:false; response_revision:25979; number_of_response:1; }","duration":"221.105422ms","start":"2026-06-16T01:25:46.543866Z","end":"2026-06-16T01:25:46.764971Z","steps":["trace[40441124] 'process raft request' (duration: 93.080208ms)","trace[40441124] 'compare' (duration: 127.255189ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:48.34771Z","caller":"traceutil/trace.go:171","msg":"trace[1003822763] transaction","detail":"{read_only:false; response_revision:25990; number_of_response:1; }","duration":"140.132723ms","start":"2026-06-16T01:25:48.207537Z","end":"2026-06-16T01:25:48.34767Z","steps":["trace[1003822763] 'process raft request' (duration: 129.924319ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:48.437189Z","caller":"traceutil/trace.go:171","msg":"trace[1753777699] transaction","detail":"{read_only:false; response_revision:25991; number_of_response:1; }","duration":"229.164625ms","start":"2026-06-16T01:25:48.207969Z","end":"2026-06-16T01:25:48.437134Z","steps":["trace[1753777699] 'process raft request' (duration: 228.8787ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:48.437235Z","caller":"traceutil/trace.go:171","msg":"trace[232981059] transaction","detail":"{read_only:false; response_revision:25992; number_of_response:1; }","duration":"229.036403ms","start":"2026-06-16T01:25:48.208161Z","end":"2026-06-16T01:25:48.437198Z","steps":["trace[232981059] 'process raft request' (duration: 228.86632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:25:48.437509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.226042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:25:48.437653Z","caller":"traceutil/trace.go:171","msg":"trace[499507462] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25992; }","duration":"203.453816ms","start":"2026-06-16T01:25:48.234177Z","end":"2026-06-16T01:25:48.437631Z","steps":["trace[499507462] 'agreement among raft nodes before linearized reading' (duration: 203.140901ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:25:48.4371Z","caller":"traceutil/trace.go:171","msg":"trace[120896176] linearizableReadLoop","detail":"{readStateIndex:26846; appliedIndex:26843; }","duration":"202.868465ms","start":"2026-06-16T01:25:48.234206Z","end":"2026-06-16T01:25:48.437074Z","steps":["trace[120896176] 'read index received' (duration: 103.224082ms)","trace[120896176] 'applied index is now lower than readState.Index' (duration: 99.642933ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:25:50.717746Z","caller":"traceutil/trace.go:171","msg":"trace[2131142698] transaction","detail":"{read_only:false; response_revision:26012; number_of_response:1; }","duration":"232.694064ms","start":"2026-06-16T01:25:50.485023Z","end":"2026-06-16T01:25:50.717717Z","steps":["trace[2131142698] 'process raft request' (duration: 232.572232ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:08.688965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.741593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:26:08.689072Z","caller":"traceutil/trace.go:171","msg":"trace[1952454474] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:26153; }","duration":"182.903657ms","start":"2026-06-16T01:26:08.506147Z","end":"2026-06-16T01:26:08.68905Z","steps":["trace[1952454474] 'range keys from in-memory index tree' (duration: 182.662061ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:08.68931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.808512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-16T01:26:08.688995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.748813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:26:08.68941Z","caller":"traceutil/trace.go:171","msg":"trace[992439352] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26153; }","duration":"114.973155ms","start":"2026-06-16T01:26:08.574416Z","end":"2026-06-16T01:26:08.689389Z","steps":["trace[992439352] 'range keys from in-memory index tree' (duration: 114.646579ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:08.689444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.63642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-16T01:26:08.689589Z","caller":"traceutil/trace.go:171","msg":"trace[658246365] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26153; }","duration":"112.808904ms","start":"2026-06-16T01:26:08.576728Z","end":"2026-06-16T01:26:08.689537Z","steps":["trace[658246365] 'range keys from in-memory index tree' (duration: 112.308895ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:08.689552Z","caller":"traceutil/trace.go:171","msg":"trace[770268795] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26153; }","duration":"153.233742ms","start":"2026-06-16T01:26:08.536172Z","end":"2026-06-16T01:26:08.689405Z","steps":["trace[770268795] 'range keys from in-memory index tree' (duration: 152.666342ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:08.827815Z","caller":"traceutil/trace.go:171","msg":"trace[237669314] linearizableReadLoop","detail":"{readStateIndex:27013; appliedIndex:27012; }","duration":"132.327934ms","start":"2026-06-16T01:26:08.695454Z","end":"2026-06-16T01:26:08.827782Z","steps":["trace[237669314] 'read index received' (duration: 131.931037ms)","trace[237669314] 'applied index is now lower than readState.Index' (duration: 395.167µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:26:08.828056Z","caller":"traceutil/trace.go:171","msg":"trace[242195042] transaction","detail":"{read_only:false; response_revision:26154; number_of_response:1; }","duration":"133.522927ms","start":"2026-06-16T01:26:08.694492Z","end":"2026-06-16T01:26:08.828015Z","steps":["trace[242195042] 'process raft request' (duration: 132.865255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:08.828161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.694501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:26:08.828246Z","caller":"traceutil/trace.go:171","msg":"trace[1331473591] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:26154; }","duration":"132.899835ms","start":"2026-06-16T01:26:08.695331Z","end":"2026-06-16T01:26:08.828231Z","steps":["trace[1331473591] 'agreement among raft nodes before linearized reading' (duration: 132.66759ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:08.888635Z","caller":"traceutil/trace.go:171","msg":"trace[1470559505] transaction","detail":"{read_only:false; response_revision:26156; number_of_response:1; }","duration":"138.529233ms","start":"2026-06-16T01:26:08.750073Z","end":"2026-06-16T01:26:08.888602Z","steps":["trace[1470559505] 'process raft request' (duration: 138.39553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:08.888775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.930526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:26:08.888866Z","caller":"traceutil/trace.go:171","msg":"trace[58715937] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26156; }","duration":"134.087799ms","start":"2026-06-16T01:26:08.754758Z","end":"2026-06-16T01:26:08.888846Z","steps":["trace[58715937] 'agreement among raft nodes before linearized reading' (duration: 133.884235ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:08.889211Z","caller":"traceutil/trace.go:171","msg":"trace[1939441402] transaction","detail":"{read_only:false; response_revision:26155; number_of_response:1; }","duration":"192.363745ms","start":"2026-06-16T01:26:08.696824Z","end":"2026-06-16T01:26:08.889188Z","steps":["trace[1939441402] 'process raft request' (duration: 191.487998ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:08.889269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.442629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-06-16T01:26:08.889395Z","caller":"traceutil/trace.go:171","msg":"trace[834399817] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26156; }","duration":"191.607352ms","start":"2026-06-16T01:26:08.697761Z","end":"2026-06-16T01:26:08.889368Z","steps":["trace[834399817] 'agreement among raft nodes before linearized reading' (duration: 190.98585ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:09.133025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.157883ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T01:26:09.133226Z","caller":"traceutil/trace.go:171","msg":"trace[311560062] transaction","detail":"{read_only:false; response_revision:26158; number_of_response:1; }","duration":"239.841068ms","start":"2026-06-16T01:26:08.893366Z","end":"2026-06-16T01:26:09.133207Z","steps":["trace[311560062] 'process raft request' (duration: 239.766656ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:09.133242Z","caller":"traceutil/trace.go:171","msg":"trace[764496404] linearizableReadLoop","detail":"{readStateIndex:27016; appliedIndex:27015; }","duration":"244.6779ms","start":"2026-06-16T01:26:08.888535Z","end":"2026-06-16T01:26:09.133213Z","steps":["trace[764496404] 'read index received' (duration: 113.218981ms)","trace[764496404] 'applied index is now lower than readState.Index' (duration: 131.457419ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:26:09.13323Z","caller":"traceutil/trace.go:171","msg":"trace[1628274652] transaction","detail":"{read_only:false; response_revision:26157; number_of_response:1; }","duration":"268.84311ms","start":"2026-06-16T01:26:08.864313Z","end":"2026-06-16T01:26:09.133156Z","steps":["trace[1628274652] 'process raft request' (duration: 137.475743ms)","trace[1628274652] 'compare' (duration: 130.806957ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:26:09.133441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.871518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:26:09.133499Z","caller":"traceutil/trace.go:171","msg":"trace[774810722] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:26158; }","duration":"260.970241ms","start":"2026-06-16T01:26:08.872513Z","end":"2026-06-16T01:26:09.133484Z","steps":["trace[774810722] 'agreement among raft nodes before linearized reading' (duration: 260.836497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:09.133679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.865792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:26:09.133709Z","caller":"traceutil/trace.go:171","msg":"trace[662030169] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:26158; }","duration":"196.947184ms","start":"2026-06-16T01:26:08.936753Z","end":"2026-06-16T01:26:09.133701Z","steps":["trace[662030169] 'agreement among raft nodes before linearized reading' (duration: 196.894503ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:09.133763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.601104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T01:26:09.13383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.268055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18435"} {"level":"info","ts":"2026-06-16T01:26:09.133853Z","caller":"traceutil/trace.go:171","msg":"trace[737119823] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:26158; }","duration":"299.700846ms","start":"2026-06-16T01:26:08.83413Z","end":"2026-06-16T01:26:09.133831Z","steps":["trace[737119823] 'agreement among raft nodes before linearized reading' (duration: 299.552894ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:09.133891Z","caller":"traceutil/trace.go:171","msg":"trace[1974189506] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:26158; }","duration":"242.388957ms","start":"2026-06-16T01:26:08.891487Z","end":"2026-06-16T01:26:09.133876Z","steps":["trace[1974189506] 'agreement among raft nodes before linearized reading' (duration: 242.172793ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:09.133922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.60203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:26:09.134039Z","caller":"traceutil/trace.go:171","msg":"trace[670460122] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26158; }","duration":"244.077409ms","start":"2026-06-16T01:26:08.889942Z","end":"2026-06-16T01:26:09.13402Z","steps":["trace[670460122] 'agreement among raft nodes before linearized reading' (duration: 243.554689ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:10.372104Z","caller":"traceutil/trace.go:171","msg":"trace[717332156] transaction","detail":"{read_only:false; response_revision:26160; number_of_response:1; }","duration":"294.589788ms","start":"2026-06-16T01:26:10.077472Z","end":"2026-06-16T01:26:10.372062Z","steps":["trace[717332156] 'process raft request' (duration: 285.20747ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:10.372221Z","caller":"traceutil/trace.go:171","msg":"trace[1239696734] linearizableReadLoop","detail":"{readStateIndex:27024; appliedIndex:27018; }","duration":"231.263236ms","start":"2026-06-16T01:26:10.140929Z","end":"2026-06-16T01:26:10.372192Z","steps":["trace[1239696734] 'read index received' (duration: 221.659923ms)","trace[1239696734] 'applied index is now lower than readState.Index' (duration: 9.602193ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:26:10.372212Z","caller":"traceutil/trace.go:171","msg":"trace[1180021101] transaction","detail":"{read_only:false; response_revision:26161; number_of_response:1; }","duration":"288.389351ms","start":"2026-06-16T01:26:10.083769Z","end":"2026-06-16T01:26:10.372158Z","steps":["trace[1180021101] 'process raft request' (duration: 288.181877ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:10.3723Z","caller":"traceutil/trace.go:171","msg":"trace[1616885399] transaction","detail":"{read_only:false; response_revision:26162; number_of_response:1; }","duration":"282.592761ms","start":"2026-06-16T01:26:10.08967Z","end":"2026-06-16T01:26:10.372263Z","steps":["trace[1616885399] 'process raft request' (duration: 282.349066ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:10.372255Z","caller":"traceutil/trace.go:171","msg":"trace[1521485211] transaction","detail":"{read_only:false; response_revision:26163; number_of_response:1; }","duration":"278.035823ms","start":"2026-06-16T01:26:10.094187Z","end":"2026-06-16T01:26:10.372223Z","steps":["trace[1521485211] 'process raft request' (duration: 277.86659ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:10.37236Z","caller":"traceutil/trace.go:171","msg":"trace[1386156758] transaction","detail":"{read_only:false; response_revision:26165; number_of_response:1; }","duration":"274.418285ms","start":"2026-06-16T01:26:10.0979Z","end":"2026-06-16T01:26:10.372319Z","steps":["trace[1386156758] 'process raft request' (duration: 274.248402ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:10.372375Z","caller":"traceutil/trace.go:171","msg":"trace[1368581801] transaction","detail":"{read_only:false; response_revision:26164; number_of_response:1; }","duration":"275.988115ms","start":"2026-06-16T01:26:10.096334Z","end":"2026-06-16T01:26:10.372323Z","steps":["trace[1368581801] 'process raft request' (duration: 275.768611ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:10.372534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.589941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-16T01:26:10.372577Z","caller":"traceutil/trace.go:171","msg":"trace[200485577] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26165; }","duration":"231.688654ms","start":"2026-06-16T01:26:10.140874Z","end":"2026-06-16T01:26:10.372563Z","steps":["trace[200485577] 'agreement among raft nodes before linearized reading' (duration: 231.473419ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:10.372565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.089858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.138\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-06-16T01:26:10.372622Z","caller":"traceutil/trace.go:171","msg":"trace[1156558871] range","detail":"{range_begin:/registry/masterleases/199.19.213.138; range_end:; response_count:1; response_revision:26165; }","duration":"194.202451ms","start":"2026-06-16T01:26:10.178406Z","end":"2026-06-16T01:26:10.372608Z","steps":["trace[1156558871] 'agreement among raft nodes before linearized reading' (duration: 193.989556ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:10.583796Z","caller":"traceutil/trace.go:171","msg":"trace[495110373] linearizableReadLoop","detail":"{readStateIndex:27027; appliedIndex:27026; }","duration":"119.328678ms","start":"2026-06-16T01:26:10.46444Z","end":"2026-06-16T01:26:10.583769Z","steps":["trace[495110373] 'read index received' (duration: 119.081383ms)","trace[495110373] 'applied index is now lower than readState.Index' (duration: 246.435µs)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:26:10.584067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.603614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-16T01:26:10.584104Z","caller":"traceutil/trace.go:171","msg":"trace[868174191] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26167; }","duration":"119.713036ms","start":"2026-06-16T01:26:10.464381Z","end":"2026-06-16T01:26:10.584094Z","steps":["trace[868174191] 'agreement among raft nodes before linearized reading' (duration: 119.496151ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:10.584443Z","caller":"traceutil/trace.go:171","msg":"trace[2088588455] transaction","detail":"{read_only:false; response_revision:26167; number_of_response:1; }","duration":"182.560571ms","start":"2026-06-16T01:26:10.401865Z","end":"2026-06-16T01:26:10.584426Z","steps":["trace[2088588455] 'process raft request' (duration: 181.736555ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:12.528325Z","caller":"traceutil/trace.go:171","msg":"trace[1657707907] transaction","detail":"{read_only:false; response_revision:26179; number_of_response:1; }","duration":"146.598097ms","start":"2026-06-16T01:26:12.381696Z","end":"2026-06-16T01:26:12.528294Z","steps":["trace[1657707907] 'process raft request' (duration: 146.512485ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:12.52853Z","caller":"traceutil/trace.go:171","msg":"trace[871349896] transaction","detail":"{read_only:false; response_revision:26177; number_of_response:1; }","duration":"147.124486ms","start":"2026-06-16T01:26:12.381395Z","end":"2026-06-16T01:26:12.52852Z","steps":["trace[871349896] 'process raft request' (duration: 146.606946ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:12.528573Z","caller":"traceutil/trace.go:171","msg":"trace[1639288785] transaction","detail":"{read_only:false; response_revision:26178; number_of_response:1; }","duration":"147.064625ms","start":"2026-06-16T01:26:12.381476Z","end":"2026-06-16T01:26:12.528541Z","steps":["trace[1639288785] 'process raft request' (duration: 146.690378ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:12.528707Z","caller":"traceutil/trace.go:171","msg":"trace[126498020] transaction","detail":"{read_only:false; response_revision:26180; number_of_response:1; }","duration":"146.407282ms","start":"2026-06-16T01:26:12.38229Z","end":"2026-06-16T01:26:12.528697Z","steps":["trace[126498020] 'process raft request' (duration: 145.960444ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:12.529124Z","caller":"traceutil/trace.go:171","msg":"trace[1243494734] transaction","detail":"{read_only:false; response_revision:26181; number_of_response:1; }","duration":"146.053636ms","start":"2026-06-16T01:26:12.383055Z","end":"2026-06-16T01:26:12.529109Z","steps":["trace[1243494734] 'process raft request' (duration: 145.571817ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:14.072067Z","caller":"traceutil/trace.go:171","msg":"trace[29892571] transaction","detail":"{read_only:false; response_revision:26188; number_of_response:1; }","duration":"178.629445ms","start":"2026-06-16T01:26:13.89341Z","end":"2026-06-16T01:26:14.072039Z","steps":["trace[29892571] 'process raft request' (duration: 178.449652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:14.282428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.967305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-06-16T01:26:14.282514Z","caller":"traceutil/trace.go:171","msg":"trace[1165218046] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26188; }","duration":"125.107908ms","start":"2026-06-16T01:26:14.157385Z","end":"2026-06-16T01:26:14.282493Z","steps":["trace[1165218046] 'range keys from in-memory index tree' (duration: 124.775352ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:14.463337Z","caller":"traceutil/trace.go:171","msg":"trace[19039447] linearizableReadLoop","detail":"{readStateIndex:27049; appliedIndex:27048; }","duration":"176.542085ms","start":"2026-06-16T01:26:14.286766Z","end":"2026-06-16T01:26:14.463308Z","steps":["trace[19039447] 'read index received' (duration: 176.368322ms)","trace[19039447] 'applied index is now lower than readState.Index' (duration: 172.163µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:26:14.463433Z","caller":"traceutil/trace.go:171","msg":"trace[141662108] transaction","detail":"{read_only:false; response_revision:26189; number_of_response:1; }","duration":"285.912404ms","start":"2026-06-16T01:26:14.177454Z","end":"2026-06-16T01:26:14.463366Z","steps":["trace[141662108] 'process raft request' (duration: 285.640539ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:14.46379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.962433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-06-16T01:26:14.464466Z","caller":"traceutil/trace.go:171","msg":"trace[1116980382] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26189; }","duration":"177.711948ms","start":"2026-06-16T01:26:14.286725Z","end":"2026-06-16T01:26:14.464437Z","steps":["trace[1116980382] 'agreement among raft nodes before linearized reading' (duration: 176.708308ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:14.649425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.606168ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T01:26:14.649563Z","caller":"traceutil/trace.go:171","msg":"trace[1297230340] transaction","detail":"{read_only:false; response_revision:26190; number_of_response:1; }","duration":"170.057961ms","start":"2026-06-16T01:26:14.479482Z","end":"2026-06-16T01:26:14.64954Z","steps":["trace[1297230340] 'process raft request' (duration: 64.801411ms)","trace[1297230340] 'compare' (duration: 103.994406ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:26:14.658942Z","caller":"traceutil/trace.go:171","msg":"trace[1627445249] transaction","detail":"{read_only:false; response_revision:26191; number_of_response:1; }","duration":"121.768064ms","start":"2026-06-16T01:26:14.537141Z","end":"2026-06-16T01:26:14.658909Z","steps":["trace[1627445249] 'process raft request' (duration: 121.54359ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:14.659401Z","caller":"traceutil/trace.go:171","msg":"trace[977405636] transaction","detail":"{read_only:false; response_revision:26192; number_of_response:1; }","duration":"122.215632ms","start":"2026-06-16T01:26:14.53716Z","end":"2026-06-16T01:26:14.659375Z","steps":["trace[977405636] 'process raft request' (duration: 121.707793ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:14.659488Z","caller":"traceutil/trace.go:171","msg":"trace[1748674948] transaction","detail":"{read_only:false; response_revision:26194; number_of_response:1; }","duration":"121.386276ms","start":"2026-06-16T01:26:14.538072Z","end":"2026-06-16T01:26:14.659458Z","steps":["trace[1748674948] 'process raft request' (duration: 121.249353ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:14.659514Z","caller":"traceutil/trace.go:171","msg":"trace[1637879253] transaction","detail":"{read_only:false; response_revision:26193; number_of_response:1; }","duration":"122.244662ms","start":"2026-06-16T01:26:14.537197Z","end":"2026-06-16T01:26:14.659442Z","steps":["trace[1637879253] 'process raft request' (duration: 122.010008ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:14.65955Z","caller":"traceutil/trace.go:171","msg":"trace[1328811958] transaction","detail":"{read_only:false; response_revision:26195; number_of_response:1; }","duration":"121.203022ms","start":"2026-06-16T01:26:14.538291Z","end":"2026-06-16T01:26:14.659494Z","steps":["trace[1328811958] 'process raft request' (duration: 121.09164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:30.521257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.581109ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T01:26:30.52143Z","caller":"traceutil/trace.go:171","msg":"trace[1174329695] linearizableReadLoop","detail":"{readStateIndex:27180; appliedIndex:27179; }","duration":"108.774448ms","start":"2026-06-16T01:26:30.412632Z","end":"2026-06-16T01:26:30.521407Z","steps":["trace[1174329695] 'read index received' (duration: 84.663µs)","trace[1174329695] 'applied index is now lower than readState.Index' (duration: 108.687615ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:26:30.521447Z","caller":"traceutil/trace.go:171","msg":"trace[1914922026] transaction","detail":"{read_only:false; response_revision:26316; number_of_response:1; }","duration":"246.676158ms","start":"2026-06-16T01:26:30.274732Z","end":"2026-06-16T01:26:30.521408Z","steps":["trace[1914922026] 'process raft request' (duration: 73.799263ms)","trace[1914922026] 'compare' (duration: 172.421957ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:26:30.521645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.002442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/projects/\" range_end:\"/registry/openstack.k-orc.cloud/projects0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:26:30.521723Z","caller":"traceutil/trace.go:171","msg":"trace[280528532] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/projects/; range_end:/registry/openstack.k-orc.cloud/projects0; response_count:0; response_revision:26316; }","duration":"109.130764ms","start":"2026-06-16T01:26:30.412564Z","end":"2026-06-16T01:26:30.521695Z","steps":["trace[280528532] 'agreement among raft nodes before linearized reading' (duration: 108.967031ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:30.969033Z","caller":"traceutil/trace.go:171","msg":"trace[307799226] transaction","detail":"{read_only:false; response_revision:26317; number_of_response:1; }","duration":"347.836722ms","start":"2026-06-16T01:26:30.621152Z","end":"2026-06-16T01:26:30.968989Z","steps":["trace[307799226] 'process raft request' (duration: 347.305281ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:30.969288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:26:30.621122Z","time spent":"348.043415ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:26:31.09743Z","caller":"traceutil/trace.go:171","msg":"trace[764973655] transaction","detail":"{read_only:false; response_revision:26318; number_of_response:1; }","duration":"383.213954ms","start":"2026-06-16T01:26:30.714185Z","end":"2026-06-16T01:26:31.097399Z","steps":["trace[764973655] 'process raft request' (duration: 382.986338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:31.097657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:26:30.714152Z","time spent":"383.372227ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:26:31.097827Z","caller":"traceutil/trace.go:171","msg":"trace[435271910] transaction","detail":"{read_only:false; response_revision:26320; number_of_response:1; }","duration":"360.534443ms","start":"2026-06-16T01:26:30.737262Z","end":"2026-06-16T01:26:31.097797Z","steps":["trace[435271910] 'process raft request' (duration: 360.346539ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:31.097845Z","caller":"traceutil/trace.go:171","msg":"trace[412343830] transaction","detail":"{read_only:false; response_revision:26319; number_of_response:1; }","duration":"378.887731ms","start":"2026-06-16T01:26:30.718923Z","end":"2026-06-16T01:26:31.097811Z","steps":["trace[412343830] 'process raft request' (duration: 378.432853ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:31.09803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:26:30.737249Z","time spent":"360.665465ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:26:31.098123Z","caller":"traceutil/trace.go:171","msg":"trace[1589658722] transaction","detail":"{read_only:false; response_revision:26321; number_of_response:1; }","duration":"354.768782ms","start":"2026-06-16T01:26:30.743331Z","end":"2026-06-16T01:26:31.0981Z","steps":["trace[1589658722] 'process raft request' (duration: 354.410156ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:31.098155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:26:30.718894Z","time spent":"379.027644ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:26:31.098243Z","caller":"traceutil/trace.go:171","msg":"trace[1499202849] transaction","detail":"{read_only:false; response_revision:26322; number_of_response:1; }","duration":"354.376425ms","start":"2026-06-16T01:26:30.743855Z","end":"2026-06-16T01:26:31.098231Z","steps":["trace[1499202849] 'process raft request' (duration: 354.142281ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:31.09824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:26:30.743292Z","time spent":"354.884495ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:26:31.098315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:26:30.743847Z","time spent":"354.424966ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:26:31.098327Z","caller":"traceutil/trace.go:171","msg":"trace[1284950986] linearizableReadLoop","detail":"{readStateIndex:27187; appliedIndex:27180; }","duration":"345.981765ms","start":"2026-06-16T01:26:30.752312Z","end":"2026-06-16T01:26:31.098293Z","steps":["trace[1284950986] 'read index received' (duration: 216.191858ms)","trace[1284950986] 'applied index is now lower than readState.Index' (duration: 129.788897ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:26:31.098389Z","caller":"traceutil/trace.go:171","msg":"trace[1049051072] transaction","detail":"{read_only:false; response_revision:26323; number_of_response:1; }","duration":"353.750212ms","start":"2026-06-16T01:26:30.744614Z","end":"2026-06-16T01:26:31.098364Z","steps":["trace[1049051072] 'process raft request' (duration: 353.570509ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:31.098485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.162358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-06-16T01:26:31.098496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:26:30.744604Z","time spent":"353.837084ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:26:31.09851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.20578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-16T01:26:31.098526Z","caller":"traceutil/trace.go:171","msg":"trace[1331375817] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26323; }","duration":"346.203809ms","start":"2026-06-16T01:26:30.752311Z","end":"2026-06-16T01:26:31.098514Z","steps":["trace[1331375817] 'agreement among raft nodes before linearized reading' (duration: 346.058636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:31.098556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:26:30.752191Z","time spent":"346.358813ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-16T01:26:31.098558Z","caller":"traceutil/trace.go:171","msg":"trace[608449045] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26323; }","duration":"346.302922ms","start":"2026-06-16T01:26:30.752241Z","end":"2026-06-16T01:26:31.098544Z","steps":["trace[608449045] 'agreement among raft nodes before linearized reading' (duration: 346.151069ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:31.098554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.376847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-06-16T01:26:31.098606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:26:30.752227Z","time spent":"346.367652ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-16T01:26:31.098626Z","caller":"traceutil/trace.go:171","msg":"trace[1024100669] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26323; }","duration":"151.489849ms","start":"2026-06-16T01:26:30.94712Z","end":"2026-06-16T01:26:31.09861Z","steps":["trace[1024100669] 'agreement among raft nodes before linearized reading' (duration: 151.293905ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:26:31.098865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.580838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-16T01:26:31.098939Z","caller":"traceutil/trace.go:171","msg":"trace[802283598] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26323; }","duration":"104.72817ms","start":"2026-06-16T01:26:30.994193Z","end":"2026-06-16T01:26:31.098922Z","steps":["trace[802283598] 'agreement among raft nodes before linearized reading' (duration: 104.359833ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:37.205104Z","caller":"traceutil/trace.go:171","msg":"trace[766919073] transaction","detail":"{read_only:false; response_revision:26361; number_of_response:1; }","duration":"144.597699ms","start":"2026-06-16T01:26:37.060479Z","end":"2026-06-16T01:26:37.205076Z","steps":["trace[766919073] 'process raft request' (duration: 144.323754ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:26:37.218835Z","caller":"traceutil/trace.go:171","msg":"trace[1516382250] transaction","detail":"{read_only:false; response_revision:26362; number_of_response:1; }","duration":"100.196204ms","start":"2026-06-16T01:26:37.118591Z","end":"2026-06-16T01:26:37.218787Z","steps":["trace[1516382250] 'process raft request' (duration: 99.781966ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:29:47.137979Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25317} {"level":"info","ts":"2026-06-16T01:29:47.29009Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25317,"took":"147.938792ms","hash":2360388492,"current-db-size-bytes":60006400,"current-db-size":"60 MB","current-db-size-in-use-bytes":38678528,"current-db-size-in-use":"39 MB"} {"level":"info","ts":"2026-06-16T01:29:47.290162Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2360388492,"revision":25317,"compact-revision":22063} {"level":"info","ts":"2026-06-16T01:31:14.449785Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2062be27cfb43adb","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-16T01:31:14.455291Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-16T01:31:14.455399Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-16T01:34:47.147746Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28266} {"level":"info","ts":"2026-06-16T01:34:47.314803Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28266,"took":"160.363596ms","hash":2087872813,"current-db-size-bytes":60006400,"current-db-size":"60 MB","current-db-size-in-use-bytes":32493568,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-16T01:34:47.314873Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2087872813,"revision":28266,"compact-revision":25317} {"level":"info","ts":"2026-06-16T01:39:47.154632Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30622} {"level":"info","ts":"2026-06-16T01:39:47.308553Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30622,"took":"150.272225ms","hash":1623766433,"current-db-size-bytes":60006400,"current-db-size":"60 MB","current-db-size-in-use-bytes":30494720,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-16T01:39:47.308636Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1623766433,"revision":30622,"compact-revision":28266} {"level":"info","ts":"2026-06-16T01:44:47.159722Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32879} {"level":"info","ts":"2026-06-16T01:44:47.303624Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32879,"took":"139.074668ms","hash":1566567394,"current-db-size-bytes":61050880,"current-db-size":"61 MB","current-db-size-in-use-bytes":31084544,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-16T01:44:47.303677Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1566567394,"revision":32879,"compact-revision":30622} {"level":"info","ts":"2026-06-16T01:49:47.173124Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35141} {"level":"info","ts":"2026-06-16T01:49:47.321898Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35141,"took":"144.768387ms","hash":1050792650,"current-db-size-bytes":61947904,"current-db-size":"62 MB","current-db-size-in-use-bytes":31993856,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-16T01:49:47.321956Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1050792650,"revision":35141,"compact-revision":32879} {"level":"info","ts":"2026-06-16T01:52:45.386611Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2062be27cfb43adb","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-16T01:52:45.393593Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-16T01:52:45.393719Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-06-16T01:54:47.18021Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37408} {"level":"info","ts":"2026-06-16T01:54:47.299005Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37408,"took":"115.816967ms","hash":144245408,"current-db-size-bytes":64061440,"current-db-size":"64 MB","current-db-size-in-use-bytes":32358400,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-16T01:54:47.299144Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":144245408,"revision":37408,"compact-revision":35141} {"level":"info","ts":"2026-06-16T01:59:47.186136Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39682} {"level":"info","ts":"2026-06-16T01:59:47.317989Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39682,"took":"126.133833ms","hash":729577056,"current-db-size-bytes":64061440,"current-db-size":"64 MB","current-db-size-in-use-bytes":30760960,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-16T01:59:47.318072Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":729577056,"revision":39682,"compact-revision":37408}