{"level":"warn","ts":"2026-07-02T09:58:47.750108Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T09:58:47.750259Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.175: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.175:2380","--initial-cluster=instance=https://199.19.213.175:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.175:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.175: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-07-02T09:58:47.750503Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T09:58:47.750535Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.175:2380"]} {"level":"info","ts":"2026-07-02T09:58:47.750576Z","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-07-02T09:58:47.751937Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.175:2379"]} {"level":"info","ts":"2026-07-02T09:58:47.752196Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.175:2380"],"listen-peer-urls":["https://199.19.213.175:2380"],"advertise-client-urls":["https://199.19.213.175:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.175:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.175: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-07-02T09:58:47.757712Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.96078ms"} {"level":"info","ts":"2026-07-02T09:58:47.767028Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"223c7693b78843e1","cluster-id":"b697af90308fdc01"} {"level":"info","ts":"2026-07-02T09:58:47.76713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 switched to configuration voters=()"} {"level":"info","ts":"2026-07-02T09:58:47.767154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became follower at term 0"} {"level":"info","ts":"2026-07-02T09:58:47.767355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 223c7693b78843e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-02T09:58:47.767393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became follower at term 1"} {"level":"info","ts":"2026-07-02T09:58:47.767487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 switched to configuration voters=(2466977072703620065)"} {"level":"warn","ts":"2026-07-02T09:58:47.782962Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-02T09:58:47.785429Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-02T09:58:47.788469Z","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-07-02T09:58:47.792035Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"223c7693b78843e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-02T09:58:47.79233Z","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-07-02T09:58:47.79247Z","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-07-02T09:58:47.792525Z","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-07-02T09:58:47.792738Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"223c7693b78843e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-02T09:58:47.794213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 switched to configuration voters=(2466977072703620065)"} {"level":"info","ts":"2026-07-02T09:58:47.794748Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b697af90308fdc01","local-member-id":"223c7693b78843e1","added-peer-id":"223c7693b78843e1","added-peer-peer-urls":["https://199.19.213.175:2380"]} {"level":"info","ts":"2026-07-02T09:58:47.797232Z","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-07-02T09:58:47.797272Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.175:2380"} {"level":"info","ts":"2026-07-02T09:58:47.797312Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.175:2380"} {"level":"info","ts":"2026-07-02T09:58:47.797637Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-02T09:58:47.797571Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"223c7693b78843e1","initial-advertise-peer-urls":["https://199.19.213.175:2380"],"listen-peer-urls":["https://199.19.213.175:2380"],"advertise-client-urls":["https://199.19.213.175:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.175:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-02T09:58:48.168749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 is starting a new election at term 1"} {"level":"info","ts":"2026-07-02T09:58:48.168818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-02T09:58:48.16892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 received MsgPreVoteResp from 223c7693b78843e1 at term 1"} {"level":"info","ts":"2026-07-02T09:58:48.168987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became candidate at term 2"} {"level":"info","ts":"2026-07-02T09:58:48.16901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 received MsgVoteResp from 223c7693b78843e1 at term 2"} {"level":"info","ts":"2026-07-02T09:58:48.169095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"223c7693b78843e1 became leader at term 2"} {"level":"info","ts":"2026-07-02T09:58:48.16912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 223c7693b78843e1 elected leader 223c7693b78843e1 at term 2"} {"level":"info","ts":"2026-07-02T09:58:48.182212Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T09:58:48.19262Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"223c7693b78843e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.175:2379]}","request-path":"/0/members/223c7693b78843e1/attributes","cluster-id":"b697af90308fdc01","publish-timeout":"7s"} {"level":"info","ts":"2026-07-02T09:58:48.192776Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T09:58:48.195331Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-02T09:58:48.200304Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T09:58:48.202376Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.175:2379"} {"level":"info","ts":"2026-07-02T09:58:48.204953Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b697af90308fdc01","local-member-id":"223c7693b78843e1","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T09:58:48.205154Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T09:58:48.205234Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T09:58:48.208426Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-02T09:58:48.208485Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-02T09:58:58.172172Z","caller":"traceutil/trace.go:171","msg":"trace[1234890892] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"134.189921ms","start":"2026-07-02T09:58:58.037941Z","end":"2026-07-02T09:58:58.172131Z","steps":["trace[1234890892] 'process raft request' (duration: 117.068118ms)","trace[1234890892] 'compare' (duration: 16.869156ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T09:59:00.921348Z","caller":"traceutil/trace.go:171","msg":"trace[1206809328] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"139.611979ms","start":"2026-07-02T09:59:00.781715Z","end":"2026-07-02T09:59:00.921327Z","steps":["trace[1206809328] 'process raft request' (duration: 139.473346ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T09:59:01.463056Z","caller":"traceutil/trace.go:171","msg":"trace[1618762098] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"212.363985ms","start":"2026-07-02T09:59:01.250667Z","end":"2026-07-02T09:59:01.463031Z","steps":["trace[1618762098] 'process raft request' (duration: 212.200931ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T09:59:35.358611Z","caller":"traceutil/trace.go:171","msg":"trace[143651425] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"101.270991ms","start":"2026-07-02T09:59:35.257284Z","end":"2026-07-02T09:59:35.358555Z","steps":["trace[143651425] 'process raft request' (duration: 100.310792ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T09:59:35.804545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.788285ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-02T09:59:35.804752Z","caller":"traceutil/trace.go:171","msg":"trace[1126065452] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"287.814237ms","start":"2026-07-02T09:59:35.516918Z","end":"2026-07-02T09:59:35.804733Z","steps":["trace[1126065452] 'process raft request' (duration: 178.301079ms)","trace[1126065452] 'compare' (duration: 107.092511ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T09:59:36.062085Z","caller":"traceutil/trace.go:171","msg":"trace[1424958431] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:675; }","duration":"197.000316ms","start":"2026-07-02T09:59:35.865022Z","end":"2026-07-02T09:59:36.062022Z","steps":["trace[1424958431] 'read index received' (duration: 9.567152ms)","trace[1424958431] 'applied index is now lower than readState.Index' (duration: 187.431934ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T09:59:36.062225Z","caller":"traceutil/trace.go:171","msg":"trace[647766791] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"251.830062ms","start":"2026-07-02T09:59:35.810375Z","end":"2026-07-02T09:59:36.062205Z","steps":["trace[647766791] 'process raft request' (duration: 251.534086ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T09:59:36.062327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.285581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-747dr\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-02T09:59:36.062376Z","caller":"traceutil/trace.go:171","msg":"trace[1639565417] range","detail":"{range_begin:/registry/pods/kube-system/cilium-747dr; range_end:; response_count:1; response_revision:650; }","duration":"197.381964ms","start":"2026-07-02T09:59:35.864981Z","end":"2026-07-02T09:59:36.062363Z","steps":["trace[1639565417] 'agreement among raft nodes before linearized reading' (duration: 197.19712ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T09:59:36.062446Z","caller":"traceutil/trace.go:171","msg":"trace[306748789] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"253.600235ms","start":"2026-07-02T09:59:35.808835Z","end":"2026-07-02T09:59:36.062435Z","steps":["trace[306748789] 'process raft request' (duration: 252.852551ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T09:59:36.062525Z","caller":"traceutil/trace.go:171","msg":"trace[929255989] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"249.839833ms","start":"2026-07-02T09:59:35.812672Z","end":"2026-07-02T09:59:36.062512Z","steps":["trace[929255989] 'process raft request' (duration: 249.296543ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T09:59:36.580156Z","caller":"traceutil/trace.go:171","msg":"trace[418200489] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:678; }","duration":"229.70226ms","start":"2026-07-02T09:59:36.35043Z","end":"2026-07-02T09:59:36.580133Z","steps":["trace[418200489] 'read index received' (duration: 229.431595ms)","trace[418200489] 'applied index is now lower than readState.Index' (duration: 269.675µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T09:59:36.580278Z","caller":"traceutil/trace.go:171","msg":"trace[1629726917] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"504.670734ms","start":"2026-07-02T09:59:36.075585Z","end":"2026-07-02T09:59:36.580255Z","steps":["trace[1629726917] 'process raft request' (duration: 504.360619ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T09:59:36.580335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.884813ms","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-07-02T09:59:36.580392Z","caller":"traceutil/trace.go:171","msg":"trace[764719776] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:651; }","duration":"229.995965ms","start":"2026-07-02T09:59:36.350381Z","end":"2026-07-02T09:59:36.580377Z","steps":["trace[764719776] 'agreement among raft nodes before linearized reading' (duration: 229.878533ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T09:59:36.580443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.676118ms","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-07-02T09:59:36.580536Z","caller":"traceutil/trace.go:171","msg":"trace[947630230] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:651; }","duration":"104.80605ms","start":"2026-07-02T09:59:36.475706Z","end":"2026-07-02T09:59:36.580512Z","steps":["trace[947630230] 'agreement among raft nodes before linearized reading' (duration: 104.626917ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T09:59:36.580651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T09:59:36.075566Z","time spent":"504.771847ms","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T09:59:36.846731Z","caller":"traceutil/trace.go:171","msg":"trace[2023850313] linearizableReadLoop","detail":"{readStateIndex:682; appliedIndex:679; }","duration":"167.542325ms","start":"2026-07-02T09:59:36.679152Z","end":"2026-07-02T09:59:36.846694Z","steps":["trace[2023850313] 'read index received' (duration: 106.603104ms)","trace[2023850313] 'applied index is now lower than readState.Index' (duration: 60.938221ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T09:59:36.846775Z","caller":"traceutil/trace.go:171","msg":"trace[1318887576] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"260.660014ms","start":"2026-07-02T09:59:36.586101Z","end":"2026-07-02T09:59:36.846761Z","steps":["trace[1318887576] 'process raft request' (duration: 260.475361ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T09:59:36.846899Z","caller":"traceutil/trace.go:171","msg":"trace[415885036] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"260.914211ms","start":"2026-07-02T09:59:36.585978Z","end":"2026-07-02T09:59:36.846892Z","steps":["trace[415885036] 'process raft request' (duration: 199.761095ms)","trace[415885036] 'compare' (duration: 60.399741ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T09:59:36.847022Z","caller":"traceutil/trace.go:171","msg":"trace[1482497550] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"260.85358ms","start":"2026-07-02T09:59:36.586137Z","end":"2026-07-02T09:59:36.846991Z","steps":["trace[1482497550] 'process raft request' (duration: 260.522113ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T09:59:36.847091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.887032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-02T09:59:36.847179Z","caller":"traceutil/trace.go:171","msg":"trace[701458090] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:654; }","duration":"168.041075ms","start":"2026-07-02T09:59:36.679091Z","end":"2026-07-02T09:59:36.847132Z","steps":["trace[701458090] 'agreement among raft nodes before linearized reading' (duration: 167.701818ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T09:59:52.700285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.1077ms","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-07-02T09:59:52.700432Z","caller":"traceutil/trace.go:171","msg":"trace[1981612191] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:807; }","duration":"115.280613ms","start":"2026-07-02T09:59:52.585132Z","end":"2026-07-02T09:59:52.700413Z","steps":["trace[1981612191] 'range keys from in-memory index tree' (duration: 115.08606ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T09:59:52.700504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.62326ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T09:59:52.700721Z","caller":"traceutil/trace.go:171","msg":"trace[1043688448] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"301.957195ms","start":"2026-07-02T09:59:52.398698Z","end":"2026-07-02T09:59:52.700655Z","steps":["trace[1043688448] 'process raft request' (duration: 29.09766ms)","trace[1043688448] 'compare' (duration: 272.433757ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T09:59:52.701072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T09:59:52.398673Z","time spent":"302.302941ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T09:59:56.910613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.957662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T09:59:56.910706Z","caller":"traceutil/trace.go:171","msg":"trace[1626681534] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:857; }","duration":"109.089784ms","start":"2026-07-02T09:59:56.801597Z","end":"2026-07-02T09:59:56.910687Z","steps":["trace[1626681534] 'range keys from in-memory index tree' (duration: 108.919392ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T09:59:56.910815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.009555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T09:59:56.910892Z","caller":"traceutil/trace.go:171","msg":"trace[1127230364] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:857; }","duration":"109.114026ms","start":"2026-07-02T09:59:56.801764Z","end":"2026-07-02T09:59:56.910878Z","steps":["trace[1127230364] 'count revisions from in-memory index tree' (duration: 108.982433ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T09:59:56.911181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.314023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050256"} {"level":"info","ts":"2026-07-02T09:59:56.911271Z","caller":"traceutil/trace.go:171","msg":"trace[637930363] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:857; }","duration":"113.431285ms","start":"2026-07-02T09:59:56.797813Z","end":"2026-07-02T09:59:56.911244Z","steps":["trace[637930363] 'range keys from in-memory index tree' (duration: 112.651462ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:01:18.575897Z","caller":"traceutil/trace.go:171","msg":"trace[454230186] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"175.954078ms","start":"2026-07-02T10:01:18.39992Z","end":"2026-07-02T10:01:18.575874Z","steps":["trace[454230186] 'process raft request' (duration: 175.793806ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:01:33.333954Z","caller":"traceutil/trace.go:171","msg":"trace[1578564352] transaction","detail":"{read_only:false; response_revision:2021; number_of_response:1; }","duration":"137.416597ms","start":"2026-07-02T10:01:33.196498Z","end":"2026-07-02T10:01:33.333914Z","steps":["trace[1578564352] 'process raft request' (duration: 137.008114ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:01:52.623809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.389917ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T10:01:52.62443Z","caller":"traceutil/trace.go:171","msg":"trace[263251228] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"152.49485ms","start":"2026-07-02T10:01:52.471904Z","end":"2026-07-02T10:01:52.624399Z","steps":["trace[263251228] 'process raft request' (duration: 51.381346ms)","trace[263251228] 'compare' (duration: 100.082884ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:01:53.201653Z","caller":"traceutil/trace.go:171","msg":"trace[841741162] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"133.460467ms","start":"2026-07-02T10:01:53.06815Z","end":"2026-07-02T10:01:53.20161Z","steps":["trace[841741162] 'process raft request' (duration: 133.201135ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:01:53.739213Z","caller":"traceutil/trace.go:171","msg":"trace[1519644355] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"201.426959ms","start":"2026-07-02T10:01:53.537693Z","end":"2026-07-02T10:01:53.73912Z","steps":["trace[1519644355] 'process raft request' (duration: 111.556962ms)","trace[1519644355] 'compare' (duration: 89.464753ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:02:58.162695Z","caller":"traceutil/trace.go:171","msg":"trace[2083067768] transaction","detail":"{read_only:false; response_revision:2596; number_of_response:1; }","duration":"159.395616ms","start":"2026-07-02T10:02:58.003254Z","end":"2026-07-02T10:02:58.16265Z","steps":["trace[2083067768] 'process raft request' (duration: 158.966252ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:02:58.162838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.524867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-07-02T10:02:58.162899Z","caller":"traceutil/trace.go:171","msg":"trace[1374467867] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2596; }","duration":"159.640418ms","start":"2026-07-02T10:02:58.003246Z","end":"2026-07-02T10:02:58.162886Z","steps":["trace[1374467867] 'agreement among raft nodes before linearized reading' (duration: 159.452286ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:02:58.162648Z","caller":"traceutil/trace.go:171","msg":"trace[362547104] linearizableReadLoop","detail":"{readStateIndex:2697; appliedIndex:2696; }","duration":"159.301115ms","start":"2026-07-02T10:02:58.003301Z","end":"2026-07-02T10:02:58.162602Z","steps":["trace[362547104] 'read index received' (duration: 107.601µs)","trace[362547104] 'applied index is now lower than readState.Index' (duration: 159.192074ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:03:30.388501Z","caller":"traceutil/trace.go:171","msg":"trace[512442066] transaction","detail":"{read_only:false; response_revision:2774; number_of_response:1; }","duration":"100.756562ms","start":"2026-07-02T10:03:30.287715Z","end":"2026-07-02T10:03:30.388472Z","steps":["trace[512442066] 'process raft request' (duration: 99.962541ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:03:30.525132Z","caller":"traceutil/trace.go:171","msg":"trace[692623482] transaction","detail":"{read_only:false; response_revision:2778; number_of_response:1; }","duration":"129.84683ms","start":"2026-07-02T10:03:30.395261Z","end":"2026-07-02T10:03:30.525108Z","steps":["trace[692623482] 'process raft request' (duration: 129.810739ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:03:30.525427Z","caller":"traceutil/trace.go:171","msg":"trace[511826050] transaction","detail":"{read_only:false; response_revision:2777; number_of_response:1; }","duration":"131.435993ms","start":"2026-07-02T10:03:30.393968Z","end":"2026-07-02T10:03:30.525404Z","steps":["trace[511826050] 'process raft request' (duration: 131.079094ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:03:30.525229Z","caller":"traceutil/trace.go:171","msg":"trace[1353309111] transaction","detail":"{read_only:false; response_revision:2776; number_of_response:1; }","duration":"131.533816ms","start":"2026-07-02T10:03:30.393653Z","end":"2026-07-02T10:03:30.525187Z","steps":["trace[1353309111] 'process raft request' (duration: 131.28175ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:04:48.640536Z","caller":"traceutil/trace.go:171","msg":"trace[1931891329] transaction","detail":"{read_only:false; response_revision:3184; number_of_response:1; }","duration":"152.119258ms","start":"2026-07-02T10:04:48.488377Z","end":"2026-07-02T10:04:48.640496Z","steps":["trace[1931891329] 'process raft request' (duration: 151.914694ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:49.336959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.749227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T10:04:49.337268Z","caller":"traceutil/trace.go:171","msg":"trace[1595137763] transaction","detail":"{read_only:false; response_revision:3187; number_of_response:1; }","duration":"122.112401ms","start":"2026-07-02T10:04:49.215136Z","end":"2026-07-02T10:04:49.337248Z","steps":["trace[1595137763] 'process raft request' (duration: 122.06673ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:04:49.337331Z","caller":"traceutil/trace.go:171","msg":"trace[2000608467] transaction","detail":"{read_only:false; response_revision:3186; number_of_response:1; }","duration":"507.348208ms","start":"2026-07-02T10:04:48.829943Z","end":"2026-07-02T10:04:49.337291Z","steps":["trace[2000608467] 'process raft request' (duration: 507.148514ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:04:49.337302Z","caller":"traceutil/trace.go:171","msg":"trace[1730830072] transaction","detail":"{read_only:false; response_revision:3185; number_of_response:1; }","duration":"639.127229ms","start":"2026-07-02T10:04:48.698146Z","end":"2026-07-02T10:04:49.337273Z","steps":["trace[1730830072] 'process raft request' (duration: 480.920513ms)","trace[1730830072] 'compare' (duration: 157.179637ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:04:49.337562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:48.829914Z","time spent":"507.535903ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:04:49.337536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:48.698095Z","time spent":"639.356884ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:04:49.337572Z","caller":"traceutil/trace.go:171","msg":"trace[1803619752] linearizableReadLoop","detail":"{readStateIndex:3310; appliedIndex:3308; }","duration":"378.208ms","start":"2026-07-02T10:04:48.959352Z","end":"2026-07-02T10:04:49.33756Z","steps":["trace[1803619752] 'read index received' (duration: 219.721548ms)","trace[1803619752] 'applied index is now lower than readState.Index' (duration: 158.485312ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:04:49.337708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.362154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-02T10:04:49.337743Z","caller":"traceutil/trace.go:171","msg":"trace[1657194646] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3187; }","duration":"378.440124ms","start":"2026-07-02T10:04:48.959292Z","end":"2026-07-02T10:04:49.337733Z","steps":["trace[1657194646] 'agreement among raft nodes before linearized reading' (duration: 378.308212ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:49.337775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:48.95927Z","time spent":"378.498406ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-02T10:04:49.337892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.145495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:04:49.337937Z","caller":"traceutil/trace.go:171","msg":"trace[89972706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3187; }","duration":"158.224366ms","start":"2026-07-02T10:04:49.1797Z","end":"2026-07-02T10:04:49.337925Z","steps":["trace[89972706] 'agreement among raft nodes before linearized reading' (duration: 158.159655ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:49.337933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.736297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-02T10:04:49.337931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.405932ms","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-07-02T10:04:49.337996Z","caller":"traceutil/trace.go:171","msg":"trace[1379083827] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3187; }","duration":"340.837579ms","start":"2026-07-02T10:04:48.997141Z","end":"2026-07-02T10:04:49.337978Z","steps":["trace[1379083827] 'agreement among raft nodes before linearized reading' (duration: 340.660376ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:49.338013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.088575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-07-02T10:04:49.338059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:48.997095Z","time spent":"340.95081ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-02T10:04:49.338027Z","caller":"traceutil/trace.go:171","msg":"trace[1840866890] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3187; }","duration":"337.527965ms","start":"2026-07-02T10:04:49.000485Z","end":"2026-07-02T10:04:49.338013Z","steps":["trace[1840866890] 'agreement among raft nodes before linearized reading' (duration: 337.314171ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:04:49.338065Z","caller":"traceutil/trace.go:171","msg":"trace[1484617330] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3187; }","duration":"338.183817ms","start":"2026-07-02T10:04:48.999866Z","end":"2026-07-02T10:04:49.33805Z","steps":["trace[1484617330] 'agreement among raft nodes before linearized reading' (duration: 337.991524ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:49.338181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:49.000434Z","time spent":"337.679028ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-02T10:04:49.338208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:48.999855Z","time spent":"338.33827ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-02T10:04:50.007506Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274225,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:04:50.50768Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274225,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:04:51.008593Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274225,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:04:51.509613Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274225,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:04:52.009939Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274225,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:04:52.484424Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.090181746s","expected-duration":"1s"} {"level":"info","ts":"2026-07-02T10:04:52.485069Z","caller":"traceutil/trace.go:171","msg":"trace[1520811845] transaction","detail":"{read_only:false; response_revision:3189; number_of_response:1; }","duration":"3.141417275s","start":"2026-07-02T10:04:49.343617Z","end":"2026-07-02T10:04:52.485034Z","steps":["trace[1520811845] 'process raft request' (duration: 3.141121569s)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:04:52.485221Z","caller":"traceutil/trace.go:171","msg":"trace[669983979] transaction","detail":"{read_only:false; response_revision:3192; number_of_response:1; }","duration":"3.104014575s","start":"2026-07-02T10:04:49.381187Z","end":"2026-07-02T10:04:52.485201Z","steps":["trace[669983979] 'process raft request' (duration: 3.103911073s)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:04:52.485276Z","caller":"traceutil/trace.go:171","msg":"trace[1342527830] transaction","detail":"{read_only:false; response_revision:3191; number_of_response:1; }","duration":"3.14016398s","start":"2026-07-02T10:04:49.345092Z","end":"2026-07-02T10:04:52.485256Z","steps":["trace[1342527830] 'process raft request' (duration: 3.139909556s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.485363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:49.381172Z","time spent":"3.104114147s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:04:52.48547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:49.345084Z","time spent":"3.140253102s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:04:52.485084Z","caller":"traceutil/trace.go:171","msg":"trace[659023712] transaction","detail":"{read_only:false; response_revision:3190; number_of_response:1; }","duration":"3.140796044s","start":"2026-07-02T10:04:49.344257Z","end":"2026-07-02T10:04:52.485053Z","steps":["trace[659023712] 'process raft request' (duration: 3.140682072s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.485702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:49.344249Z","time spent":"3.141375394s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:04:52.48676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:49.343606Z","time spent":"3.141647289s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:04:52.622016Z","caller":"traceutil/trace.go:171","msg":"trace[848913334] transaction","detail":"{read_only:false; response_revision:3193; number_of_response:1; }","duration":"2.355204137s","start":"2026-07-02T10:04:50.266787Z","end":"2026-07-02T10:04:52.621991Z","steps":["trace[848913334] 'process raft request' (duration: 2.342552423s)","trace[848913334] 'compare' (duration: 12.44361ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:04:52.622207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:50.266754Z","time spent":"2.35532688s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:04:52.622523Z","caller":"traceutil/trace.go:171","msg":"trace[22803851] linearizableReadLoop","detail":"{readStateIndex:3319; appliedIndex:3313; }","duration":"3.115721975s","start":"2026-07-02T10:04:49.506766Z","end":"2026-07-02T10:04:52.622487Z","steps":["trace[22803851] 'read index received' (duration: 2.97816432s)","trace[22803851] 'applied index is now lower than readState.Index' (duration: 137.556115ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:04:52.622632Z","caller":"traceutil/trace.go:171","msg":"trace[263333390] transaction","detail":"{read_only:false; response_revision:3194; number_of_response:1; }","duration":"1.277877489s","start":"2026-07-02T10:04:51.344734Z","end":"2026-07-02T10:04:52.622611Z","steps":["trace[263333390] 'process raft request' (duration: 1.277201626s)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:04:52.622726Z","caller":"traceutil/trace.go:171","msg":"trace[2055005971] transaction","detail":"{read_only:false; response_revision:3195; number_of_response:1; }","duration":"1.277256097s","start":"2026-07-02T10:04:51.345453Z","end":"2026-07-02T10:04:52.622709Z","steps":["trace[2055005971] 'process raft request' (duration: 1.276799289s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.622901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:51.345442Z","time spent":"1.277366439s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:04:52.622981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.116209604s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T10:04:52.623029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.22936523s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T10:04:52.623079Z","caller":"traceutil/trace.go:171","msg":"trace[1052205427] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:3195; }","duration":"3.116332347s","start":"2026-07-02T10:04:49.50673Z","end":"2026-07-02T10:04:52.623062Z","steps":["trace[1052205427] 'agreement among raft nodes before linearized reading' (duration: 3.116220125s)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:04:52.623117Z","caller":"traceutil/trace.go:171","msg":"trace[546817960] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:3195; }","duration":"1.229491072s","start":"2026-07-02T10:04:51.393611Z","end":"2026-07-02T10:04:52.623102Z","steps":["trace[546817960] 'agreement among raft nodes before linearized reading' (duration: 1.22936296s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.623151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:49.506712Z","time spent":"3.116423719s","remote":"127.0.0.1:56394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:04:52.623166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:51.393589Z","time spent":"1.229561773s","remote":"127.0.0.1:37956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":3,"response size":30,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:04:52.62319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.435037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-02T10:04:52.622896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.089055704s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-07-02T10:04:52.623282Z","caller":"traceutil/trace.go:171","msg":"trace[1201636380] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:3195; }","duration":"853.511559ms","start":"2026-07-02T10:04:51.769723Z","end":"2026-07-02T10:04:52.623234Z","steps":["trace[1201636380] 'agreement among raft nodes before linearized reading' (duration: 853.349986ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.623317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:51.769682Z","time spent":"853.627341ms","remote":"127.0.0.1:37716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":59,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"info","ts":"2026-07-02T10:04:52.623327Z","caller":"traceutil/trace.go:171","msg":"trace[505313677] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3195; }","duration":"3.089508773s","start":"2026-07-02T10:04:49.533794Z","end":"2026-07-02T10:04:52.623303Z","steps":["trace[505313677] 'agreement among raft nodes before linearized reading' (duration: 3.088960593s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.623374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.136909719s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T10:04:52.623387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:49.533778Z","time spent":"3.089590574s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-07-02T10:04:52.623416Z","caller":"traceutil/trace.go:171","msg":"trace[611283888] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:3195; }","duration":"1.13698305s","start":"2026-07-02T10:04:51.486419Z","end":"2026-07-02T10:04:52.623402Z","steps":["trace[611283888] 'agreement among raft nodes before linearized reading' (duration: 1.136912639s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.623449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:51.486401Z","time spent":"1.137039713s","remote":"127.0.0.1:56456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:04:52.62354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.869813ms","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-07-02T10:04:52.62356Z","caller":"traceutil/trace.go:171","msg":"trace[1595262366] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:3195; }","duration":"564.927434ms","start":"2026-07-02T10:04:52.058626Z","end":"2026-07-02T10:04:52.623554Z","steps":["trace[1595262366] 'agreement among raft nodes before linearized reading' (duration: 564.833792ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.623577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:52.058604Z","time spent":"564.969345ms","remote":"127.0.0.1:37764","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-07-02T10:04:52.623566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.225067317s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-07-02T10:04:52.623642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"705.032344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-02T10:04:52.622923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:51.344703Z","time spent":"1.278067383s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:04:52.623651Z","caller":"traceutil/trace.go:171","msg":"trace[316939101] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3195; }","duration":"1.225155878s","start":"2026-07-02T10:04:51.398453Z","end":"2026-07-02T10:04:52.623609Z","steps":["trace[316939101] 'agreement among raft nodes before linearized reading' (duration: 1.224897092s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.62368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"985.526827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T10:04:52.623749Z","caller":"traceutil/trace.go:171","msg":"trace[1583976580] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:3195; }","duration":"985.608009ms","start":"2026-07-02T10:04:51.638098Z","end":"2026-07-02T10:04:52.623706Z","steps":["trace[1583976580] 'agreement among raft nodes before linearized reading' (duration: 985.502177ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.623786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:51.638076Z","time spent":"985.69838ms","remote":"127.0.0.1:37778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":3,"response size":30,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:04:52.623787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:51.398439Z","time spent":"1.22525631s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-02T10:04:52.623836Z","caller":"traceutil/trace.go:171","msg":"trace[1582690002] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3195; }","duration":"705.120626ms","start":"2026-07-02T10:04:51.918534Z","end":"2026-07-02T10:04:52.623655Z","steps":["trace[1582690002] 'agreement among raft nodes before linearized reading' (duration: 705.086225ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.623887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:51.918488Z","time spent":"705.390321ms","remote":"127.0.0.1:53404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:04:52.624201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.390918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.175\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-02T10:04:52.624221Z","caller":"traceutil/trace.go:171","msg":"trace[388997403] range","detail":"{range_begin:/registry/masterleases/199.19.213.175; range_end:; response_count:1; response_revision:3195; }","duration":"837.433268ms","start":"2026-07-02T10:04:51.786782Z","end":"2026-07-02T10:04:52.624215Z","steps":["trace[388997403] 'agreement among raft nodes before linearized reading' (duration: 837.370917ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.624237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:51.786771Z","time spent":"837.462148ms","remote":"127.0.0.1:37550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.175\" "} {"level":"warn","ts":"2026-07-02T10:04:52.624266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.468160774s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-07-02T10:04:52.624304Z","caller":"traceutil/trace.go:171","msg":"trace[920741700] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:3195; }","duration":"1.468231547s","start":"2026-07-02T10:04:51.15606Z","end":"2026-07-02T10:04:52.624291Z","steps":["trace[920741700] 'agreement among raft nodes before linearized reading' (duration: 1.468122105s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.624333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:51.156039Z","time spent":"1.468286888s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-07-02T10:04:52.624577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.977910922s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-02T10:04:52.62461Z","caller":"traceutil/trace.go:171","msg":"trace[572293258] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3195; }","duration":"1.978003554s","start":"2026-07-02T10:04:50.646597Z","end":"2026-07-02T10:04:52.624601Z","steps":["trace[572293258] 'agreement among raft nodes before linearized reading' (duration: 1.977899682s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.624636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:50.646576Z","time spent":"1.978054175s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-02T10:04:52.625284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.327391469s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18be70dbad77b7ef\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-07-02T10:04:52.625324Z","caller":"traceutil/trace.go:171","msg":"trace[841766325] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18be70dbad77b7ef; range_end:; response_count:1; response_revision:3195; }","duration":"1.3274583s","start":"2026-07-02T10:04:51.297854Z","end":"2026-07-02T10:04:52.625312Z","steps":["trace[841766325] 'agreement among raft nodes before linearized reading' (duration: 1.327334157s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.625669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.93350692s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-07-02T10:04:52.625743Z","caller":"traceutil/trace.go:171","msg":"trace[1955584655] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:3195; }","duration":"2.933620022s","start":"2026-07-02T10:04:49.692111Z","end":"2026-07-02T10:04:52.625731Z","steps":["trace[1955584655] 'agreement among raft nodes before linearized reading' (duration: 2.93349099s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.625757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.930912399s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:124168"} {"level":"warn","ts":"2026-07-02T10:04:52.625815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:49.692076Z","time spent":"2.933727414s","remote":"127.0.0.1:37594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":141,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-07-02T10:04:52.625837Z","caller":"traceutil/trace.go:171","msg":"trace[2062212987] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:3195; }","duration":"2.931052562s","start":"2026-07-02T10:04:49.694769Z","end":"2026-07-02T10:04:52.625822Z","steps":["trace[2062212987] 'agreement among raft nodes before linearized reading' (duration: 2.930557173s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.625883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:49.69475Z","time spent":"2.931121873s","remote":"127.0.0.1:37580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":124191,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-07-02T10:04:52.625888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.34196303s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-02T10:04:52.625938Z","caller":"traceutil/trace.go:171","msg":"trace[1633301601] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3195; }","duration":"1.342048872s","start":"2026-07-02T10:04:51.283879Z","end":"2026-07-02T10:04:52.625927Z","steps":["trace[1633301601] 'agreement among raft nodes before linearized reading' (duration: 1.34193115s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.62574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.623457242s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"warn","ts":"2026-07-02T10:04:52.625979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:51.283857Z","time spent":"1.342112303s","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-07-02T10:04:52.626004Z","caller":"traceutil/trace.go:171","msg":"trace[703510464] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:3195; }","duration":"2.623749837s","start":"2026-07-02T10:04:50.002241Z","end":"2026-07-02T10:04:52.625991Z","steps":["trace[703510464] 'agreement among raft nodes before linearized reading' (duration: 2.623414631s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.626053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:50.002225Z","time spent":"2.623815439s","remote":"127.0.0.1:37700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-07-02T10:04:52.626314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.447135758s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:04:52.62635Z","caller":"traceutil/trace.go:171","msg":"trace[1400131947] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3195; }","duration":"1.447191749s","start":"2026-07-02T10:04:51.179148Z","end":"2026-07-02T10:04:52.62634Z","steps":["trace[1400131947] 'agreement among raft nodes before linearized reading' (duration: 1.447131698s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:04:52.626377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:51.179136Z","time spent":"1.44723427s","remote":"127.0.0.1:37526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T10:04:52.625353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:04:51.297843Z","time spent":"1.32750376s","remote":"127.0.0.1:37596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":802,"request content":"key:\"/registry/events/auth-system/keycloak-0.18be70dbad77b7ef\" "} {"level":"warn","ts":"2026-07-02T10:05:21.135928Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274650,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:05:21.63629Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274650,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:05:22.136913Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274650,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:05:22.637462Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274650,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:05:23.137756Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274650,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:05:23.180204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000222293s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-02T10:05:23.180329Z","caller":"traceutil/trace.go:171","msg":"trace[499430472] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000391706s","start":"2026-07-02T10:05:21.179901Z","end":"2026-07-02T10:05:23.180292Z","steps":["trace[499430472] 'agreement among raft nodes before linearized reading' (duration: 2.000263454s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:23.18039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:21.179878Z","time spent":"2.000500878s","remote":"127.0.0.1:37526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T10:05:23.638923Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274650,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:05:24.139506Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274650,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:05:24.640469Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274650,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:05:25.140682Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274650,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:05:25.182151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00081112s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-02T10:05:25.182299Z","caller":"traceutil/trace.go:171","msg":"trace[407477444] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001012785s","start":"2026-07-02T10:05:23.181243Z","end":"2026-07-02T10:05:25.182256Z","steps":["trace[407477444] 'agreement among raft nodes before linearized reading' (duration: 2.000828361s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:25.182383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:23.181226Z","time spent":"2.001134256s","remote":"127.0.0.1:37520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/02 10:05:25 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-02T10:05:25.636885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.000040069s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-02T10:05:25.637026Z","caller":"traceutil/trace.go:171","msg":"trace[277857186] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"5.000216073s","start":"2026-07-02T10:05:20.636788Z","end":"2026-07-02T10:05:25.637005Z","steps":["trace[277857186] 'agreement among raft nodes before linearized reading' (duration: 5.00005195s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:25.637083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:20.636781Z","time spent":"5.000284734s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-02T10:05:25.641136Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274650,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:05:25.723229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:20.724271Z","time spent":"4.998954517s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-07-02T10:05:25.727675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:20.730322Z","time spent":"4.997350118s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/07/02 10:05:25 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-02T10:05:25.804469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.995433444s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-02T10:05:25.804582Z","caller":"traceutil/trace.go:171","msg":"trace[852356563] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.995576196s","start":"2026-07-02T10:05:20.808981Z","end":"2026-07-02T10:05:25.804557Z","steps":["trace[852356563] 'agreement among raft nodes before linearized reading' (duration: 4.995428414s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:25.804647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:20.808955Z","time spent":"4.995680378s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} 2026/07/02 10:05:25 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-02T10:05:25.806463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.997487829s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-02T10:05:25.806577Z","caller":"traceutil/trace.go:171","msg":"trace[2076547193] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.997660133s","start":"2026-07-02T10:05:20.808889Z","end":"2026-07-02T10:05:25.806549Z","steps":["trace[2076547193] 'agreement among raft nodes before linearized reading' (duration: 4.997516209s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:25.806639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:20.808868Z","time spent":"4.997759295s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} 2026/07/02 10:05:25 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-02T10:05:26.141827Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274650,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:05:26.642478Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274650,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:05:27.14306Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274650,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:05:27.190098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000086756s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-02T10:05:27.190201Z","caller":"traceutil/trace.go:171","msg":"trace[396159866] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000244699s","start":"2026-07-02T10:05:25.189934Z","end":"2026-07-02T10:05:27.190179Z","steps":["trace[396159866] 'agreement among raft nodes before linearized reading' (duration: 2.000107777s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:27.190309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:25.189916Z","time spent":"2.000365641s","remote":"127.0.0.1:37526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T10:05:27.619368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:20.618528Z","time spent":"7.000830119s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-07-02T10:05:27.636078Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"} {"level":"warn","ts":"2026-07-02T10:05:27.636303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.000787582s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-07-02T10:05:27.636367Z","caller":"traceutil/trace.go:171","msg":"trace[1362817362] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; }","duration":"7.000908944s","start":"2026-07-02T10:05:20.635427Z","end":"2026-07-02T10:05:27.636336Z","steps":["trace[1362817362] 'agreement among raft nodes before linearized reading' (duration: 7.000828253s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:27.636423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:20.635404Z","time spent":"7.001008925s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-02T10:05:28.1368Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4891365639824274660,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:05:28.447634Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"7.82892286s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-02T10:05:28.604888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:25.187018Z","time spent":"3.417864776s","remote":"127.0.0.1:37596","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-02T10:05:28.60509Z","caller":"traceutil/trace.go:171","msg":"trace[85469551] transaction","detail":"{read_only:false; response_revision:3336; number_of_response:1; }","duration":"5.141750128s","start":"2026-07-02T10:05:23.463315Z","end":"2026-07-02T10:05:28.605065Z","steps":["trace[85469551] 'process raft request' (duration: 5.140866884s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.605204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:23.463289Z","time spent":"5.141843299s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:05:28.605483Z","caller":"traceutil/trace.go:171","msg":"trace[269423957] transaction","detail":"{read_only:false; response_revision:3337; number_of_response:1; }","duration":"1.717826165s","start":"2026-07-02T10:05:26.887643Z","end":"2026-07-02T10:05:28.605469Z","steps":["trace[269423957] 'process raft request' (duration: 1.717048461s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.60577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:26.887612Z","time spent":"1.718086449s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:05:28.757148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.328325ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-02T10:05:28.757865Z","caller":"traceutil/trace.go:171","msg":"trace[336556322] transaction","detail":"{read_only:false; response_revision:3339; number_of_response:1; }","duration":"1.472505614s","start":"2026-07-02T10:05:27.285319Z","end":"2026-07-02T10:05:28.757825Z","steps":["trace[336556322] 'process raft request' (duration: 1.471978786s)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:28.757906Z","caller":"traceutil/trace.go:171","msg":"trace[87689711] linearizableReadLoop","detail":"{readStateIndex:3470; appliedIndex:3462; }","duration":"1.121643591s","start":"2026-07-02T10:05:27.636215Z","end":"2026-07-02T10:05:28.757859Z","steps":["trace[87689711] 'read index received' (duration: 811.673718ms)","trace[87689711] 'applied index is now lower than readState.Index' (duration: 309.965983ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:05:28.757937Z","caller":"traceutil/trace.go:171","msg":"trace[1569609203] transaction","detail":"{read_only:false; response_revision:3340; number_of_response:1; }","duration":"150.740838ms","start":"2026-07-02T10:05:28.607165Z","end":"2026-07-02T10:05:28.757906Z","steps":["trace[1569609203] 'process raft request' (duration: 150.638256ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.758034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.133849792s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"info","ts":"2026-07-02T10:05:28.758073Z","caller":"traceutil/trace.go:171","msg":"trace[1175168665] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:3340; }","duration":"1.133927713s","start":"2026-07-02T10:05:27.624134Z","end":"2026-07-02T10:05:28.758062Z","steps":["trace[1175168665] 'agreement among raft nodes before linearized reading' (duration: 1.133830561s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.758098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:27.624097Z","time spent":"1.133995354s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":593,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-07-02T10:05:28.758107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.681865858s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:05:28.758148Z","caller":"traceutil/trace.go:171","msg":"trace[2125650734] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:3340; }","duration":"3.681987989s","start":"2026-07-02T10:05:25.076149Z","end":"2026-07-02T10:05:28.758137Z","steps":["trace[2125650734] 'agreement among raft nodes before linearized reading' (duration: 3.681880108s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.758199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:25.076125Z","time spent":"3.682064121s","remote":"127.0.0.1:52132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:05:28.758209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.49472008s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-02T10:05:28.758256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.500382188s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:05:28.758285Z","caller":"traceutil/trace.go:171","msg":"trace[1437254336] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:3340; }","duration":"2.500455079s","start":"2026-07-02T10:05:26.257823Z","end":"2026-07-02T10:05:28.758278Z","steps":["trace[1437254336] 'agreement among raft nodes before linearized reading' (duration: 2.500406648s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.758304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:26.257799Z","time spent":"2.50049947s","remote":"127.0.0.1:37718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:05:28.758306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.891573112s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/auth-system/keycloak-0\" ","response":"range_response_count:1 size:8141"} {"level":"info","ts":"2026-07-02T10:05:28.758403Z","caller":"traceutil/trace.go:171","msg":"trace[1287319858] range","detail":"{range_begin:/registry/pods/auth-system/keycloak-0; range_end:; response_count:1; response_revision:3340; }","duration":"6.891701644s","start":"2026-07-02T10:05:21.866683Z","end":"2026-07-02T10:05:28.758384Z","steps":["trace[1287319858] 'agreement among raft nodes before linearized reading' (duration: 6.89145407s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.758454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.028572526s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:551"} {"level":"warn","ts":"2026-07-02T10:05:28.758455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.969475518s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.175\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:05:28.758476Z","caller":"traceutil/trace.go:171","msg":"trace[326637660] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:3340; }","duration":"3.028653808s","start":"2026-07-02T10:05:25.729817Z","end":"2026-07-02T10:05:28.758471Z","steps":["trace[326637660] 'agreement among raft nodes before linearized reading' (duration: 3.028585817s)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:28.758491Z","caller":"traceutil/trace.go:171","msg":"trace[1491865096] range","detail":"{range_begin:/registry/masterleases/199.19.213.175; range_end:; response_count:0; response_revision:3340; }","duration":"6.96955561s","start":"2026-07-02T10:05:21.788927Z","end":"2026-07-02T10:05:28.758482Z","steps":["trace[1491865096] 'agreement among raft nodes before linearized reading' (duration: 6.969494369s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.758502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:25.729784Z","time spent":"3.028713289s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":574,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-07-02T10:05:28.758512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.165849275s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-02T10:05:28.758524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:21.788906Z","time spent":"6.969608771s","remote":"127.0.0.1:37550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.19.213.175\" "} {"level":"info","ts":"2026-07-02T10:05:28.758553Z","caller":"traceutil/trace.go:171","msg":"trace[760982832] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:3340; }","duration":"4.165924228s","start":"2026-07-02T10:05:24.592617Z","end":"2026-07-02T10:05:28.758541Z","steps":["trace[760982832] 'agreement among raft nodes before linearized reading' (duration: 4.165865237s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.758584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:24.592598Z","time spent":"4.165979089s","remote":"127.0.0.1:53426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":30,"request content":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:05:28.75853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.257854977s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-02T10:05:28.758621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.032634017s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"} {"level":"info","ts":"2026-07-02T10:05:28.758649Z","caller":"traceutil/trace.go:171","msg":"trace[501843009] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:3340; }","duration":"3.032687788s","start":"2026-07-02T10:05:25.725952Z","end":"2026-07-02T10:05:28.75864Z","steps":["trace[501843009] 'agreement among raft nodes before linearized reading' (duration: 3.032626097s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.758669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:25.725936Z","time spent":"3.032728569s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":548,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "} {"level":"info","ts":"2026-07-02T10:05:28.758672Z","caller":"traceutil/trace.go:171","msg":"trace[619503149] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:3340; }","duration":"1.257966439s","start":"2026-07-02T10:05:27.500653Z","end":"2026-07-02T10:05:28.758619Z","steps":["trace[619503149] 'agreement among raft nodes before linearized reading' (duration: 1.257732585s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.758765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.232326928s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T10:05:28.758767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.949774395s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-07-02T10:05:28.758807Z","caller":"traceutil/trace.go:171","msg":"trace[842331462] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:3340; }","duration":"3.232380569s","start":"2026-07-02T10:05:25.526404Z","end":"2026-07-02T10:05:28.758785Z","steps":["trace[842331462] 'agreement among raft nodes before linearized reading' (duration: 3.232343598s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.758833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:25.526393Z","time spent":"3.23243349s","remote":"127.0.0.1:37730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-07-02T10:05:28.75884Z","caller":"traceutil/trace.go:171","msg":"trace[540163824] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3340; }","duration":"7.949853836s","start":"2026-07-02T10:05:20.808973Z","end":"2026-07-02T10:05:28.758827Z","steps":["trace[540163824] 'agreement among raft nodes before linearized reading' (duration: 7.949691893s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.758851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.898483557s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-02T10:05:28.758879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:20.808966Z","time spent":"7.949904566s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-07-02T10:05:28.758897Z","caller":"traceutil/trace.go:171","msg":"trace[1389362450] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:3340; }","duration":"4.898586689s","start":"2026-07-02T10:05:23.860301Z","end":"2026-07-02T10:05:28.758888Z","steps":["trace[1389362450] 'agreement among raft nodes before linearized reading' (duration: 4.898465267s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.758902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:27.500571Z","time spent":"1.258149813s","remote":"127.0.0.1:37964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:05:28.759041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.532637622s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-02T10:05:28.759077Z","caller":"traceutil/trace.go:171","msg":"trace[1103229319] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3340; }","duration":"5.532737294s","start":"2026-07-02T10:05:23.226332Z","end":"2026-07-02T10:05:28.759069Z","steps":["trace[1103229319] 'agreement among raft nodes before linearized reading' (duration: 5.532617312s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.757936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.504204858s","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:5"} {"level":"info","ts":"2026-07-02T10:05:28.758346Z","caller":"traceutil/trace.go:171","msg":"trace[321883579] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3340; }","duration":"2.494910193s","start":"2026-07-02T10:05:26.26335Z","end":"2026-07-02T10:05:28.75826Z","steps":["trace[321883579] 'agreement among raft nodes before linearized reading' (duration: 2.494659698s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.759147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:26.263314Z","time spent":"2.495817678s","remote":"127.0.0.1:53350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:05:28.759176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.476287871s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-02T10:05:28.759202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.080011882s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-07-02T10:05:28.759211Z","caller":"traceutil/trace.go:171","msg":"trace[1245368580] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:3340; }","duration":"2.476341932s","start":"2026-07-02T10:05:26.282856Z","end":"2026-07-02T10:05:28.759198Z","steps":["trace[1245368580] 'agreement among raft nodes before linearized reading' (duration: 2.476289651s)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:28.759178Z","caller":"traceutil/trace.go:171","msg":"trace[463071530] 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:3340; }","duration":"3.505447149s","start":"2026-07-02T10:05:25.253702Z","end":"2026-07-02T10:05:28.759149Z","steps":["trace[463071530] 'agreement among raft nodes before linearized reading' (duration: 3.504160757s)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:28.759236Z","caller":"traceutil/trace.go:171","msg":"trace[242551300] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:3340; }","duration":"6.080064923s","start":"2026-07-02T10:05:22.679162Z","end":"2026-07-02T10:05:28.759227Z","steps":["trace[242551300] 'agreement among raft nodes before linearized reading' (duration: 6.079961062s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.759268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:22.679153Z","time spent":"6.080108374s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-07-02T10:05:28.759274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.568150962s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:05:28.759306Z","caller":"traceutil/trace.go:171","msg":"trace[388064171] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3340; }","duration":"1.568238303s","start":"2026-07-02T10:05:27.191062Z","end":"2026-07-02T10:05:28.7593Z","steps":["trace[388064171] 'agreement among raft nodes before linearized reading' (duration: 1.568196253s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.759337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:27.191037Z","time spent":"1.568295714s","remote":"127.0.0.1:37520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T10:05:28.758929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:23.860264Z","time spent":"4.89865728s","remote":"127.0.0.1:44546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":15,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:05:28.759489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.08728108s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-07-02T10:05:28.759525Z","caller":"traceutil/trace.go:171","msg":"trace[1325551581] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:3340; }","duration":"6.087356801s","start":"2026-07-02T10:05:22.672161Z","end":"2026-07-02T10:05:28.759517Z","steps":["trace[1325551581] 'agreement among raft nodes before linearized reading' (duration: 6.087257568s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.759558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:22.672136Z","time spent":"6.087415893s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-07-02T10:05:28.759646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.755933673s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"warn","ts":"2026-07-02T10:05:28.759243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:26.282844Z","time spent":"2.476392202s","remote":"127.0.0.1:53398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":2,"response size":30,"request content":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true "} {"level":"info","ts":"2026-07-02T10:05:28.759676Z","caller":"traceutil/trace.go:171","msg":"trace[1180977190] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:3340; }","duration":"6.756016105s","start":"2026-07-02T10:05:22.003653Z","end":"2026-07-02T10:05:28.759669Z","steps":["trace[1180977190] 'agreement among raft nodes before linearized reading' (duration: 6.755936973s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.759697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:22.003623Z","time spent":"6.756069535s","remote":"127.0.0.1:37700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-07-02T10:05:28.758453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:21.866671Z","time spent":"6.891773195s","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":8164,"request content":"key:\"/registry/pods/auth-system/keycloak-0\" "} {"level":"warn","ts":"2026-07-02T10:05:28.759324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:25.253668Z","time spent":"3.505630542s","remote":"127.0.0.1:56610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:05:28.760043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:27.285282Z","time spent":"1.472669856s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:05:28.760291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.121447908s","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-07-02T10:05:28.760321Z","caller":"traceutil/trace.go:171","msg":"trace[1306329877] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3340; }","duration":"1.121499068s","start":"2026-07-02T10:05:27.638815Z","end":"2026-07-02T10:05:28.760314Z","steps":["trace[1306329877] 'agreement among raft nodes before linearized reading' (duration: 1.121426737s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.760339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:27.638803Z","time spent":"1.121532009s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-02T10:05:28.760405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.39235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T10:05:28.760427Z","caller":"traceutil/trace.go:171","msg":"trace[778552250] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:3340; }","duration":"324.470462ms","start":"2026-07-02T10:05:28.435951Z","end":"2026-07-02T10:05:28.760422Z","steps":["trace[778552250] 'agreement among raft nodes before linearized reading' (duration: 324.430961ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.760446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:28.435917Z","time spent":"324.524103ms","remote":"127.0.0.1:37934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:05:28.760567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.732255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T10:05:28.760592Z","caller":"traceutil/trace.go:171","msg":"trace[989914761] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:3340; }","duration":"409.761847ms","start":"2026-07-02T10:05:28.350825Z","end":"2026-07-02T10:05:28.760586Z","steps":["trace[989914761] 'agreement among raft nodes before linearized reading' (duration: 409.717456ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.760611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:28.350745Z","time spent":"409.861248ms","remote":"127.0.0.1:37654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":30,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:05:28.760737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"951.783884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-02T10:05:28.76076Z","caller":"traceutil/trace.go:171","msg":"trace[351446439] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3340; }","duration":"951.829825ms","start":"2026-07-02T10:05:27.808925Z","end":"2026-07-02T10:05:28.760755Z","steps":["trace[351446439] 'agreement among raft nodes before linearized reading' (duration: 951.772494ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.760778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:27.808914Z","time spent":"951.859326ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-02T10:05:28.760952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.191988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-02T10:05:28.76099Z","caller":"traceutil/trace.go:171","msg":"trace[738980095] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3340; }","duration":"954.286448ms","start":"2026-07-02T10:05:27.806696Z","end":"2026-07-02T10:05:28.760983Z","steps":["trace[738980095] 'agreement among raft nodes before linearized reading' (duration: 954.115294ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.76101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:27.806671Z","time spent":"954.33507ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-02T10:05:28.760542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.12410363s","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-07-02T10:05:28.761137Z","caller":"traceutil/trace.go:171","msg":"trace[1940725517] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3340; }","duration":"8.124771622s","start":"2026-07-02T10:05:20.63634Z","end":"2026-07-02T10:05:28.761112Z","steps":["trace[1940725517] 'agreement among raft nodes before linearized reading' (duration: 8.122633095s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.759105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:23.226292Z","time spent":"5.532806625s","remote":"127.0.0.1:37686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-07-02T10:05:28.761531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:05:20.636315Z","time spent":"8.12519735s","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-02T10:05:28.912044Z","caller":"traceutil/trace.go:171","msg":"trace[634480797] transaction","detail":"{read_only:false; response_revision:3341; number_of_response:1; }","duration":"145.0591ms","start":"2026-07-02T10:05:28.766942Z","end":"2026-07-02T10:05:28.912001Z","steps":["trace[634480797] 'process raft request' (duration: 127.007481ms)","trace[634480797] 'compare' (duration: 17.753224ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:05:28.912535Z","caller":"traceutil/trace.go:171","msg":"trace[1109370826] transaction","detail":"{read_only:false; response_revision:3343; number_of_response:1; }","duration":"143.220869ms","start":"2026-07-02T10:05:28.769291Z","end":"2026-07-02T10:05:28.912512Z","steps":["trace[1109370826] 'process raft request' (duration: 142.887984ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:28.912566Z","caller":"traceutil/trace.go:171","msg":"trace[334894911] linearizableReadLoop","detail":"{readStateIndex:3480; appliedIndex:3472; }","duration":"121.494137ms","start":"2026-07-02T10:05:28.791049Z","end":"2026-07-02T10:05:28.912543Z","steps":["trace[334894911] 'read index received' (duration: 102.900818ms)","trace[334894911] 'applied index is now lower than readState.Index' (duration: 18.592069ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:05:28.912665Z","caller":"traceutil/trace.go:171","msg":"trace[958273000] transaction","detail":"{read_only:false; response_revision:3344; number_of_response:1; }","duration":"143.310891ms","start":"2026-07-02T10:05:28.769344Z","end":"2026-07-02T10:05:28.912654Z","steps":["trace[958273000] 'process raft request' (duration: 142.992285ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:28.912688Z","caller":"traceutil/trace.go:171","msg":"trace[1937365668] transaction","detail":"{read_only:false; response_revision:3342; number_of_response:1; }","duration":"143.541055ms","start":"2026-07-02T10:05:28.769136Z","end":"2026-07-02T10:05:28.912677Z","steps":["trace[1937365668] 'process raft request' (duration: 142.795192ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.912877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.81319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:05:28.912923Z","caller":"traceutil/trace.go:171","msg":"trace[1293758706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3348; }","duration":"143.915542ms","start":"2026-07-02T10:05:28.768995Z","end":"2026-07-02T10:05:28.912911Z","steps":["trace[1293758706] 'agreement among raft nodes before linearized reading' (duration: 143.835581ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.913022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.104448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18be70fad9cc9de2\" ","response":"range_response_count:1 size:774"} {"level":"info","ts":"2026-07-02T10:05:28.91307Z","caller":"traceutil/trace.go:171","msg":"trace[1652855051] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18be70fad9cc9de2; range_end:; response_count:1; response_revision:3348; }","duration":"146.174909ms","start":"2026-07-02T10:05:28.766882Z","end":"2026-07-02T10:05:28.913057Z","steps":["trace[1652855051] 'agreement among raft nodes before linearized reading' (duration: 146.008016ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.91304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.592435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"} {"level":"warn","ts":"2026-07-02T10:05:28.913151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.8449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"info","ts":"2026-07-02T10:05:28.913185Z","caller":"traceutil/trace.go:171","msg":"trace[1538723219] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:3348; }","duration":"143.88576ms","start":"2026-07-02T10:05:28.76929Z","end":"2026-07-02T10:05:28.913175Z","steps":["trace[1538723219] 'agreement among raft nodes before linearized reading' (duration: 143.778008ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.913314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.037532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:551"} {"level":"info","ts":"2026-07-02T10:05:28.913346Z","caller":"traceutil/trace.go:171","msg":"trace[935149639] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:3348; }","duration":"144.075833ms","start":"2026-07-02T10:05:28.769262Z","end":"2026-07-02T10:05:28.913338Z","steps":["trace[935149639] 'agreement among raft nodes before linearized reading' (duration: 143.999032ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.913521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.34311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-02T10:05:28.913557Z","caller":"traceutil/trace.go:171","msg":"trace[804534105] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3348; }","duration":"144.40679ms","start":"2026-07-02T10:05:28.769142Z","end":"2026-07-02T10:05:28.913549Z","steps":["trace[804534105] 'agreement among raft nodes before linearized reading' (duration: 144.301329ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:28.913575Z","caller":"traceutil/trace.go:171","msg":"trace[1517409217] transaction","detail":"{read_only:false; response_revision:3346; number_of_response:1; }","duration":"144.071263ms","start":"2026-07-02T10:05:28.769487Z","end":"2026-07-02T10:05:28.913558Z","steps":["trace[1517409217] 'process raft request' (duration: 142.935094ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:28.913145Z","caller":"traceutil/trace.go:171","msg":"trace[1066365236] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:3348; }","duration":"143.800118ms","start":"2026-07-02T10:05:28.769325Z","end":"2026-07-02T10:05:28.913125Z","steps":["trace[1066365236] 'agreement among raft nodes before linearized reading' (duration: 143.455033ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:28.913481Z","caller":"traceutil/trace.go:171","msg":"trace[1956418223] transaction","detail":"{read_only:false; response_revision:3345; number_of_response:1; }","duration":"143.733517ms","start":"2026-07-02T10:05:28.769451Z","end":"2026-07-02T10:05:28.913185Z","steps":["trace[1956418223] 'process raft request' (duration: 142.919284ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:28.913797Z","caller":"traceutil/trace.go:171","msg":"trace[1774160647] transaction","detail":"{read_only:false; response_revision:3347; number_of_response:1; }","duration":"143.753939ms","start":"2026-07-02T10:05:28.770021Z","end":"2026-07-02T10:05:28.913775Z","steps":["trace[1774160647] 'process raft request' (duration: 142.431646ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:28.913923Z","caller":"traceutil/trace.go:171","msg":"trace[942214587] transaction","detail":"{read_only:false; response_revision:3348; number_of_response:1; }","duration":"142.206152ms","start":"2026-07-02T10:05:28.771696Z","end":"2026-07-02T10:05:28.913902Z","steps":["trace[942214587] 'process raft request' (duration: 140.790228ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:28.938295Z","caller":"traceutil/trace.go:171","msg":"trace[2011637727] transaction","detail":"{read_only:false; response_revision:3349; number_of_response:1; }","duration":"146.353922ms","start":"2026-07-02T10:05:28.791917Z","end":"2026-07-02T10:05:28.938271Z","steps":["trace[2011637727] 'process raft request' (duration: 146.22311ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:28.938508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.614585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1315"} {"level":"info","ts":"2026-07-02T10:05:28.938673Z","caller":"traceutil/trace.go:171","msg":"trace[1578640549] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:3349; }","duration":"143.796228ms","start":"2026-07-02T10:05:28.794781Z","end":"2026-07-02T10:05:28.938577Z","steps":["trace[1578640549] 'agreement among raft nodes before linearized reading' (duration: 143.503913ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:29.151213Z","caller":"traceutil/trace.go:171","msg":"trace[1864370581] linearizableReadLoop","detail":"{readStateIndex:3483; appliedIndex:3482; }","duration":"106.021824ms","start":"2026-07-02T10:05:29.04515Z","end":"2026-07-02T10:05:29.151172Z","steps":["trace[1864370581] 'read index received' (duration: 19.107106ms)","trace[1864370581] 'applied index is now lower than readState.Index' (duration: 86.912958ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:05:29.151321Z","caller":"traceutil/trace.go:171","msg":"trace[1366431606] transaction","detail":"{read_only:false; response_revision:3351; number_of_response:1; }","duration":"153.132061ms","start":"2026-07-02T10:05:28.998151Z","end":"2026-07-02T10:05:29.151283Z","steps":["trace[1366431606] 'process raft request' (duration: 66.250994ms)","trace[1366431606] 'compare' (duration: 86.388279ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:05:29.151435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.260058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:05:29.151545Z","caller":"traceutil/trace.go:171","msg":"trace[1486212461] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:3351; }","duration":"106.430192ms","start":"2026-07-02T10:05:29.045088Z","end":"2026-07-02T10:05:29.151518Z","steps":["trace[1486212461] 'agreement among raft nodes before linearized reading' (duration: 106.215928ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:29.416252Z","caller":"traceutil/trace.go:171","msg":"trace[237816736] transaction","detail":"{read_only:false; response_revision:3352; number_of_response:1; }","duration":"258.063169ms","start":"2026-07-02T10:05:29.158156Z","end":"2026-07-02T10:05:29.41622Z","steps":["trace[237816736] 'process raft request' (duration: 168.558327ms)","trace[237816736] 'compare' (duration: 89.158166ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:05:29.429419Z","caller":"traceutil/trace.go:171","msg":"trace[817833868] transaction","detail":"{read_only:false; response_revision:3353; number_of_response:1; }","duration":"270.906718ms","start":"2026-07-02T10:05:29.158495Z","end":"2026-07-02T10:05:29.429402Z","steps":["trace[817833868] 'process raft request' (duration: 270.719865ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:29.431171Z","caller":"traceutil/trace.go:171","msg":"trace[1170039585] transaction","detail":"{read_only:false; response_revision:3354; number_of_response:1; }","duration":"272.373473ms","start":"2026-07-02T10:05:29.158742Z","end":"2026-07-02T10:05:29.431115Z","steps":["trace[1170039585] 'process raft request' (duration: 270.573322ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:29.43155Z","caller":"traceutil/trace.go:171","msg":"trace[1452388895] linearizableReadLoop","detail":"{readStateIndex:3489; appliedIndex:3483; }","duration":"270.38642ms","start":"2026-07-02T10:05:29.161087Z","end":"2026-07-02T10:05:29.431473Z","steps":["trace[1452388895] 'read index received' (duration: 165.775419ms)","trace[1452388895] 'applied index is now lower than readState.Index' (duration: 104.609131ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:05:29.432607Z","caller":"traceutil/trace.go:171","msg":"trace[2053228140] transaction","detail":"{read_only:false; response_revision:3357; number_of_response:1; }","duration":"273.170387ms","start":"2026-07-02T10:05:29.159354Z","end":"2026-07-02T10:05:29.432525Z","steps":["trace[2053228140] 'process raft request' (duration: 271.974906ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:29.432925Z","caller":"traceutil/trace.go:171","msg":"trace[851672905] transaction","detail":"{read_only:false; response_revision:3355; number_of_response:1; }","duration":"273.787948ms","start":"2026-07-02T10:05:29.159094Z","end":"2026-07-02T10:05:29.432882Z","steps":["trace[851672905] 'process raft request' (duration: 270.577843ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:05:29.432976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.846465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-02T10:05:29.433594Z","caller":"traceutil/trace.go:171","msg":"trace[2013658507] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3358; }","duration":"272.000398ms","start":"2026-07-02T10:05:29.16107Z","end":"2026-07-02T10:05:29.43307Z","steps":["trace[2013658507] 'agreement among raft nodes before linearized reading' (duration: 271.366706ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:29.433927Z","caller":"traceutil/trace.go:171","msg":"trace[1136512572] transaction","detail":"{read_only:false; response_revision:3358; number_of_response:1; }","duration":"270.862197ms","start":"2026-07-02T10:05:29.163027Z","end":"2026-07-02T10:05:29.433889Z","steps":["trace[1136512572] 'process raft request' (duration: 268.376294ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:05:29.434076Z","caller":"traceutil/trace.go:171","msg":"trace[1105077566] transaction","detail":"{read_only:false; response_revision:3356; number_of_response:1; }","duration":"274.869876ms","start":"2026-07-02T10:05:29.15914Z","end":"2026-07-02T10:05:29.43401Z","steps":["trace[1105077566] 'process raft request' (duration: 272.011097ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:37.343454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.403302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2f8d1e99-ecb1-45c1-953f-aad93e2573b2\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-07-02T10:07:37.343555Z","caller":"traceutil/trace.go:171","msg":"trace[1715113653] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2f8d1e99-ecb1-45c1-953f-aad93e2573b2; range_end:; response_count:1; response_revision:4686; }","duration":"108.556544ms","start":"2026-07-02T10:07:37.234981Z","end":"2026-07-02T10:07:37.343537Z","steps":["trace[1715113653] 'range keys from in-memory index tree' (duration: 108.23879ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:37.49097Z","caller":"traceutil/trace.go:171","msg":"trace[139862278] transaction","detail":"{read_only:false; response_revision:4687; number_of_response:1; }","duration":"119.206692ms","start":"2026-07-02T10:07:37.371734Z","end":"2026-07-02T10:07:37.49094Z","steps":["trace[139862278] 'process raft request' (duration: 118.991479ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:37.523138Z","caller":"traceutil/trace.go:171","msg":"trace[293188564] linearizableReadLoop","detail":"{readStateIndex:4874; appliedIndex:4872; }","duration":"134.906276ms","start":"2026-07-02T10:07:37.388212Z","end":"2026-07-02T10:07:37.523118Z","steps":["trace[293188564] 'read index received' (duration: 102.506564ms)","trace[293188564] 'applied index is now lower than readState.Index' (duration: 32.398622ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:07:37.523286Z","caller":"traceutil/trace.go:171","msg":"trace[1405587079] transaction","detail":"{read_only:false; response_revision:4688; number_of_response:1; }","duration":"145.544065ms","start":"2026-07-02T10:07:37.377727Z","end":"2026-07-02T10:07:37.523271Z","steps":["trace[1405587079] 'process raft request' (duration: 145.201901ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:37.52376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.535834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1825"} {"level":"info","ts":"2026-07-02T10:07:37.523818Z","caller":"traceutil/trace.go:171","msg":"trace[605991217] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4691; }","duration":"135.621256ms","start":"2026-07-02T10:07:37.388164Z","end":"2026-07-02T10:07:37.523785Z","steps":["trace[605991217] 'agreement among raft nodes before linearized reading' (duration: 135.030838ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:39.742239Z","caller":"traceutil/trace.go:171","msg":"trace[1581775871] transaction","detail":"{read_only:false; response_revision:4707; number_of_response:1; }","duration":"213.088486ms","start":"2026-07-02T10:07:39.529123Z","end":"2026-07-02T10:07:39.742212Z","steps":["trace[1581775871] 'process raft request' (duration: 124.060651ms)","trace[1581775871] 'compare' (duration: 88.515199ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:07:39.742372Z","caller":"traceutil/trace.go:171","msg":"trace[585944611] transaction","detail":"{read_only:false; response_revision:4708; number_of_response:1; }","duration":"211.788319ms","start":"2026-07-02T10:07:39.530575Z","end":"2026-07-02T10:07:39.742363Z","steps":["trace[585944611] 'process raft request' (duration: 211.248003ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:42.236115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.217444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:07:42.236211Z","caller":"traceutil/trace.go:171","msg":"trace[120754641] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4812; }","duration":"103.355006ms","start":"2026-07-02T10:07:42.132835Z","end":"2026-07-02T10:07:42.23619Z","steps":["trace[120754641] 'range keys from in-memory index tree' (duration: 103.151374ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:42.297567Z","caller":"traceutil/trace.go:171","msg":"trace[330053365] transaction","detail":"{read_only:false; response_revision:4813; number_of_response:1; }","duration":"112.839679ms","start":"2026-07-02T10:07:42.184695Z","end":"2026-07-02T10:07:42.297535Z","steps":["trace[330053365] 'process raft request' (duration: 112.586616ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:42.503391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.858731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:07:42.503682Z","caller":"traceutil/trace.go:171","msg":"trace[763944825] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4814; }","duration":"264.193395ms","start":"2026-07-02T10:07:42.239463Z","end":"2026-07-02T10:07:42.503656Z","steps":["trace[763944825] 'agreement among raft nodes before linearized reading' (duration: 263.860561ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:42.503614Z","caller":"traceutil/trace.go:171","msg":"trace[255218812] transaction","detail":"{read_only:false; response_revision:4814; number_of_response:1; }","duration":"315.246866ms","start":"2026-07-02T10:07:42.187977Z","end":"2026-07-02T10:07:42.503224Z","steps":["trace[255218812] 'process raft request' (duration: 235.355533ms)","trace[255218812] 'compare' (duration: 79.368187ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:07:42.503292Z","caller":"traceutil/trace.go:171","msg":"trace[294383741] linearizableReadLoop","detail":"{readStateIndex:5003; appliedIndex:5001; }","duration":"263.658068ms","start":"2026-07-02T10:07:42.239516Z","end":"2026-07-02T10:07:42.503174Z","steps":["trace[294383741] 'read index received' (duration: 57.899818ms)","trace[294383741] 'applied index is now lower than readState.Index' (duration: 205.75655ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:07:42.50471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:07:42.187964Z","time spent":"315.915955ms","remote":"127.0.0.1:37764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:07:42.511444Z","caller":"traceutil/trace.go:171","msg":"trace[2004790393] transaction","detail":"{read_only:false; response_revision:4815; number_of_response:1; }","duration":"207.940409ms","start":"2026-07-02T10:07:42.30348Z","end":"2026-07-02T10:07:42.511421Z","steps":["trace[2004790393] 'process raft request' (duration: 207.780537ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:42.512152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.769988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4008955f-0bc7-4753-9a14-c33fdbd330e2\" ","response":"range_response_count:1 size:3646"} {"level":"warn","ts":"2026-07-02T10:07:42.512212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.73929ms","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-07-02T10:07:42.51224Z","caller":"traceutil/trace.go:171","msg":"trace[1658519437] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4008955f-0bc7-4753-9a14-c33fdbd330e2; range_end:; response_count:1; response_revision:4816; }","duration":"269.88967ms","start":"2026-07-02T10:07:42.242323Z","end":"2026-07-02T10:07:42.512213Z","steps":["trace[1658519437] 'agreement among raft nodes before linearized reading' (duration: 269.592305ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:42.512256Z","caller":"traceutil/trace.go:171","msg":"trace[111817438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4816; }","duration":"174.81608ms","start":"2026-07-02T10:07:42.337428Z","end":"2026-07-02T10:07:42.512244Z","steps":["trace[111817438] 'agreement among raft nodes before linearized reading' (duration: 174.679978ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:42.512438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.579191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-07-02T10:07:42.512462Z","caller":"traceutil/trace.go:171","msg":"trace[265999634] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4816; }","duration":"158.604372ms","start":"2026-07-02T10:07:42.353849Z","end":"2026-07-02T10:07:42.512453Z","steps":["trace[265999634] 'agreement among raft nodes before linearized reading' (duration: 158.540491ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:42.512461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.409866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:11451"} {"level":"info","ts":"2026-07-02T10:07:42.512494Z","caller":"traceutil/trace.go:171","msg":"trace[2078767683] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4816; }","duration":"205.467117ms","start":"2026-07-02T10:07:42.307016Z","end":"2026-07-02T10:07:42.512483Z","steps":["trace[2078767683] 'agreement among raft nodes before linearized reading' (duration: 205.375786ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:56.088918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.918003ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T10:07:56.089026Z","caller":"traceutil/trace.go:171","msg":"trace[1416933019] linearizableReadLoop","detail":"{readStateIndex:5189; appliedIndex:5188; }","duration":"260.56001ms","start":"2026-07-02T10:07:55.828449Z","end":"2026-07-02T10:07:56.089009Z","steps":["trace[1416933019] 'read index received' (duration: 29.391273ms)","trace[1416933019] 'applied index is now lower than readState.Index' (duration: 231.167357ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:07:56.089048Z","caller":"traceutil/trace.go:171","msg":"trace[1978912096] transaction","detail":"{read_only:false; response_revision:4995; number_of_response:1; }","duration":"292.511797ms","start":"2026-07-02T10:07:55.796514Z","end":"2026-07-02T10:07:56.089026Z","steps":["trace[1978912096] 'process raft request' (duration: 61.380621ms)","trace[1978912096] 'compare' (duration: 230.812552ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:07:56.08932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.747796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-02T10:07:56.089348Z","caller":"traceutil/trace.go:171","msg":"trace[938747711] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4995; }","duration":"187.821187ms","start":"2026-07-02T10:07:55.901521Z","end":"2026-07-02T10:07:56.089342Z","steps":["trace[938747711] 'agreement among raft nodes before linearized reading' (duration: 187.720356ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:56.08947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.951591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1986"} {"level":"info","ts":"2026-07-02T10:07:56.089492Z","caller":"traceutil/trace.go:171","msg":"trace[2145867143] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:4995; }","duration":"141.013131ms","start":"2026-07-02T10:07:55.948474Z","end":"2026-07-02T10:07:56.089487Z","steps":["trace[2145867143] 'agreement among raft nodes before linearized reading' (duration: 140.959551ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:56.089589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.451233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"info","ts":"2026-07-02T10:07:56.089604Z","caller":"traceutil/trace.go:171","msg":"trace[1204369704] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4995; }","duration":"154.486963ms","start":"2026-07-02T10:07:55.935112Z","end":"2026-07-02T10:07:56.089599Z","steps":["trace[1204369704] 'agreement among raft nodes before linearized reading' (duration: 154.445132ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:56.089707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.205019ms","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-07-02T10:07:56.089725Z","caller":"traceutil/trace.go:171","msg":"trace[2125194247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4995; }","duration":"180.2447ms","start":"2026-07-02T10:07:55.909475Z","end":"2026-07-02T10:07:56.08972Z","steps":["trace[2125194247] 'agreement among raft nodes before linearized reading' (duration: 180.2016ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:56.089805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.217721ms","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-07-02T10:07:56.089822Z","caller":"traceutil/trace.go:171","msg":"trace[991084672] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4995; }","duration":"181.253563ms","start":"2026-07-02T10:07:55.908564Z","end":"2026-07-02T10:07:56.089818Z","steps":["trace[991084672] 'agreement among raft nodes before linearized reading' (duration: 181.214693ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:56.089822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.371221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-07-02T10:07:56.089916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.162654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-02T10:07:56.089931Z","caller":"traceutil/trace.go:171","msg":"trace[1987766924] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4995; }","duration":"182.215345ms","start":"2026-07-02T10:07:55.907711Z","end":"2026-07-02T10:07:56.089926Z","steps":["trace[1987766924] 'agreement among raft nodes before linearized reading' (duration: 182.166424ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:56.089924Z","caller":"traceutil/trace.go:171","msg":"trace[1854997689] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4995; }","duration":"261.505082ms","start":"2026-07-02T10:07:55.828402Z","end":"2026-07-02T10:07:56.089907Z","steps":["trace[1854997689] 'agreement among raft nodes before linearized reading' (duration: 260.692602ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:56.231028Z","caller":"traceutil/trace.go:171","msg":"trace[1034382188] transaction","detail":"{read_only:false; response_revision:5002; number_of_response:1; }","duration":"133.88515ms","start":"2026-07-02T10:07:56.097097Z","end":"2026-07-02T10:07:56.230982Z","steps":["trace[1034382188] 'process raft request' (duration: 133.83272ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:56.23122Z","caller":"traceutil/trace.go:171","msg":"trace[1464138522] transaction","detail":"{read_only:false; response_revision:4997; number_of_response:1; }","duration":"136.719726ms","start":"2026-07-02T10:07:56.094479Z","end":"2026-07-02T10:07:56.231199Z","steps":["trace[1464138522] 'process raft request' (duration: 136.085547ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:56.231389Z","caller":"traceutil/trace.go:171","msg":"trace[731363819] transaction","detail":"{read_only:false; response_revision:4998; number_of_response:1; }","duration":"136.385641ms","start":"2026-07-02T10:07:56.094996Z","end":"2026-07-02T10:07:56.231381Z","steps":["trace[731363819] 'process raft request' (duration: 135.731053ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:56.231357Z","caller":"traceutil/trace.go:171","msg":"trace[283503901] transaction","detail":"{read_only:false; response_revision:5000; number_of_response:1; }","duration":"135.334578ms","start":"2026-07-02T10:07:56.095978Z","end":"2026-07-02T10:07:56.231312Z","steps":["trace[283503901] 'process raft request' (duration: 134.860603ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:56.231652Z","caller":"traceutil/trace.go:171","msg":"trace[1675472029] transaction","detail":"{read_only:false; response_revision:5001; number_of_response:1; }","duration":"135.225906ms","start":"2026-07-02T10:07:56.096419Z","end":"2026-07-02T10:07:56.231645Z","steps":["trace[1675472029] 'process raft request' (duration: 134.465837ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:56.231797Z","caller":"traceutil/trace.go:171","msg":"trace[1761013361] transaction","detail":"{read_only:false; response_revision:4999; number_of_response:1; }","duration":"135.918405ms","start":"2026-07-02T10:07:56.09587Z","end":"2026-07-02T10:07:56.231788Z","steps":["trace[1761013361] 'process raft request' (duration: 134.915533ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:56.771098Z","caller":"traceutil/trace.go:171","msg":"trace[380687513] transaction","detail":"{read_only:false; response_revision:5012; number_of_response:1; }","duration":"131.274517ms","start":"2026-07-02T10:07:56.639798Z","end":"2026-07-02T10:07:56.771072Z","steps":["trace[380687513] 'process raft request' (duration: 73.751106ms)","trace[380687513] 'compare' (duration: 57.353508ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:07:56.795542Z","caller":"traceutil/trace.go:171","msg":"trace[75965315] transaction","detail":"{read_only:false; response_revision:5013; number_of_response:1; }","duration":"155.273141ms","start":"2026-07-02T10:07:56.640237Z","end":"2026-07-02T10:07:56.79551Z","steps":["trace[75965315] 'process raft request' (duration: 154.908386ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:56.795975Z","caller":"traceutil/trace.go:171","msg":"trace[1480325646] transaction","detail":"{read_only:false; response_revision:5014; number_of_response:1; }","duration":"154.830455ms","start":"2026-07-02T10:07:56.641128Z","end":"2026-07-02T10:07:56.795959Z","steps":["trace[1480325646] 'process raft request' (duration: 154.631383ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:56.796107Z","caller":"traceutil/trace.go:171","msg":"trace[1968558530] linearizableReadLoop","detail":"{readStateIndex:5210; appliedIndex:5205; }","duration":"153.291195ms","start":"2026-07-02T10:07:56.642785Z","end":"2026-07-02T10:07:56.796076Z","steps":["trace[1968558530] 'read index received' (duration: 70.821288ms)","trace[1968558530] 'applied index is now lower than readState.Index' (duration: 82.468667ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:07:56.796173Z","caller":"traceutil/trace.go:171","msg":"trace[1767183807] transaction","detail":"{read_only:false; response_revision:5016; number_of_response:1; }","duration":"154.164186ms","start":"2026-07-02T10:07:56.641979Z","end":"2026-07-02T10:07:56.796143Z","steps":["trace[1767183807] 'process raft request' (duration: 153.961094ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:56.796433Z","caller":"traceutil/trace.go:171","msg":"trace[1057865277] transaction","detail":"{read_only:false; response_revision:5017; number_of_response:1; }","duration":"147.364181ms","start":"2026-07-02T10:07:56.649049Z","end":"2026-07-02T10:07:56.796413Z","steps":["trace[1057865277] 'process raft request' (duration: 146.954575ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:56.796809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.000245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-07-02T10:07:56.79685Z","caller":"traceutil/trace.go:171","msg":"trace[446604890] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5017; }","duration":"154.074986ms","start":"2026-07-02T10:07:56.642763Z","end":"2026-07-02T10:07:56.796838Z","steps":["trace[446604890] 'agreement among raft nodes before linearized reading' (duration: 153.921074ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:56.796452Z","caller":"traceutil/trace.go:171","msg":"trace[943401069] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"154.917747ms","start":"2026-07-02T10:07:56.641518Z","end":"2026-07-02T10:07:56.796435Z","steps":["trace[943401069] 'process raft request' (duration: 154.351769ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:08:48.384526Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2868} {"level":"info","ts":"2026-07-02T10:08:48.58816Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2868,"took":"201.885075ms","hash":1242881204,"current-db-size-bytes":52953088,"current-db-size":"53 MB","current-db-size-in-use-bytes":28401664,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-07-02T10:08:48.588779Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1242881204,"revision":2868,"compact-revision":-1} {"level":"info","ts":"2026-07-02T10:13:48.390684Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5411} {"level":"info","ts":"2026-07-02T10:13:48.474146Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5411,"took":"81.935529ms","hash":4038254257,"current-db-size-bytes":52953088,"current-db-size":"53 MB","current-db-size-in-use-bytes":18264064,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-02T10:13:48.474225Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4038254257,"revision":5411,"compact-revision":2868}