{"level":"warn","ts":"2026-08-11T07:36:13.76228Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T07:36:13.762387Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.77: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.204.45.77:2380","--initial-cluster=instance=https://199.204.45.77:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.77:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.77:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-11T07:36:13.762468Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T07:36:13.762488Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.77:2380"]} {"level":"info","ts":"2026-08-11T07:36:13.762511Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-11T07:36:13.763339Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"]} {"level":"info","ts":"2026-08-11T07:36:13.763669Z","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.204.45.77:2380"],"listen-peer-urls":["https://199.204.45.77:2380"],"advertise-client-urls":["https://199.204.45.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.77:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-11T07:36:13.768787Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.848118ms"} {"level":"info","ts":"2026-08-11T07:36:13.776717Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9133559b3198d4ec","cluster-id":"60f1aee33b0786f5"} {"level":"info","ts":"2026-08-11T07:36:13.776814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=()"} {"level":"info","ts":"2026-08-11T07:36:13.776839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became follower at term 0"} {"level":"info","ts":"2026-08-11T07:36:13.776859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9133559b3198d4ec [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-11T07:36:13.776881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became follower at term 1"} {"level":"info","ts":"2026-08-11T07:36:13.776931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=(10462800484352185580)"} {"level":"warn","ts":"2026-08-11T07:36:13.785484Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-11T07:36:13.787836Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-11T07:36:13.789623Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-11T07:36:13.793889Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9133559b3198d4ec","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-11T07:36:13.796546Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9133559b3198d4ec","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-11T07:36:13.800534Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-11T07:36:13.800753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=(10462800484352185580)"} {"level":"info","ts":"2026-08-11T07:36:13.800699Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-11T07:36:13.800897Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"60f1aee33b0786f5","local-member-id":"9133559b3198d4ec","added-peer-id":"9133559b3198d4ec","added-peer-peer-urls":["https://199.204.45.77:2380"]} {"level":"info","ts":"2026-08-11T07:36:13.800909Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-11T07:36:13.803469Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.77:2380"} {"level":"info","ts":"2026-08-11T07:36:13.803497Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.77:2380"} {"level":"info","ts":"2026-08-11T07:36:13.803046Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-11T07:36:13.805442Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9133559b3198d4ec","initial-advertise-peer-urls":["https://199.204.45.77:2380"],"listen-peer-urls":["https://199.204.45.77:2380"],"advertise-client-urls":["https://199.204.45.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-11T07:36:13.805487Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-11T07:36:14.577699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec is starting a new election at term 1"} {"level":"info","ts":"2026-08-11T07:36:14.577787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became pre-candidate at term 1"} {"level":"info","ts":"2026-08-11T07:36:14.57781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec received MsgPreVoteResp from 9133559b3198d4ec at term 1"} {"level":"info","ts":"2026-08-11T07:36:14.57783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became candidate at term 2"} {"level":"info","ts":"2026-08-11T07:36:14.577847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec received MsgVoteResp from 9133559b3198d4ec at term 2"} {"level":"info","ts":"2026-08-11T07:36:14.577867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became leader at term 2"} {"level":"info","ts":"2026-08-11T07:36:14.577886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9133559b3198d4ec elected leader 9133559b3198d4ec at term 2"} {"level":"info","ts":"2026-08-11T07:36:14.578904Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T07:36:14.579817Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9133559b3198d4ec","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.77:2379]}","request-path":"/0/members/9133559b3198d4ec/attributes","cluster-id":"60f1aee33b0786f5","publish-timeout":"7s"} {"level":"info","ts":"2026-08-11T07:36:14.579994Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T07:36:14.580041Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T07:36:14.5806Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"60f1aee33b0786f5","local-member-id":"9133559b3198d4ec","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T07:36:14.580736Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T07:36:14.58078Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T07:36:14.583399Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-11T07:36:14.583955Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.77:2379"} {"level":"info","ts":"2026-08-11T07:36:14.584042Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-11T07:36:14.584061Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-08-11T07:36:18.66986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.034056ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:36:18.670073Z","caller":"traceutil/trace.go:171","msg":"trace[1197409697] linearizableReadLoop","detail":"{readStateIndex:264; appliedIndex:263; }","duration":"635.960273ms","start":"2026-08-11T07:36:18.034097Z","end":"2026-08-11T07:36:18.670057Z","steps":["trace[1197409697] 'read index received' (duration: 197.437656ms)","trace[1197409697] 'applied index is now lower than readState.Index' (duration: 438.521366ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:36:18.670173Z","caller":"traceutil/trace.go:171","msg":"trace[1590580808] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"640.032363ms","start":"2026-08-11T07:36:18.030077Z","end":"2026-08-11T07:36:18.67011Z","steps":["trace[1590580808] 'process raft request' (duration: 201.497065ms)","trace[1590580808] 'compare' (duration: 436.867776ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:36:18.670293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.148753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-08-11T07:36:18.670359Z","caller":"traceutil/trace.go:171","msg":"trace[418346536] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:1; response_revision:258; }","duration":"636.286693ms","start":"2026-08-11T07:36:18.034061Z","end":"2026-08-11T07:36:18.670347Z","steps":["trace[418346536] 'agreement among raft nodes before linearized reading' (duration: 636.119722ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:36:18.670328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:36:18.03006Z","time spent":"640.201273ms","remote":"127.0.0.1:59070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":525,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T07:36:18.670456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:36:18.034045Z","time spent":"636.3959ms","remote":"127.0.0.1:59194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" "} {"level":"info","ts":"2026-08-11T07:36:19.220299Z","caller":"traceutil/trace.go:171","msg":"trace[1602047513] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"543.668631ms","start":"2026-08-11T07:36:18.676607Z","end":"2026-08-11T07:36:19.220275Z","steps":["trace[1602047513] 'process raft request' (duration: 543.535313ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:36:19.220428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:36:18.676581Z","time spent":"543.790308ms","remote":"127.0.0.1:59070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11436,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T07:36:19.220871Z","caller":"traceutil/trace.go:171","msg":"trace[603226413] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"542.991789ms","start":"2026-08-11T07:36:18.67786Z","end":"2026-08-11T07:36:19.220851Z","steps":["trace[603226413] 'process raft request' (duration: 542.918545ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:36:19.220951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:36:18.677851Z","time spent":"543.068453ms","remote":"127.0.0.1:59194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T07:36:49.89508Z","caller":"traceutil/trace.go:171","msg":"trace[86647388] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"148.557512ms","start":"2026-08-11T07:36:49.746498Z","end":"2026-08-11T07:36:49.895056Z","steps":["trace[86647388] 'process raft request' (duration: 148.286315ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:36:50.164012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.268196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-11T07:36:50.164127Z","caller":"traceutil/trace.go:171","msg":"trace[2107322560] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:519; }","duration":"160.423065ms","start":"2026-08-11T07:36:50.003688Z","end":"2026-08-11T07:36:50.164111Z","steps":["trace[2107322560] 'range keys from in-memory index tree' (duration: 160.17192ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:36:50.989385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.945321ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:36:50.989526Z","caller":"traceutil/trace.go:171","msg":"trace[94508164] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"286.055468ms","start":"2026-08-11T07:36:50.703448Z","end":"2026-08-11T07:36:50.989503Z","steps":["trace[94508164] 'process raft request' (duration: 123.721722ms)","trace[94508164] 'compare' (duration: 161.623331ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:36:51.394439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.485395ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:36:51.39454Z","caller":"traceutil/trace.go:171","msg":"trace[1358476329] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"679.399177ms","start":"2026-08-11T07:36:50.715126Z","end":"2026-08-11T07:36:51.394525Z","steps":["trace[1358476329] 'process raft request' (duration: 549.766263ms)","trace[1358476329] 'compare' (duration: 129.341155ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:36:51.394592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:36:50.715109Z","time spent":"679.459791ms","remote":"127.0.0.1:59022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74745,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:36:51.396319Z","caller":"traceutil/trace.go:171","msg":"trace[1442559120] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"377.599205ms","start":"2026-08-11T07:36:51.018708Z","end":"2026-08-11T07:36:51.396307Z","steps":["trace[1442559120] 'process raft request' (duration: 377.530861ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:36:51.39638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:36:51.018691Z","time spent":"377.660349ms","remote":"127.0.0.1:59022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:36:51.39684Z","caller":"traceutil/trace.go:171","msg":"trace[1664984370] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"435.710506ms","start":"2026-08-11T07:36:50.961121Z","end":"2026-08-11T07:36:51.396831Z","steps":["trace[1664984370] 'process raft request' (duration: 434.847533ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:36:51.39688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:36:50.961093Z","time spent":"435.7691ms","remote":"127.0.0.1:59022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T07:36:56.441269Z","caller":"traceutil/trace.go:171","msg":"trace[1245617852] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"105.544986ms","start":"2026-08-11T07:36:56.335704Z","end":"2026-08-11T07:36:56.441249Z","steps":["trace[1245617852] 'process raft request' (duration: 100.146898ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:36:56.817774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.917421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:36:56.817874Z","caller":"traceutil/trace.go:171","msg":"trace[1768085789] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"246.06459ms","start":"2026-08-11T07:36:56.571787Z","end":"2026-08-11T07:36:56.817852Z","steps":["trace[1768085789] 'range keys from in-memory index tree' (duration: 245.825555ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:36:56.849578Z","caller":"traceutil/trace.go:171","msg":"trace[1651275503] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"258.515881ms","start":"2026-08-11T07:36:56.591032Z","end":"2026-08-11T07:36:56.849548Z","steps":["trace[1651275503] 'process raft request' (duration: 257.256932ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:36:57.715098Z","caller":"traceutil/trace.go:171","msg":"trace[1531886226] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:653; }","duration":"248.619164ms","start":"2026-08-11T07:36:57.466449Z","end":"2026-08-11T07:36:57.715068Z","steps":["trace[1531886226] 'read index received' (duration: 175.08596ms)","trace[1531886226] 'applied index is now lower than readState.Index' (duration: 73.531264ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:36:57.715263Z","caller":"traceutil/trace.go:171","msg":"trace[1033052230] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"807.585855ms","start":"2026-08-11T07:36:56.907617Z","end":"2026-08-11T07:36:57.715203Z","steps":["trace[1033052230] 'process raft request' (duration: 733.834878ms)","trace[1033052230] 'compare' (duration: 73.345712ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:36:57.715413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:36:56.907589Z","time spent":"807.754276ms","remote":"127.0.0.1:59524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-11T07:36:57.715584Z","caller":"traceutil/trace.go:171","msg":"trace[71996357] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"782.493954ms","start":"2026-08-11T07:36:56.933057Z","end":"2026-08-11T07:36:57.715551Z","steps":["trace[71996357] 'process raft request' (duration: 781.94103ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:36:57.715657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.19818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.77\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-11T07:36:57.71572Z","caller":"traceutil/trace.go:171","msg":"trace[227858098] range","detail":"{range_begin:/registry/masterleases/199.204.45.77; range_end:; response_count:1; response_revision:630; }","duration":"249.310968ms","start":"2026-08-11T07:36:57.466394Z","end":"2026-08-11T07:36:57.715705Z","steps":["trace[227858098] 'agreement among raft nodes before linearized reading' (duration: 249.137547ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:36:57.715754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:36:56.933031Z","time spent":"782.629013ms","remote":"127.0.0.1:59260","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-08-11T07:36:58.227262Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15342813882613814906,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T07:36:58.47208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.500273ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-08-11T07:36:58.472375Z","caller":"traceutil/trace.go:171","msg":"trace[177371772] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:655; }","duration":"745.325325ms","start":"2026-08-11T07:36:57.72703Z","end":"2026-08-11T07:36:58.472355Z","steps":["trace[177371772] 'read index received' (duration: 606.63919ms)","trace[177371772] 'applied index is now lower than readState.Index' (duration: 138.685255ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:36:58.472486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:36:57.71719Z","time spent":"755.291629ms","remote":"127.0.0.1:59000","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-08-11T07:36:58.472863Z","caller":"traceutil/trace.go:171","msg":"trace[1381005252] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"752.475712ms","start":"2026-08-11T07:36:57.720373Z","end":"2026-08-11T07:36:58.472849Z","steps":["trace[1381005252] 'process raft request' (duration: 751.823512ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:36:58.472971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:36:57.72035Z","time spent":"752.555227ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:36:58.473116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.05856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:36:58.473261Z","caller":"traceutil/trace.go:171","msg":"trace[152480818] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:631; }","duration":"746.259623ms","start":"2026-08-11T07:36:57.726975Z","end":"2026-08-11T07:36:58.473235Z","steps":["trace[152480818] 'agreement among raft nodes before linearized reading' (duration: 746.05242ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:36:58.47335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:36:57.726962Z","time spent":"746.36833ms","remote":"127.0.0.1:59236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-08-11T07:36:58.47363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.608599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-11T07:36:58.473682Z","caller":"traceutil/trace.go:171","msg":"trace[496657085] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:631; }","duration":"150.700375ms","start":"2026-08-11T07:36:58.32297Z","end":"2026-08-11T07:36:58.47367Z","steps":["trace[496657085] 'agreement among raft nodes before linearized reading' (duration: 150.542926ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:36:58.473627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.436351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-11T07:36:58.473811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.842731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-11T07:36:58.473896Z","caller":"traceutil/trace.go:171","msg":"trace[140470498] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:631; }","duration":"202.98616ms","start":"2026-08-11T07:36:58.270889Z","end":"2026-08-11T07:36:58.473875Z","steps":["trace[140470498] 'agreement among raft nodes before linearized reading' (duration: 202.767266ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:36:58.473858Z","caller":"traceutil/trace.go:171","msg":"trace[1821292763] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:631; }","duration":"545.728039ms","start":"2026-08-11T07:36:57.928085Z","end":"2026-08-11T07:36:58.473813Z","steps":["trace[1821292763] 'agreement among raft nodes before linearized reading' (duration: 545.014835ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:36:58.474056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:36:57.928063Z","time spent":"545.976565ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-11T07:37:02.511992Z","caller":"traceutil/trace.go:171","msg":"trace[2030924378] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"115.138635ms","start":"2026-08-11T07:37:02.396791Z","end":"2026-08-11T07:37:02.51193Z","steps":["trace[2030924378] 'process raft request' (duration: 75.467139ms)","trace[2030924378] 'compare' (duration: 39.375058ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:37:03.999143Z","caller":"traceutil/trace.go:171","msg":"trace[1788793112] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"382.553397ms","start":"2026-08-11T07:37:03.616571Z","end":"2026-08-11T07:37:03.999124Z","steps":["trace[1788793112] 'process raft request' (duration: 382.362875ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:37:03.999271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:37:03.61655Z","time spent":"382.652843ms","remote":"127.0.0.1:59022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4318,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:37:04.003206Z","caller":"traceutil/trace.go:171","msg":"trace[2095858554] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"289.58162ms","start":"2026-08-11T07:37:03.713597Z","end":"2026-08-11T07:37:04.003178Z","steps":["trace[2095858554] 'process raft request' (duration: 289.220577ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:04.501586Z","caller":"traceutil/trace.go:171","msg":"trace[668580640] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"110.07727ms","start":"2026-08-11T07:37:04.39148Z","end":"2026-08-11T07:37:04.501558Z","steps":["trace[668580640] 'process raft request' (duration: 109.886018ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:04.671467Z","caller":"traceutil/trace.go:171","msg":"trace[337056447] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"120.065757ms","start":"2026-08-11T07:37:04.551381Z","end":"2026-08-11T07:37:04.671446Z","steps":["trace[337056447] 'process raft request' (duration: 48.771067ms)","trace[337056447] 'compare' (duration: 71.115508ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:37:04.671531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.856806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:37:04.671621Z","caller":"traceutil/trace.go:171","msg":"trace[1016608890] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:703; }","duration":"101.992874ms","start":"2026-08-11T07:37:04.569608Z","end":"2026-08-11T07:37:04.671601Z","steps":["trace[1016608890] 'agreement among raft nodes before linearized reading' (duration: 101.787741ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:04.709686Z","caller":"traceutil/trace.go:171","msg":"trace[1902149762] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"133.563982ms","start":"2026-08-11T07:37:04.576099Z","end":"2026-08-11T07:37:04.709663Z","steps":["trace[1902149762] 'process raft request' (duration: 133.014967ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:04.710143Z","caller":"traceutil/trace.go:171","msg":"trace[1307053701] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"132.649546ms","start":"2026-08-11T07:37:04.577481Z","end":"2026-08-11T07:37:04.710131Z","steps":["trace[1307053701] 'process raft request' (duration: 132.445322ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:04.710282Z","caller":"traceutil/trace.go:171","msg":"trace[716258404] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"134.096996ms","start":"2026-08-11T07:37:04.576173Z","end":"2026-08-11T07:37:04.71027Z","steps":["trace[716258404] 'process raft request' (duration: 133.603185ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:04.710119Z","caller":"traceutil/trace.go:171","msg":"trace[1336004037] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"131.134401ms","start":"2026-08-11T07:37:04.578936Z","end":"2026-08-11T07:37:04.71007Z","steps":["trace[1336004037] 'process raft request' (duration: 131.037965ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:04.797271Z","caller":"traceutil/trace.go:171","msg":"trace[1607904282] linearizableReadLoop","detail":"{readStateIndex:735; appliedIndex:730; }","duration":"124.459203ms","start":"2026-08-11T07:37:04.672792Z","end":"2026-08-11T07:37:04.797251Z","steps":["trace[1607904282] 'read index received' (duration: 36.326398ms)","trace[1607904282] 'applied index is now lower than readState.Index' (duration: 88.131855ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:37:04.797315Z","caller":"traceutil/trace.go:171","msg":"trace[2085648245] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"127.829414ms","start":"2026-08-11T07:37:04.669456Z","end":"2026-08-11T07:37:04.797286Z","steps":["trace[2085648245] 'process raft request' (duration: 103.655138ms)","trace[2085648245] 'compare' (duration: 24.024356ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:37:04.797434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.622553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:37:04.797474Z","caller":"traceutil/trace.go:171","msg":"trace[975125898] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:708; }","duration":"124.706498ms","start":"2026-08-11T07:37:04.672757Z","end":"2026-08-11T07:37:04.797463Z","steps":["trace[975125898] 'agreement among raft nodes before linearized reading' (duration: 124.610992ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:12.880143Z","caller":"traceutil/trace.go:171","msg":"trace[989193126] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"136.152576ms","start":"2026-08-11T07:37:12.743965Z","end":"2026-08-11T07:37:12.880118Z","steps":["trace[989193126] 'read index received' (duration: 136.032628ms)","trace[989193126] 'applied index is now lower than readState.Index' (duration: 118.528µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:37:12.880238Z","caller":"traceutil/trace.go:171","msg":"trace[232819958] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"174.905467ms","start":"2026-08-11T07:37:12.705302Z","end":"2026-08-11T07:37:12.880208Z","steps":["trace[232819958] 'process raft request' (duration: 174.661612ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:37:12.880487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.791171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-11T07:37:12.88049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.746572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-11T07:37:12.880485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.495986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T07:37:12.880534Z","caller":"traceutil/trace.go:171","msg":"trace[273740810] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:781; }","duration":"127.884586ms","start":"2026-08-11T07:37:12.752637Z","end":"2026-08-11T07:37:12.880521Z","steps":["trace[273740810] 'agreement among raft nodes before linearized reading' (duration: 127.717195ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:12.880543Z","caller":"traceutil/trace.go:171","msg":"trace[2019292923] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:781; }","duration":"129.841019ms","start":"2026-08-11T07:37:12.75069Z","end":"2026-08-11T07:37:12.880531Z","steps":["trace[2019292923] 'agreement among raft nodes before linearized reading' (duration: 129.663977ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:12.880565Z","caller":"traceutil/trace.go:171","msg":"trace[1587405493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:781; }","duration":"136.630085ms","start":"2026-08-11T07:37:12.743915Z","end":"2026-08-11T07:37:12.880545Z","steps":["trace[1587405493] 'agreement among raft nodes before linearized reading' (duration: 136.38249ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:37:16.298298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.781162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-11T07:37:16.29837Z","caller":"traceutil/trace.go:171","msg":"trace[1419825100] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:798; }","duration":"686.908291ms","start":"2026-08-11T07:37:15.611445Z","end":"2026-08-11T07:37:16.298353Z","steps":["trace[1419825100] 'range keys from in-memory index tree' (duration: 686.587511ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:37:16.298409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:37:15.611421Z","time spent":"686.978985ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-11T07:37:33.974533Z","caller":"traceutil/trace.go:171","msg":"trace[425574640] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"201.149462ms","start":"2026-08-11T07:37:33.773339Z","end":"2026-08-11T07:37:33.974488Z","steps":["trace[425574640] 'process raft request' (duration: 200.781073ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:37:45.360038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.592631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T07:37:45.360144Z","caller":"traceutil/trace.go:171","msg":"trace[122175112] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1200; }","duration":"110.767884ms","start":"2026-08-11T07:37:45.249359Z","end":"2026-08-11T07:37:45.360127Z","steps":["trace[122175112] 'count revisions from in-memory index tree' (duration: 110.497825ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:37:45.706606Z","caller":"traceutil/trace.go:171","msg":"trace[1737770244] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"118.747711ms","start":"2026-08-11T07:37:45.58783Z","end":"2026-08-11T07:37:45.706578Z","steps":["trace[1737770244] 'process raft request' (duration: 118.583568ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:38:03.23002Z","caller":"traceutil/trace.go:171","msg":"trace[1166826802] transaction","detail":"{read_only:false; response_revision:1343; number_of_response:1; }","duration":"113.4831ms","start":"2026-08-11T07:38:03.116507Z","end":"2026-08-11T07:38:03.22999Z","steps":["trace[1166826802] 'process raft request' (duration: 113.086377ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:38:08.754327Z","caller":"traceutil/trace.go:171","msg":"trace[722207485] transaction","detail":"{read_only:false; response_revision:1459; number_of_response:1; }","duration":"167.076688ms","start":"2026-08-11T07:38:08.587229Z","end":"2026-08-11T07:38:08.754305Z","steps":["trace[722207485] 'process raft request' (duration: 166.96196ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:38:08.754368Z","caller":"traceutil/trace.go:171","msg":"trace[634895992] linearizableReadLoop","detail":"{readStateIndex:1505; appliedIndex:1505; }","duration":"130.239728ms","start":"2026-08-11T07:38:08.624104Z","end":"2026-08-11T07:38:08.754344Z","steps":["trace[634895992] 'read index received' (duration: 130.227738ms)","trace[634895992] 'applied index is now lower than readState.Index' (duration: 10.02µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:38:08.754628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.492794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-patch-pmc7b\" ","response":"range_response_count:1 size:4178"} {"level":"info","ts":"2026-08-11T07:38:08.754692Z","caller":"traceutil/trace.go:171","msg":"trace[397201844] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-patch-pmc7b; range_end:; response_count:1; response_revision:1459; }","duration":"130.615242ms","start":"2026-08-11T07:38:08.624059Z","end":"2026-08-11T07:38:08.754675Z","steps":["trace[397201844] 'agreement among raft nodes before linearized reading' (duration: 130.405665ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:38:08.755541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.730646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:38:08.755717Z","caller":"traceutil/trace.go:171","msg":"trace[2006857270] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"103.645167ms","start":"2026-08-11T07:38:08.652048Z","end":"2026-08-11T07:38:08.755693Z","steps":["trace[2006857270] 'process raft request' (duration: 103.234771ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:38:08.75563Z","caller":"traceutil/trace.go:171","msg":"trace[1032006790] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1460; }","duration":"110.855535ms","start":"2026-08-11T07:38:08.644753Z","end":"2026-08-11T07:38:08.755609Z","steps":["trace[1032006790] 'agreement among raft nodes before linearized reading' (duration: 110.635217ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:38:09.950361Z","caller":"traceutil/trace.go:171","msg":"trace[1154795777] transaction","detail":"{read_only:false; response_revision:1467; number_of_response:1; }","duration":"164.262579ms","start":"2026-08-11T07:38:09.786065Z","end":"2026-08-11T07:38:09.950328Z","steps":["trace[1154795777] 'process raft request' (duration: 164.082331ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:38:33.618835Z","caller":"traceutil/trace.go:171","msg":"trace[680019533] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"232.744078ms","start":"2026-08-11T07:38:33.386064Z","end":"2026-08-11T07:38:33.618808Z","steps":["trace[680019533] 'process raft request' (duration: 232.567107ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:38:33.747121Z","caller":"traceutil/trace.go:171","msg":"trace[2041512212] linearizableReadLoop","detail":"{readStateIndex:1947; appliedIndex:1944; }","duration":"354.404129ms","start":"2026-08-11T07:38:33.392691Z","end":"2026-08-11T07:38:33.747096Z","steps":["trace[2041512212] 'read index received' (duration: 226.057472ms)","trace[2041512212] 'applied index is now lower than readState.Index' (duration: 128.345527ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:38:33.747163Z","caller":"traceutil/trace.go:171","msg":"trace[2073898429] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"360.477402ms","start":"2026-08-11T07:38:33.386648Z","end":"2026-08-11T07:38:33.747125Z","steps":["trace[2073898429] 'process raft request' (duration: 360.18919ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:38:33.747163Z","caller":"traceutil/trace.go:171","msg":"trace[86288758] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"360.26285ms","start":"2026-08-11T07:38:33.386879Z","end":"2026-08-11T07:38:33.747142Z","steps":["trace[86288758] 'process raft request' (duration: 360.158199ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:38:33.747372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:38:33.386634Z","time spent":"360.645693ms","remote":"127.0.0.1:59260","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-08-11T07:38:33.747383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.640951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-11T07:38:33.74742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:38:33.386864Z","time spent":"360.445421ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:38:33.747428Z","caller":"traceutil/trace.go:171","msg":"trace[1687895795] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1874; }","duration":"354.778782ms","start":"2026-08-11T07:38:33.392637Z","end":"2026-08-11T07:38:33.747415Z","steps":["trace[1687895795] 'agreement among raft nodes before linearized reading' (duration: 354.562541ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:38:33.747621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:38:33.392622Z","time spent":"354.986004ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-11T07:38:33.747623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.407734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-08-11T07:38:33.747707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.906776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-158e6454-2382-495e-b664-b1129cf19944\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-08-11T07:38:33.747772Z","caller":"traceutil/trace.go:171","msg":"trace[1388905619] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-158e6454-2382-495e-b664-b1129cf19944; range_end:; response_count:1; response_revision:1874; }","duration":"275.989737ms","start":"2026-08-11T07:38:33.471765Z","end":"2026-08-11T07:38:33.747754Z","steps":["trace[1388905619] 'agreement among raft nodes before linearized reading' (duration: 275.817476ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:38:33.747745Z","caller":"traceutil/trace.go:171","msg":"trace[105161734] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1874; }","duration":"333.566945ms","start":"2026-08-11T07:38:33.41416Z","end":"2026-08-11T07:38:33.747727Z","steps":["trace[105161734] 'agreement among raft nodes before linearized reading' (duration: 333.207863ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:38:33.747877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:38:33.414146Z","time spent":"333.718116ms","remote":"127.0.0.1:58768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-08-11T07:38:33.747923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.84792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T07:38:33.747941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.729296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:38:33.747978Z","caller":"traceutil/trace.go:171","msg":"trace[725804117] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1874; }","duration":"306.93524ms","start":"2026-08-11T07:38:33.441027Z","end":"2026-08-11T07:38:33.747962Z","steps":["trace[725804117] 'agreement among raft nodes before linearized reading' (duration: 306.86085ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:38:33.748023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:38:33.441009Z","time spent":"307.003781ms","remote":"127.0.0.1:58934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-11T07:38:33.748012Z","caller":"traceutil/trace.go:171","msg":"trace[1066250543] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1874; }","duration":"178.834746ms","start":"2026-08-11T07:38:33.569166Z","end":"2026-08-11T07:38:33.748001Z","steps":["trace[1066250543] 'agreement among raft nodes before linearized reading' (duration: 178.741546ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:38:33.74768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.763769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T07:38:33.748236Z","caller":"traceutil/trace.go:171","msg":"trace[2141824059] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1874; }","duration":"288.318233ms","start":"2026-08-11T07:38:33.459903Z","end":"2026-08-11T07:38:33.748221Z","steps":["trace[2141824059] 'agreement among raft nodes before linearized reading' (duration: 287.701149ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:38:34.170832Z","caller":"traceutil/trace.go:171","msg":"trace[1939641908] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"415.340398ms","start":"2026-08-11T07:38:33.755466Z","end":"2026-08-11T07:38:34.170807Z","steps":["trace[1939641908] 'process raft request' (duration: 415.187277ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:38:34.17098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:38:33.755445Z","time spent":"415.457819ms","remote":"127.0.0.1:59168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:38:34.350429Z","caller":"traceutil/trace.go:171","msg":"trace[484485485] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"183.567585ms","start":"2026-08-11T07:38:34.166837Z","end":"2026-08-11T07:38:34.350405Z","steps":["trace[484485485] 'process raft request' (duration: 183.216712ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:38:34.35042Z","caller":"traceutil/trace.go:171","msg":"trace[1326881695] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"321.888869ms","start":"2026-08-11T07:38:34.028501Z","end":"2026-08-11T07:38:34.35039Z","steps":["trace[1326881695] 'process raft request' (duration: 270.570253ms)","trace[1326881695] 'compare' (duration: 50.867303ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:38:34.350684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:38:34.028475Z","time spent":"322.112031ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:38:48.319452Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15342813882613817563,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-11T07:38:48.445527Z","caller":"traceutil/trace.go:171","msg":"trace[948953550] transaction","detail":"{read_only:false; response_revision:1991; number_of_response:1; }","duration":"764.832592ms","start":"2026-08-11T07:38:47.680667Z","end":"2026-08-11T07:38:48.445499Z","steps":["trace[948953550] 'process raft request' (duration: 764.68521ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:38:48.445578Z","caller":"traceutil/trace.go:171","msg":"trace[1431972973] linearizableReadLoop","detail":"{readStateIndex:2068; appliedIndex:2068; }","duration":"626.129705ms","start":"2026-08-11T07:38:47.819417Z","end":"2026-08-11T07:38:48.445547Z","steps":["trace[1431972973] 'read index received' (duration: 626.097135ms)","trace[1431972973] 'applied index is now lower than readState.Index' (duration: 30.38µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:38:48.445694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:38:47.680655Z","time spent":"764.951764ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:38:48.446054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.584902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T07:38:48.446173Z","caller":"traceutil/trace.go:171","msg":"trace[33406827] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1991; }","duration":"626.766504ms","start":"2026-08-11T07:38:47.819379Z","end":"2026-08-11T07:38:48.446146Z","steps":["trace[33406827] 'agreement among raft nodes before linearized reading' (duration: 626.343698ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:38:48.446232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:38:47.81936Z","time spent":"626.862356ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-11T07:38:48.481435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.59446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-11T07:38:48.481485Z","caller":"traceutil/trace.go:171","msg":"trace[1891302499] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1993; }","duration":"626.686742ms","start":"2026-08-11T07:38:47.854784Z","end":"2026-08-11T07:38:48.481471Z","steps":["trace[1891302499] 'agreement among raft nodes before linearized reading' (duration: 626.56086ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:38:48.481476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.187195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-08-11T07:38:48.481507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:38:47.854765Z","time spent":"626.737813ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-11T07:38:48.481527Z","caller":"traceutil/trace.go:171","msg":"trace[642923779] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1993; }","duration":"642.272696ms","start":"2026-08-11T07:38:47.839238Z","end":"2026-08-11T07:38:48.481511Z","steps":["trace[642923779] 'agreement among raft nodes before linearized reading' (duration: 642.133554ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:38:48.481589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:38:47.839217Z","time spent":"642.362398ms","remote":"127.0.0.1:58768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-08-11T07:38:48.481908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.449368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-11T07:38:48.481955Z","caller":"traceutil/trace.go:171","msg":"trace[173194772] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1993; }","duration":"662.535859ms","start":"2026-08-11T07:38:47.819409Z","end":"2026-08-11T07:38:48.481945Z","steps":["trace[173194772] 'agreement among raft nodes before linearized reading' (duration: 661.868679ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:38:48.481984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:38:47.819388Z","time spent":"662.5901ms","remote":"127.0.0.1:59260","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":"warn","ts":"2026-08-11T07:38:48.48173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.583328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:38:48.482139Z","caller":"traceutil/trace.go:171","msg":"trace[1629708748] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1993; }","duration":"357.959234ms","start":"2026-08-11T07:38:48.124112Z","end":"2026-08-11T07:38:48.482071Z","steps":["trace[1629708748] 'agreement among raft nodes before linearized reading' (duration: 357.216133ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:38:48.482209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:38:48.124066Z","time spent":"358.129547ms","remote":"127.0.0.1:48658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-08-11T07:38:59.262956Z","caller":"traceutil/trace.go:171","msg":"trace[1406911711] transaction","detail":"{read_only:false; response_revision:2067; number_of_response:1; }","duration":"340.633245ms","start":"2026-08-11T07:38:58.922296Z","end":"2026-08-11T07:38:59.26293Z","steps":["trace[1406911711] 'process raft request' (duration: 340.426031ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:38:59.263203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:38:58.922272Z","time spent":"340.790069ms","remote":"127.0.0.1:59168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11650,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:38:59.265489Z","caller":"traceutil/trace.go:171","msg":"trace[1158426866] linearizableReadLoop","detail":"{readStateIndex:2147; appliedIndex:2145; }","duration":"233.215307ms","start":"2026-08-11T07:38:59.032254Z","end":"2026-08-11T07:38:59.265469Z","steps":["trace[1158426866] 'read index received' (duration: 230.394818ms)","trace[1158426866] 'applied index is now lower than readState.Index' (duration: 2.818509ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:38:59.265531Z","caller":"traceutil/trace.go:171","msg":"trace[1498683975] transaction","detail":"{read_only:false; response_revision:2068; number_of_response:1; }","duration":"289.627418ms","start":"2026-08-11T07:38:58.975846Z","end":"2026-08-11T07:38:59.265474Z","steps":["trace[1498683975] 'process raft request' (duration: 288.023445ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:38:59.265577Z","caller":"traceutil/trace.go:171","msg":"trace[1706532749] transaction","detail":"{read_only:false; response_revision:2069; number_of_response:1; }","duration":"166.545262ms","start":"2026-08-11T07:38:59.09901Z","end":"2026-08-11T07:38:59.265555Z","steps":["trace[1706532749] 'process raft request' (duration: 166.259687ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:38:59.267179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.233079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T07:38:59.2676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.573504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-11T07:38:59.267646Z","caller":"traceutil/trace.go:171","msg":"trace[631063310] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:2069; }","duration":"106.127477ms","start":"2026-08-11T07:38:59.161497Z","end":"2026-08-11T07:38:59.267624Z","steps":["trace[631063310] 'agreement among raft nodes before linearized reading' (duration: 105.217879ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:38:59.267692Z","caller":"traceutil/trace.go:171","msg":"trace[6991245] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2069; }","duration":"235.487393ms","start":"2026-08-11T07:38:59.03219Z","end":"2026-08-11T07:38:59.267677Z","steps":["trace[6991245] 'agreement among raft nodes before linearized reading' (duration: 233.428231ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:00.208258Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15342813882613817727,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-11T07:39:00.365558Z","caller":"traceutil/trace.go:171","msg":"trace[1439799402] linearizableReadLoop","detail":"{readStateIndex:2150; appliedIndex:2149; }","duration":"657.334862ms","start":"2026-08-11T07:38:59.708195Z","end":"2026-08-11T07:39:00.36553Z","steps":["trace[1439799402] 'read index received' (duration: 657.095027ms)","trace[1439799402] 'applied index is now lower than readState.Index' (duration: 238.605µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:39:00.365657Z","caller":"traceutil/trace.go:171","msg":"trace[1629535036] transaction","detail":"{read_only:false; response_revision:2071; number_of_response:1; }","duration":"723.837442ms","start":"2026-08-11T07:38:59.641788Z","end":"2026-08-11T07:39:00.365626Z","steps":["trace[1629535036] 'process raft request' (duration: 723.562696ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:00.365814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.600337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T07:39:00.365915Z","caller":"traceutil/trace.go:171","msg":"trace[537688143] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:2071; }","duration":"657.695289ms","start":"2026-08-11T07:38:59.708179Z","end":"2026-08-11T07:39:00.365874Z","steps":["trace[537688143] 'agreement among raft nodes before linearized reading' (duration: 657.501835ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:00.365964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:38:59.708133Z","time spent":"657.818862ms","remote":"127.0.0.1:59078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":24,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-08-11T07:39:00.366012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:38:59.641769Z","time spent":"724.081167ms","remote":"127.0.0.1:59260","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-08-11T07:39:00.65472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.976084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-11T07:39:00.654824Z","caller":"traceutil/trace.go:171","msg":"trace[1753844099] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2071; }","duration":"159.142057ms","start":"2026-08-11T07:39:00.495646Z","end":"2026-08-11T07:39:00.654788Z","steps":["trace[1753844099] 'range keys from in-memory index tree' (duration: 158.762129ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:00.724019Z","caller":"traceutil/trace.go:171","msg":"trace[1936850536] transaction","detail":"{read_only:false; response_revision:2072; number_of_response:1; }","duration":"201.261433ms","start":"2026-08-11T07:39:00.522714Z","end":"2026-08-11T07:39:00.723976Z","steps":["trace[1936850536] 'process raft request' (duration: 201.025328ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:00.736777Z","caller":"traceutil/trace.go:171","msg":"trace[362600758] linearizableReadLoop","detail":"{readStateIndex:2152; appliedIndex:2150; }","duration":"194.830967ms","start":"2026-08-11T07:39:00.541924Z","end":"2026-08-11T07:39:00.736755Z","steps":["trace[362600758] 'read index received' (duration: 181.792413ms)","trace[362600758] 'applied index is now lower than readState.Index' (duration: 13.037874ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:39:00.736956Z","caller":"traceutil/trace.go:171","msg":"trace[104622280] transaction","detail":"{read_only:false; response_revision:2073; number_of_response:1; }","duration":"213.267835ms","start":"2026-08-11T07:39:00.523674Z","end":"2026-08-11T07:39:00.736942Z","steps":["trace[104622280] 'process raft request' (duration: 212.867387ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:00.73728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.331159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-11T07:39:00.737321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.064647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-11T07:39:00.73735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.103996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:39:00.737373Z","caller":"traceutil/trace.go:171","msg":"trace[1861839087] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2075; }","duration":"195.484002ms","start":"2026-08-11T07:39:00.541864Z","end":"2026-08-11T07:39:00.737348Z","steps":["trace[1861839087] 'agreement among raft nodes before linearized reading' (duration: 195.106994ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:00.737391Z","caller":"traceutil/trace.go:171","msg":"trace[1250390163] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2075; }","duration":"189.20956ms","start":"2026-08-11T07:39:00.548164Z","end":"2026-08-11T07:39:00.737373Z","steps":["trace[1250390163] 'agreement among raft nodes before linearized reading' (duration: 188.937204ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:00.737435Z","caller":"traceutil/trace.go:171","msg":"trace[821100066] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2075; }","duration":"168.166677ms","start":"2026-08-11T07:39:00.569218Z","end":"2026-08-11T07:39:00.737385Z","steps":["trace[821100066] 'agreement among raft nodes before linearized reading' (duration: 168.117696ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:00.737313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.154111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-11T07:39:00.737575Z","caller":"traceutil/trace.go:171","msg":"trace[658164181] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2075; }","duration":"182.452327ms","start":"2026-08-11T07:39:00.555112Z","end":"2026-08-11T07:39:00.737565Z","steps":["trace[658164181] 'agreement among raft nodes before linearized reading' (duration: 182.093889ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:00.737777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.350291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-11T07:39:00.737947Z","caller":"traceutil/trace.go:171","msg":"trace[336690213] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2075; }","duration":"187.496194ms","start":"2026-08-11T07:39:00.550371Z","end":"2026-08-11T07:39:00.737867Z","steps":["trace[336690213] 'agreement among raft nodes before linearized reading' (duration: 186.862231ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:05.510935Z","caller":"traceutil/trace.go:171","msg":"trace[1436959974] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"164.227995ms","start":"2026-08-11T07:39:05.346674Z","end":"2026-08-11T07:39:05.510902Z","steps":["trace[1436959974] 'process raft request' (duration: 73.073304ms)","trace[1436959974] 'compare' (duration: 91.031329ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:39:05.884848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.874265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-11T07:39:05.884915Z","caller":"traceutil/trace.go:171","msg":"trace[1672443046] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2105; }","duration":"110.990518ms","start":"2026-08-11T07:39:05.773906Z","end":"2026-08-11T07:39:05.884896Z","steps":["trace[1672443046] 'range keys from in-memory index tree' (duration: 110.694931ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:07.13277Z","caller":"traceutil/trace.go:171","msg":"trace[138710660] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"288.944612ms","start":"2026-08-11T07:39:06.843771Z","end":"2026-08-11T07:39:07.132716Z","steps":["trace[138710660] 'process raft request' (duration: 242.490635ms)","trace[138710660] 'compare' (duration: 46.318133ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:39:07.133027Z","caller":"traceutil/trace.go:171","msg":"trace[927877077] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"288.457099ms","start":"2026-08-11T07:39:06.844535Z","end":"2026-08-11T07:39:07.132992Z","steps":["trace[927877077] 'process raft request' (duration: 288.144482ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:07.133221Z","caller":"traceutil/trace.go:171","msg":"trace[478490457] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"287.895567ms","start":"2026-08-11T07:39:06.845313Z","end":"2026-08-11T07:39:07.133209Z","steps":["trace[478490457] 'process raft request' (duration: 287.60323ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:07.169674Z","caller":"traceutil/trace.go:171","msg":"trace[1313647428] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"312.971788ms","start":"2026-08-11T07:39:06.856641Z","end":"2026-08-11T07:39:07.169612Z","steps":["trace[1313647428] 'process raft request' (duration: 312.770083ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:07.169866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:39:06.856627Z","time spent":"313.131842ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:39:07.170072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.249774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-11T07:39:07.170139Z","caller":"traceutil/trace.go:171","msg":"trace[2035989682] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2115; }","duration":"278.364397ms","start":"2026-08-11T07:39:06.891758Z","end":"2026-08-11T07:39:07.170122Z","steps":["trace[2035989682] 'agreement among raft nodes before linearized reading' (duration: 277.930677ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:07.169632Z","caller":"traceutil/trace.go:171","msg":"trace[55212680] linearizableReadLoop","detail":"{readStateIndex:2195; appliedIndex:2191; }","duration":"277.772023ms","start":"2026-08-11T07:39:06.891796Z","end":"2026-08-11T07:39:07.169568Z","steps":["trace[55212680] 'read index received' (duration: 194.843788ms)","trace[55212680] 'applied index is now lower than readState.Index' (duration: 82.926885ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:39:07.649566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.323257ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:39:07.649665Z","caller":"traceutil/trace.go:171","msg":"trace[1118509200] linearizableReadLoop","detail":"{readStateIndex:2196; appliedIndex:2195; }","duration":"283.191063ms","start":"2026-08-11T07:39:07.366457Z","end":"2026-08-11T07:39:07.649648Z","steps":["trace[1118509200] 'read index received' (duration: 146.6095ms)","trace[1118509200] 'applied index is now lower than readState.Index' (duration: 136.580323ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:39:07.649779Z","caller":"traceutil/trace.go:171","msg":"trace[1122086245] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"355.277661ms","start":"2026-08-11T07:39:07.294472Z","end":"2026-08-11T07:39:07.64975Z","steps":["trace[1122086245] 'process raft request' (duration: 218.668627ms)","trace[1122086245] 'compare' (duration: 136.223135ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:39:07.649945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.482831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12385"} {"level":"info","ts":"2026-08-11T07:39:07.650005Z","caller":"traceutil/trace.go:171","msg":"trace[501709091] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2116; }","duration":"283.579833ms","start":"2026-08-11T07:39:07.36641Z","end":"2026-08-11T07:39:07.64999Z","steps":["trace[501709091] 'agreement among raft nodes before linearized reading' (duration: 283.341778ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:07.650261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.821543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.77\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-08-11T07:39:07.650353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.853521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-11T07:39:07.650379Z","caller":"traceutil/trace.go:171","msg":"trace[829213510] range","detail":"{range_begin:/registry/masterleases/199.204.45.77; range_end:; response_count:1; response_revision:2116; }","duration":"175.011298ms","start":"2026-08-11T07:39:07.475335Z","end":"2026-08-11T07:39:07.650346Z","steps":["trace[829213510] 'agreement among raft nodes before linearized reading' (duration: 174.6894ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:07.650431Z","caller":"traceutil/trace.go:171","msg":"trace[278414398] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2116; }","duration":"134.974794ms","start":"2026-08-11T07:39:07.515437Z","end":"2026-08-11T07:39:07.650412Z","steps":["trace[278414398] 'agreement among raft nodes before linearized reading' (duration: 134.764879ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:07.650536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:39:07.294448Z","time spent":"355.463785ms","remote":"127.0.0.1:59260","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-08-11T07:39:07.793665Z","caller":"traceutil/trace.go:171","msg":"trace[1367990010] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"139.640075ms","start":"2026-08-11T07:39:07.653998Z","end":"2026-08-11T07:39:07.793638Z","steps":["trace[1367990010] 'process raft request' (duration: 103.973966ms)","trace[1367990010] 'compare' (duration: 35.423393ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:39:07.794272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.295703ms","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-08-11T07:39:07.79437Z","caller":"traceutil/trace.go:171","msg":"trace[1498710841] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2118; }","duration":"135.425555ms","start":"2026-08-11T07:39:07.658919Z","end":"2026-08-11T07:39:07.794345Z","steps":["trace[1498710841] 'agreement among raft nodes before linearized reading' (duration: 135.20686ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:09.184793Z","caller":"traceutil/trace.go:171","msg":"trace[1741016451] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"348.316162ms","start":"2026-08-11T07:39:08.836451Z","end":"2026-08-11T07:39:09.184767Z","steps":["trace[1741016451] 'process raft request' (duration: 348.112897ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:09.184918Z","caller":"traceutil/trace.go:171","msg":"trace[651623162] linearizableReadLoop","detail":"{readStateIndex:2202; appliedIndex:2200; }","duration":"333.426201ms","start":"2026-08-11T07:39:08.851473Z","end":"2026-08-11T07:39:09.1849Z","steps":["trace[651623162] 'read index received' (duration: 333.222746ms)","trace[651623162] 'applied index is now lower than readState.Index' (duration: 202.345µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:39:09.184951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:39:08.836428Z","time spent":"348.441955ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:39:09.185064Z","caller":"traceutil/trace.go:171","msg":"trace[963366940] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"339.387256ms","start":"2026-08-11T07:39:08.845633Z","end":"2026-08-11T07:39:09.18502Z","steps":["trace[963366940] 'process raft request' (duration: 339.092449ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:09.185127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.634916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-11T07:39:09.185184Z","caller":"traceutil/trace.go:171","msg":"trace[1077528346] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2121; }","duration":"333.732329ms","start":"2026-08-11T07:39:08.851442Z","end":"2026-08-11T07:39:09.185174Z","steps":["trace[1077528346] 'agreement among raft nodes before linearized reading' (duration: 333.548724ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:09.185223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:39:08.851428Z","time spent":"333.7865ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-11T07:39:09.18524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:39:08.845603Z","time spent":"339.535419ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:39:09.467153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.580275ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:39:09.467412Z","caller":"traceutil/trace.go:171","msg":"trace[1552555406] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"278.378424ms","start":"2026-08-11T07:39:09.189006Z","end":"2026-08-11T07:39:09.467385Z","steps":["trace[1552555406] 'process raft request' (duration: 278.253841ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:39:09.467425Z","caller":"traceutil/trace.go:171","msg":"trace[786959526] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"436.63488ms","start":"2026-08-11T07:39:09.030763Z","end":"2026-08-11T07:39:09.467398Z","steps":["trace[786959526] 'process raft request' (duration: 257.736148ms)","trace[786959526] 'compare' (duration: 178.40061ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:39:09.467516Z","caller":"traceutil/trace.go:171","msg":"trace[2072430640] linearizableReadLoop","detail":"{readStateIndex:2203; appliedIndex:2202; }","duration":"282.460195ms","start":"2026-08-11T07:39:09.184964Z","end":"2026-08-11T07:39:09.467424Z","steps":["trace[2072430640] 'read index received' (duration: 103.434739ms)","trace[2072430640] 'applied index is now lower than readState.Index' (duration: 179.015176ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:39:09.467611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:39:09.030729Z","time spent":"436.746283ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:39:09.467621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.840579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T07:39:09.467658Z","caller":"traceutil/trace.go:171","msg":"trace[630485149] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2123; }","duration":"329.90403ms","start":"2026-08-11T07:39:09.137743Z","end":"2026-08-11T07:39:09.467647Z","steps":["trace[630485149] 'agreement among raft nodes before linearized reading' (duration: 329.788628ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:09.467703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:39:09.137736Z","time spent":"329.953171ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-11T07:39:09.467754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.378162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-11T07:39:09.467789Z","caller":"traceutil/trace.go:171","msg":"trace[1324320773] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2123; }","duration":"330.414243ms","start":"2026-08-11T07:39:09.137366Z","end":"2026-08-11T07:39:09.467781Z","steps":["trace[1324320773] 'agreement among raft nodes before linearized reading' (duration: 330.28594ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:09.467816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:39:09.137318Z","time spent":"330.490244ms","remote":"127.0.0.1:59260","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":"warn","ts":"2026-08-11T07:39:09.467946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.251861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-11T07:39:09.468005Z","caller":"traceutil/trace.go:171","msg":"trace[1590373944] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2123; }","duration":"282.360223ms","start":"2026-08-11T07:39:09.185623Z","end":"2026-08-11T07:39:09.467983Z","steps":["trace[1590373944] 'agreement among raft nodes before linearized reading' (duration: 282.093626ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:09.468195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.779302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-11T07:39:09.468303Z","caller":"traceutil/trace.go:171","msg":"trace[1059092238] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2123; }","duration":"330.934236ms","start":"2026-08-11T07:39:09.137344Z","end":"2026-08-11T07:39:09.468278Z","steps":["trace[1059092238] 'agreement among raft nodes before linearized reading' (duration: 330.197408ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:39:09.468421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:39:09.137325Z","time spent":"331.081429ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-11T07:40:50.028239Z","caller":"traceutil/trace.go:171","msg":"trace[142442997] transaction","detail":"{read_only:false; response_revision:2766; number_of_response:1; }","duration":"485.264296ms","start":"2026-08-11T07:40:49.542939Z","end":"2026-08-11T07:40:50.028203Z","steps":["trace[142442997] 'process raft request' (duration: 485.086498ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:40:50.028809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:40:49.542909Z","time spent":"485.414133ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:40:50.070781Z","caller":"traceutil/trace.go:171","msg":"trace[852149360] linearizableReadLoop","detail":"{readStateIndex:2871; appliedIndex:2869; }","duration":"501.345539ms","start":"2026-08-11T07:40:49.569366Z","end":"2026-08-11T07:40:50.070711Z","steps":["trace[852149360] 'read index received' (duration: 458.714717ms)","trace[852149360] 'applied index is now lower than readState.Index' (duration: 42.629602ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:40:50.070841Z","caller":"traceutil/trace.go:171","msg":"trace[760496900] transaction","detail":"{read_only:false; response_revision:2767; number_of_response:1; }","duration":"504.748105ms","start":"2026-08-11T07:40:49.566064Z","end":"2026-08-11T07:40:50.070812Z","steps":["trace[760496900] 'process raft request' (duration: 504.39587ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:40:50.071011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.618391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:40:50.071114Z","caller":"traceutil/trace.go:171","msg":"trace[436207917] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2767; }","duration":"501.786758ms","start":"2026-08-11T07:40:49.569302Z","end":"2026-08-11T07:40:50.071089Z","steps":["trace[436207917] 'agreement among raft nodes before linearized reading' (duration: 501.59939ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:40:50.071149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.307012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18cab0490234f385\" ","response":"range_response_count:1 size:781"} {"level":"warn","ts":"2026-08-11T07:40:50.071169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:40:49.569277Z","time spent":"501.882342ms","remote":"127.0.0.1:58934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-11T07:40:50.071223Z","caller":"traceutil/trace.go:171","msg":"trace[1186353945] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18cab0490234f385; range_end:; response_count:1; response_revision:2767; }","duration":"247.45653ms","start":"2026-08-11T07:40:49.823748Z","end":"2026-08-11T07:40:50.071204Z","steps":["trace[1186353945] 'agreement among raft nodes before linearized reading' (duration: 247.192169ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:40:50.071497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.139379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-08-11T07:40:50.071533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.163866ms","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":"info","ts":"2026-08-11T07:40:50.071585Z","caller":"traceutil/trace.go:171","msg":"trace[1097084548] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2767; }","duration":"112.371105ms","start":"2026-08-11T07:40:49.959198Z","end":"2026-08-11T07:40:50.071569Z","steps":["trace[1097084548] 'agreement among raft nodes before linearized reading' (duration: 112.271931ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:40:50.071586Z","caller":"traceutil/trace.go:171","msg":"trace[757255389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2767; }","duration":"110.217572ms","start":"2026-08-11T07:40:49.961336Z","end":"2026-08-11T07:40:50.071553Z","steps":["trace[757255389] 'agreement among raft nodes before linearized reading' (duration: 110.018374ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:40:50.072201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:40:49.56604Z","time spent":"505.963268ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:44:31.327014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.813184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-08-11T07:44:31.327078Z","caller":"traceutil/trace.go:171","msg":"trace[1965173216] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4527; }","duration":"106.914526ms","start":"2026-08-11T07:44:31.220149Z","end":"2026-08-11T07:44:31.327064Z","steps":["trace[1965173216] 'range keys from in-memory index tree' (duration: 106.663719ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:44:31.437884Z","caller":"traceutil/trace.go:171","msg":"trace[1208230173] transaction","detail":"{read_only:false; response_revision:4529; number_of_response:1; }","duration":"105.538804ms","start":"2026-08-11T07:44:31.332327Z","end":"2026-08-11T07:44:31.437865Z","steps":["trace[1208230173] 'process raft request' (duration: 105.131521ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:44:31.438213Z","caller":"traceutil/trace.go:171","msg":"trace[99959449] transaction","detail":"{read_only:false; response_revision:4530; number_of_response:1; }","duration":"105.792402ms","start":"2026-08-11T07:44:31.332399Z","end":"2026-08-11T07:44:31.438192Z","steps":["trace[99959449] 'process raft request' (duration: 105.43803ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:44:31.440027Z","caller":"traceutil/trace.go:171","msg":"trace[2023421172] transaction","detail":"{read_only:false; response_revision:4531; number_of_response:1; }","duration":"107.559657ms","start":"2026-08-11T07:44:31.332445Z","end":"2026-08-11T07:44:31.440004Z","steps":["trace[2023421172] 'process raft request' (duration: 105.610596ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:44:43.545844Z","caller":"traceutil/trace.go:171","msg":"trace[853912041] transaction","detail":"{read_only:false; response_revision:4715; number_of_response:1; }","duration":"156.778927ms","start":"2026-08-11T07:44:43.389045Z","end":"2026-08-11T07:44:43.545824Z","steps":["trace[853912041] 'process raft request' (duration: 156.622172ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:44:44.179244Z","caller":"traceutil/trace.go:171","msg":"trace[165524165] transaction","detail":"{read_only:false; response_revision:4734; number_of_response:1; }","duration":"131.513499ms","start":"2026-08-11T07:44:44.047705Z","end":"2026-08-11T07:44:44.179219Z","steps":["trace[165524165] 'process raft request' (duration: 130.915769ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:44:44.359408Z","caller":"traceutil/trace.go:171","msg":"trace[2091130176] transaction","detail":"{read_only:false; response_revision:4740; number_of_response:1; }","duration":"147.721655ms","start":"2026-08-11T07:44:44.211656Z","end":"2026-08-11T07:44:44.359378Z","steps":["trace[2091130176] 'process raft request' (duration: 147.671273ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:44:44.359859Z","caller":"traceutil/trace.go:171","msg":"trace[878453514] transaction","detail":"{read_only:false; response_revision:4739; number_of_response:1; }","duration":"148.886403ms","start":"2026-08-11T07:44:44.210932Z","end":"2026-08-11T07:44:44.359819Z","steps":["trace[878453514] 'process raft request' (duration: 148.305965ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:44:44.360005Z","caller":"traceutil/trace.go:171","msg":"trace[1320338701] transaction","detail":"{read_only:false; response_revision:4738; number_of_response:1; }","duration":"149.08469ms","start":"2026-08-11T07:44:44.2109Z","end":"2026-08-11T07:44:44.359985Z","steps":["trace[1320338701] 'process raft request' (duration: 148.188221ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:44:52.305521Z","caller":"traceutil/trace.go:171","msg":"trace[760915735] linearizableReadLoop","detail":"{readStateIndex:5088; appliedIndex:5087; }","duration":"101.581898ms","start":"2026-08-11T07:44:52.203919Z","end":"2026-08-11T07:44:52.305501Z","steps":["trace[760915735] 'read index received' (duration: 96.763689ms)","trace[760915735] 'applied index is now lower than readState.Index' (duration: 4.817569ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:44:52.305698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.760686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-08-11T07:44:52.305729Z","caller":"traceutil/trace.go:171","msg":"trace[77189972] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4904; }","duration":"101.841858ms","start":"2026-08-11T07:44:52.20388Z","end":"2026-08-11T07:44:52.305722Z","steps":["trace[77189972] 'agreement among raft nodes before linearized reading' (duration: 101.701183ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:44:52.305672Z","caller":"traceutil/trace.go:171","msg":"trace[2079512870] transaction","detail":"{read_only:false; response_revision:4904; number_of_response:1; }","duration":"106.145549ms","start":"2026-08-11T07:44:52.199496Z","end":"2026-08-11T07:44:52.305642Z","steps":["trace[2079512870] 'process raft request' (duration: 101.233507ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:44:57.243795Z","caller":"traceutil/trace.go:171","msg":"trace[450258378] transaction","detail":"{read_only:false; response_revision:4949; number_of_response:1; }","duration":"267.104465ms","start":"2026-08-11T07:44:56.976662Z","end":"2026-08-11T07:44:57.243767Z","steps":["trace[450258378] 'process raft request' (duration: 266.92587ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:44:57.269237Z","caller":"traceutil/trace.go:171","msg":"trace[60381597] transaction","detail":"{read_only:false; response_revision:4951; number_of_response:1; }","duration":"192.304767ms","start":"2026-08-11T07:44:57.076901Z","end":"2026-08-11T07:44:57.269206Z","steps":["trace[60381597] 'process raft request' (duration: 192.160243ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:44:57.269445Z","caller":"traceutil/trace.go:171","msg":"trace[1080372572] transaction","detail":"{read_only:false; response_revision:4950; number_of_response:1; }","duration":"290.778137ms","start":"2026-08-11T07:44:56.978649Z","end":"2026-08-11T07:44:57.269428Z","steps":["trace[1080372572] 'process raft request' (duration: 290.28167ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:44:57.583856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.614765ms","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":"info","ts":"2026-08-11T07:44:57.583933Z","caller":"traceutil/trace.go:171","msg":"trace[1420642143] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4951; }","duration":"235.735489ms","start":"2026-08-11T07:44:57.348178Z","end":"2026-08-11T07:44:57.583914Z","steps":["trace[1420642143] 'count revisions from in-memory index tree' (duration: 235.540293ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:44:57.583925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.683847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-08-11T07:44:57.584083Z","caller":"traceutil/trace.go:171","msg":"trace[2012800207] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4951; }","duration":"182.855693ms","start":"2026-08-11T07:44:57.401177Z","end":"2026-08-11T07:44:57.584032Z","steps":["trace[2012800207] 'range keys from in-memory index tree' (duration: 182.4818ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:44:57.727379Z","caller":"traceutil/trace.go:171","msg":"trace[1339090067] transaction","detail":"{read_only:false; response_revision:4953; number_of_response:1; }","duration":"109.322834ms","start":"2026-08-11T07:44:57.618001Z","end":"2026-08-11T07:44:57.727324Z","steps":["trace[1339090067] 'process raft request' (duration: 70.30976ms)","trace[1339090067] 'compare' (duration: 38.8867ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:44:58.214448Z","caller":"traceutil/trace.go:171","msg":"trace[726832746] transaction","detail":"{read_only:false; response_revision:4963; number_of_response:1; }","duration":"164.628165ms","start":"2026-08-11T07:44:58.049778Z","end":"2026-08-11T07:44:58.214406Z","steps":["trace[726832746] 'process raft request' (duration: 164.459409ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:46:14.610454Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2903} {"level":"info","ts":"2026-08-11T07:46:14.692319Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2903,"took":"80.221458ms","hash":3255440340,"current-db-size-bytes":54931456,"current-db-size":"55 MB","current-db-size-in-use-bytes":29200384,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-11T07:46:14.692537Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3255440340,"revision":2903,"compact-revision":-1} {"level":"info","ts":"2026-08-11T07:47:06.025399Z","caller":"traceutil/trace.go:171","msg":"trace[1529027170] transaction","detail":"{read_only:false; response_revision:5885; number_of_response:1; }","duration":"122.906455ms","start":"2026-08-11T07:47:05.902427Z","end":"2026-08-11T07:47:06.025334Z","steps":["trace[1529027170] 'process raft request' (duration: 122.675776ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:48:32.983271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.249303ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-11T07:48:33.545024Z","caller":"traceutil/trace.go:171","msg":"trace[1737227753] transaction","detail":"{read_only:false; response_revision:6531; number_of_response:1; }","duration":"197.821059ms","start":"2026-08-11T07:48:33.347149Z","end":"2026-08-11T07:48:33.54497Z","steps":["trace[1737227753] 'process raft request' (duration: 197.639482ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:48:41.375398Z","caller":"traceutil/trace.go:171","msg":"trace[874208426] transaction","detail":"{read_only:false; response_revision:6571; number_of_response:1; }","duration":"190.971929ms","start":"2026-08-11T07:48:41.18439Z","end":"2026-08-11T07:48:41.375362Z","steps":["trace[874208426] 'process raft request' (duration: 190.767401ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:48:41.375295Z","caller":"traceutil/trace.go:171","msg":"trace[163665317] linearizableReadLoop","detail":"{readStateIndex:6810; appliedIndex:6809; }","duration":"145.127487ms","start":"2026-08-11T07:48:41.230152Z","end":"2026-08-11T07:48:41.37528Z","steps":["trace[163665317] 'read index received' (duration: 144.9626ms)","trace[163665317] 'applied index is now lower than readState.Index' (duration: 164.047µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:48:41.375585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.413949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"info","ts":"2026-08-11T07:48:41.375774Z","caller":"traceutil/trace.go:171","msg":"trace[1665874368] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6571; }","duration":"145.656769ms","start":"2026-08-11T07:48:41.230096Z","end":"2026-08-11T07:48:41.375753Z","steps":["trace[1665874368] 'agreement among raft nodes before linearized reading' (duration: 145.314085ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:48:41.376191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.537565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-11T07:48:41.37625Z","caller":"traceutil/trace.go:171","msg":"trace[1942797357] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6571; }","duration":"122.622828ms","start":"2026-08-11T07:48:41.253612Z","end":"2026-08-11T07:48:41.376235Z","steps":["trace[1942797357] 'agreement among raft nodes before linearized reading' (duration: 122.520354ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:48:41.376323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.915639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"info","ts":"2026-08-11T07:48:41.376354Z","caller":"traceutil/trace.go:171","msg":"trace[1820402760] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6571; }","duration":"146.022923ms","start":"2026-08-11T07:48:41.230322Z","end":"2026-08-11T07:48:41.376345Z","steps":["trace[1820402760] 'agreement among raft nodes before linearized reading' (duration: 145.504122ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:48:47.570451Z","caller":"traceutil/trace.go:171","msg":"trace[1118406600] transaction","detail":"{read_only:false; response_revision:6604; number_of_response:1; }","duration":"141.587992ms","start":"2026-08-11T07:48:47.428835Z","end":"2026-08-11T07:48:47.570423Z","steps":["trace[1118406600] 'process raft request' (duration: 141.334702ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:48:47.570771Z","caller":"traceutil/trace.go:171","msg":"trace[147009773] transaction","detail":"{read_only:false; response_revision:6605; number_of_response:1; }","duration":"141.275069ms","start":"2026-08-11T07:48:47.429477Z","end":"2026-08-11T07:48:47.570752Z","steps":["trace[147009773] 'process raft request' (duration: 140.897694ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:48:47.570936Z","caller":"traceutil/trace.go:171","msg":"trace[781095382] transaction","detail":"{read_only:false; response_revision:6606; number_of_response:1; }","duration":"141.275399ms","start":"2026-08-11T07:48:47.429654Z","end":"2026-08-11T07:48:47.570929Z","steps":["trace[781095382] 'process raft request' (duration: 141.017619ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:51:14.616676Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5577} {"level":"info","ts":"2026-08-11T07:51:14.723792Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5577,"took":"106.027782ms","hash":92096460,"current-db-size-bytes":54931456,"current-db-size":"55 MB","current-db-size-in-use-bytes":18546688,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-11T07:51:14.723856Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":92096460,"revision":5577,"compact-revision":2903}