{"level":"warn","ts":"2026-08-11T10:59:31.732481Z","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-11T10:59:31.732602Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.162:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.162:2380","--initial-cluster=instance=https://199.19.213.162:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.162:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.162: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-11T10:59:31.732866Z","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-11T10:59:31.732885Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.162:2380"]} {"level":"info","ts":"2026-08-11T10:59:31.732962Z","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-11T10:59:31.73394Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.162:2379"]} {"level":"info","ts":"2026-08-11T10:59:31.734096Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.162:2380"],"listen-peer-urls":["https://199.19.213.162:2380"],"advertise-client-urls":["https://199.19.213.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.162: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-11T10:59:31.738988Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.57513ms"} {"level":"info","ts":"2026-08-11T10:59:31.745185Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8c0a14645b8502c5","cluster-id":"49fe27222e1c6db4"} {"level":"info","ts":"2026-08-11T10:59:31.745393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8c0a14645b8502c5 switched to configuration voters=()"} {"level":"info","ts":"2026-08-11T10:59:31.745444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8c0a14645b8502c5 became follower at term 0"} {"level":"info","ts":"2026-08-11T10:59:31.745484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8c0a14645b8502c5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-11T10:59:31.745506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8c0a14645b8502c5 became follower at term 1"} {"level":"info","ts":"2026-08-11T10:59:31.745574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8c0a14645b8502c5 switched to configuration voters=(10090900336341746373)"} {"level":"warn","ts":"2026-08-11T10:59:31.751174Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-11T10:59:31.752353Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-11T10:59:31.753385Z","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-11T10:59:31.755282Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8c0a14645b8502c5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-11T10:59:31.755478Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8c0a14645b8502c5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-11T10:59:31.755736Z","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-11T10:59:31.755799Z","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-11T10:59:31.757342Z","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-11T10:59:31.757527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8c0a14645b8502c5 switched to configuration voters=(10090900336341746373)"} {"level":"info","ts":"2026-08-11T10:59:31.757726Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49fe27222e1c6db4","local-member-id":"8c0a14645b8502c5","added-peer-id":"8c0a14645b8502c5","added-peer-peer-urls":["https://199.19.213.162:2380"]} {"level":"info","ts":"2026-08-11T10:59:31.759449Z","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-11T10:59:31.75962Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.162:2380"} {"level":"info","ts":"2026-08-11T10:59:31.759692Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.162:2380"} {"level":"info","ts":"2026-08-11T10:59:31.759815Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8c0a14645b8502c5","initial-advertise-peer-urls":["https://199.19.213.162:2380"],"listen-peer-urls":["https://199.19.213.162:2380"],"advertise-client-urls":["https://199.19.213.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-11T10:59:31.759884Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-11T10:59:32.446131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8c0a14645b8502c5 is starting a new election at term 1"} {"level":"info","ts":"2026-08-11T10:59:32.446248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8c0a14645b8502c5 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-11T10:59:32.446275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8c0a14645b8502c5 received MsgPreVoteResp from 8c0a14645b8502c5 at term 1"} {"level":"info","ts":"2026-08-11T10:59:32.446291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8c0a14645b8502c5 became candidate at term 2"} {"level":"info","ts":"2026-08-11T10:59:32.446299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8c0a14645b8502c5 received MsgVoteResp from 8c0a14645b8502c5 at term 2"} {"level":"info","ts":"2026-08-11T10:59:32.44631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8c0a14645b8502c5 became leader at term 2"} {"level":"info","ts":"2026-08-11T10:59:32.446322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8c0a14645b8502c5 elected leader 8c0a14645b8502c5 at term 2"} {"level":"info","ts":"2026-08-11T10:59:32.448447Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8c0a14645b8502c5","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.162:2379]}","request-path":"/0/members/8c0a14645b8502c5/attributes","cluster-id":"49fe27222e1c6db4","publish-timeout":"7s"} {"level":"info","ts":"2026-08-11T10:59:32.4485Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T10:59:32.448687Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T10:59:32.449102Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T10:59:32.449296Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-11T10:59:32.449357Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-11T10:59:32.450196Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49fe27222e1c6db4","local-member-id":"8c0a14645b8502c5","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T10:59:32.450403Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T10:59:32.450534Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T10:59:32.451743Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-11T10:59:32.466575Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.162:2379"} {"level":"warn","ts":"2026-08-11T10:59:35.45436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.467334ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-11T10:59:35.454487Z","caller":"traceutil/trace.go:171","msg":"trace[1815201450] transaction","detail":"{read_only:false; response_revision:182; number_of_response:1; }","duration":"267.45469ms","start":"2026-08-11T10:59:35.187017Z","end":"2026-08-11T10:59:35.454472Z","steps":["trace[1815201450] 'process raft request' (duration: 121.415437ms)","trace[1815201450] 'compare' (duration: 145.326482ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T10:59:35.734588Z","caller":"traceutil/trace.go:171","msg":"trace[474971454] transaction","detail":"{read_only:false; response_revision:183; number_of_response:1; }","duration":"276.017877ms","start":"2026-08-11T10:59:35.458546Z","end":"2026-08-11T10:59:35.734564Z","steps":["trace[474971454] 'process raft request' (duration: 266.724089ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:00:12.912535Z","caller":"traceutil/trace.go:171","msg":"trace[67757707] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"100.417542ms","start":"2026-08-11T11:00:12.812098Z","end":"2026-08-11T11:00:12.912516Z","steps":["trace[67757707] 'process raft request' (duration: 99.782003ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:00:12.912788Z","caller":"traceutil/trace.go:171","msg":"trace[496530298] transaction","detail":"{read_only:false; number_of_response:1; response_revision:538; }","duration":"100.648935ms","start":"2026-08-11T11:00:12.812129Z","end":"2026-08-11T11:00:12.912778Z","steps":["trace[496530298] 'process raft request' (duration: 99.859804ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:00:12.91298Z","caller":"traceutil/trace.go:171","msg":"trace[304227937] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"100.820937ms","start":"2026-08-11T11:00:12.812148Z","end":"2026-08-11T11:00:12.912969Z","steps":["trace[304227937] 'process raft request' (duration: 99.883664ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:00:12.913153Z","caller":"traceutil/trace.go:171","msg":"trace[1344258829] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"100.753296ms","start":"2026-08-11T11:00:12.812388Z","end":"2026-08-11T11:00:12.913141Z","steps":["trace[1344258829] 'process raft request' (duration: 99.686471ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:00:13.287892Z","caller":"traceutil/trace.go:171","msg":"trace[4899277] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"110.881035ms","start":"2026-08-11T11:00:13.176977Z","end":"2026-08-11T11:00:13.287858Z","steps":["trace[4899277] 'process raft request' (duration: 79.866589ms)","trace[4899277] 'compare' (duration: 30.830813ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:00:13.302416Z","caller":"traceutil/trace.go:171","msg":"trace[992880837] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"116.895535ms","start":"2026-08-11T11:00:13.185486Z","end":"2026-08-11T11:00:13.302381Z","steps":["trace[992880837] 'process raft request' (duration: 116.356268ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:00:13.302669Z","caller":"traceutil/trace.go:171","msg":"trace[1522094508] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"108.435551ms","start":"2026-08-11T11:00:13.194221Z","end":"2026-08-11T11:00:13.302657Z","steps":["trace[1522094508] 'process raft request' (duration: 107.859304ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:00:13.629402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.117292ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T11:00:13.629702Z","caller":"traceutil/trace.go:171","msg":"trace[644072549] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"287.311567ms","start":"2026-08-11T11:00:13.342369Z","end":"2026-08-11T11:00:13.62968Z","steps":["trace[644072549] 'process raft request' (duration: 287.163185ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:00:13.629702Z","caller":"traceutil/trace.go:171","msg":"trace[1550608349] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"296.213827ms","start":"2026-08-11T11:00:13.333438Z","end":"2026-08-11T11:00:13.629652Z","steps":["trace[1550608349] 'process raft request' (duration: 121.638179ms)","trace[1550608349] 'compare' (duration: 173.856408ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:00:13.629824Z","caller":"traceutil/trace.go:171","msg":"trace[1911136145] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"272.245685ms","start":"2026-08-11T11:00:13.357554Z","end":"2026-08-11T11:00:13.629799Z","steps":["trace[1911136145] 'process raft request' (duration: 272.079453ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:00:18.974706Z","caller":"traceutil/trace.go:171","msg":"trace[1904454137] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"119.330809ms","start":"2026-08-11T11:00:18.855339Z","end":"2026-08-11T11:00:18.97467Z","steps":["trace[1904454137] 'process raft request' (duration: 118.459348ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:00:19.008194Z","caller":"traceutil/trace.go:171","msg":"trace[261268819] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"100.2929ms","start":"2026-08-11T11:00:18.907877Z","end":"2026-08-11T11:00:19.00817Z","steps":["trace[261268819] 'process raft request' (duration: 100.111208ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:00:19.122306Z","caller":"traceutil/trace.go:171","msg":"trace[976283645] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"110.852631ms","start":"2026-08-11T11:00:19.011437Z","end":"2026-08-11T11:00:19.12229Z","steps":["trace[976283645] 'process raft request' (duration: 106.081429ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:00:19.12248Z","caller":"traceutil/trace.go:171","msg":"trace[177302814] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:659; }","duration":"102.503602ms","start":"2026-08-11T11:00:19.019953Z","end":"2026-08-11T11:00:19.122456Z","steps":["trace[177302814] 'read index received' (duration: 97.537517ms)","trace[177302814] 'applied index is now lower than readState.Index' (duration: 4.964975ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:00:19.12267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.691645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-znpb9\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-11T11:00:19.12271Z","caller":"traceutil/trace.go:171","msg":"trace[168036154] range","detail":"{range_begin:/registry/pods/kube-system/cilium-znpb9; range_end:; response_count:1; response_revision:640; }","duration":"102.760706ms","start":"2026-08-11T11:00:19.019937Z","end":"2026-08-11T11:00:19.122698Z","steps":["trace[168036154] 'agreement among raft nodes before linearized reading' (duration: 102.625964ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:00:19.636756Z","caller":"traceutil/trace.go:171","msg":"trace[182396419] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"106.660766ms","start":"2026-08-11T11:00:19.530058Z","end":"2026-08-11T11:00:19.636718Z","steps":["trace[182396419] 'process raft request' (duration: 105.854546ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:01:57.676872Z","caller":"traceutil/trace.go:171","msg":"trace[1979234446] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"292.012772ms","start":"2026-08-11T11:01:57.384831Z","end":"2026-08-11T11:01:57.676843Z","steps":["trace[1979234446] 'process raft request' (duration: 291.78454ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:01:57.705136Z","caller":"traceutil/trace.go:171","msg":"trace[1505292431] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"208.085831ms","start":"2026-08-11T11:01:57.497004Z","end":"2026-08-11T11:01:57.70509Z","steps":["trace[1505292431] 'process raft request' (duration: 207.598507ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:01:57.706232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.597815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-91758056-62d4-498e-9d38-c59250e18a5e\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-11T11:01:57.706303Z","caller":"traceutil/trace.go:171","msg":"trace[194676346] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-91758056-62d4-498e-9d38-c59250e18a5e; range_end:; response_count:1; response_revision:1905; }","duration":"112.754107ms","start":"2026-08-11T11:01:57.593529Z","end":"2026-08-11T11:01:57.706283Z","steps":["trace[194676346] 'agreement among raft nodes before linearized reading' (duration: 111.638016ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:01:57.70517Z","caller":"traceutil/trace.go:171","msg":"trace[313852969] linearizableReadLoop","detail":"{readStateIndex:1973; appliedIndex:1971; }","duration":"111.477514ms","start":"2026-08-11T11:01:57.593589Z","end":"2026-08-11T11:01:57.705067Z","steps":["trace[313852969] 'read index received' (duration: 81.973482ms)","trace[313852969] 'applied index is now lower than readState.Index' (duration: 29.502172ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:01:57.817076Z","caller":"traceutil/trace.go:171","msg":"trace[114568264] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"103.578676ms","start":"2026-08-11T11:01:57.713461Z","end":"2026-08-11T11:01:57.817039Z","steps":["trace[114568264] 'process raft request' (duration: 57.586711ms)","trace[114568264] 'compare' (duration: 45.853494ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:01:58.176981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.143494ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T11:01:58.177186Z","caller":"traceutil/trace.go:171","msg":"trace[1286422916] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"327.378989ms","start":"2026-08-11T11:01:57.849788Z","end":"2026-08-11T11:01:58.177167Z","steps":["trace[1286422916] 'process raft request' (duration: 327.318229ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:01:58.177244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:01:57.849753Z","time spent":"327.465851ms","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T11:01:58.177361Z","caller":"traceutil/trace.go:171","msg":"trace[219768657] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"460.459337ms","start":"2026-08-11T11:01:57.716863Z","end":"2026-08-11T11:01:58.177322Z","steps":["trace[219768657] 'process raft request' (duration: 304.858878ms)","trace[219768657] 'compare' (duration: 154.945313ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:01:58.17759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:01:57.716849Z","time spent":"460.615538ms","remote":"127.0.0.1:51156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T11:01:58.177717Z","caller":"traceutil/trace.go:171","msg":"trace[1415139293] linearizableReadLoop","detail":"{readStateIndex:1975; appliedIndex:1974; }","duration":"399.193001ms","start":"2026-08-11T11:01:57.778493Z","end":"2026-08-11T11:01:58.177686Z","steps":["trace[1415139293] 'read index received' (duration: 243.245808ms)","trace[1415139293] 'applied index is now lower than readState.Index' (duration: 155.945563ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:01:58.177847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.355882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T11:01:58.177898Z","caller":"traceutil/trace.go:171","msg":"trace[1026039920] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1908; }","duration":"399.460274ms","start":"2026-08-11T11:01:57.778425Z","end":"2026-08-11T11:01:58.177885Z","steps":["trace[1026039920] 'agreement among raft nodes before linearized reading' (duration: 399.354663ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:01:58.177958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:01:57.778405Z","time spent":"399.543374ms","remote":"127.0.0.1:51108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-08-11T11:01:58.177973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.737129ms","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-11T11:01:58.178008Z","caller":"traceutil/trace.go:171","msg":"trace[998300019] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1908; }","duration":"253.833491ms","start":"2026-08-11T11:01:57.924163Z","end":"2026-08-11T11:01:58.177997Z","steps":["trace[998300019] 'agreement among raft nodes before linearized reading' (duration: 253.68118ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:02:10.612587Z","caller":"traceutil/trace.go:171","msg":"trace[814707359] transaction","detail":"{read_only:false; response_revision:2007; number_of_response:1; }","duration":"113.812569ms","start":"2026-08-11T11:02:10.498744Z","end":"2026-08-11T11:02:10.612556Z","steps":["trace[814707359] 'process raft request' (duration: 113.636017ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:02:15.340745Z","caller":"traceutil/trace.go:171","msg":"trace[644683722] transaction","detail":"{read_only:false; response_revision:2047; number_of_response:1; }","duration":"139.548373ms","start":"2026-08-11T11:02:15.201137Z","end":"2026-08-11T11:02:15.340686Z","steps":["trace[644683722] 'process raft request' (duration: 139.283581ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:02:37.114307Z","caller":"traceutil/trace.go:171","msg":"trace[1430659854] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"195.831452ms","start":"2026-08-11T11:02:36.916934Z","end":"2026-08-11T11:02:37.112765Z","steps":["trace[1430659854] 'process raft request' (duration: 122.98048ms)","trace[1430659854] 'compare' (duration: 72.56579ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:02:37.116197Z","caller":"traceutil/trace.go:171","msg":"trace[1093531437] linearizableReadLoop","detail":"{readStateIndex:2245; appliedIndex:2243; }","duration":"100.282722ms","start":"2026-08-11T11:02:37.015887Z","end":"2026-08-11T11:02:37.11617Z","steps":["trace[1093531437] 'read index received' (duration: 24.043228ms)","trace[1093531437] 'applied index is now lower than readState.Index' (duration: 76.238704ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:02:37.116385Z","caller":"traceutil/trace.go:171","msg":"trace[413152220] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"122.848448ms","start":"2026-08-11T11:02:36.993491Z","end":"2026-08-11T11:02:37.11634Z","steps":["trace[413152220] 'process raft request' (duration: 122.527414ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:02:37.116472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.566906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-11T11:02:37.116585Z","caller":"traceutil/trace.go:171","msg":"trace[2050795703] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2168; }","duration":"100.672417ms","start":"2026-08-11T11:02:37.015833Z","end":"2026-08-11T11:02:37.116505Z","steps":["trace[2050795703] 'agreement among raft nodes before linearized reading' (duration: 100.510686ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:02:37.116886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.88132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-11T11:02:37.116935Z","caller":"traceutil/trace.go:171","msg":"trace[656331001] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2168; }","duration":"100.94266ms","start":"2026-08-11T11:02:37.015979Z","end":"2026-08-11T11:02:37.116922Z","steps":["trace[656331001] 'agreement among raft nodes before linearized reading' (duration: 100.786139ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:02:37.587052Z","caller":"traceutil/trace.go:171","msg":"trace[2025755619] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"132.156427ms","start":"2026-08-11T11:02:37.454848Z","end":"2026-08-11T11:02:37.587004Z","steps":["trace[2025755619] 'process raft request' (duration: 131.759743ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:03:09.203676Z","caller":"traceutil/trace.go:171","msg":"trace[670013072] transaction","detail":"{read_only:false; response_revision:2348; number_of_response:1; }","duration":"235.105991ms","start":"2026-08-11T11:03:08.968533Z","end":"2026-08-11T11:03:09.203639Z","steps":["trace[670013072] 'process raft request' (duration: 234.856322ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:03:09.204452Z","caller":"traceutil/trace.go:171","msg":"trace[1851486623] transaction","detail":"{read_only:false; response_revision:2349; number_of_response:1; }","duration":"228.360535ms","start":"2026-08-11T11:03:08.976041Z","end":"2026-08-11T11:03:09.204402Z","steps":["trace[1851486623] 'process raft request' (duration: 228.151947ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:03:40.018294Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":199741613679916623,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-11T11:03:40.143801Z","caller":"traceutil/trace.go:171","msg":"trace[1998803620] linearizableReadLoop","detail":"{readStateIndex:2708; appliedIndex:2707; }","duration":"626.352203ms","start":"2026-08-11T11:03:39.517411Z","end":"2026-08-11T11:03:40.143764Z","steps":["trace[1998803620] 'read index received' (duration: 626.030772ms)","trace[1998803620] 'applied index is now lower than readState.Index' (duration: 320.271µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:03:40.143932Z","caller":"traceutil/trace.go:171","msg":"trace[744697885] transaction","detail":"{read_only:false; response_revision:2617; number_of_response:1; }","duration":"664.794023ms","start":"2026-08-11T11:03:39.479089Z","end":"2026-08-11T11:03:40.143883Z","steps":["trace[744697885] 'process raft request' (duration: 664.453963ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:03:40.144118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.667342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-11T11:03:40.144171Z","caller":"traceutil/trace.go:171","msg":"trace[2133573495] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2617; }","duration":"626.756434ms","start":"2026-08-11T11:03:39.517401Z","end":"2026-08-11T11:03:40.144157Z","steps":["trace[2133573495] 'agreement among raft nodes before linearized reading' (duration: 626.531278ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:03:40.144191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.857037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T11:03:40.144216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:03:39.51731Z","time spent":"626.896619ms","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-11T11:03:40.144274Z","caller":"traceutil/trace.go:171","msg":"trace[2084086558] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:2617; }","duration":"618.972761ms","start":"2026-08-11T11:03:39.52528Z","end":"2026-08-11T11:03:40.144252Z","steps":["trace[2084086558] 'agreement among raft nodes before linearized reading' (duration: 618.848857ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:03:40.144363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:03:39.525269Z","time spent":"619.081914ms","remote":"127.0.0.1:55394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-11T11:03:40.144641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.004911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T11:03:40.144648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.471665ms","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-11T11:03:40.144712Z","caller":"traceutil/trace.go:171","msg":"trace[1925055686] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2617; }","duration":"421.274539ms","start":"2026-08-11T11:03:39.723421Z","end":"2026-08-11T11:03:40.144696Z","steps":["trace[1925055686] 'agreement among raft nodes before linearized reading' (duration: 420.998751ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:03:40.144648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.289479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-08-11T11:03:40.144769Z","caller":"traceutil/trace.go:171","msg":"trace[780247324] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2617; }","duration":"215.65446ms","start":"2026-08-11T11:03:39.92908Z","end":"2026-08-11T11:03:40.144735Z","steps":["trace[780247324] 'agreement among raft nodes before linearized reading' (duration: 215.253278ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:03:40.144849Z","caller":"traceutil/trace.go:171","msg":"trace[1424924895] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2617; }","duration":"205.525926ms","start":"2026-08-11T11:03:39.939304Z","end":"2026-08-11T11:03:40.14483Z","steps":["trace[1424924895] 'agreement among raft nodes before linearized reading' (duration: 205.154595ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:03:40.144752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:03:39.723383Z","time spent":"421.360611ms","remote":"127.0.0.1:50972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-11T11:03:40.145126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:03:39.479069Z","time spent":"664.970369ms","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T11:03:40.400337Z","caller":"traceutil/trace.go:171","msg":"trace[1124440468] transaction","detail":"{read_only:false; response_revision:2619; number_of_response:1; }","duration":"249.042985ms","start":"2026-08-11T11:03:40.15127Z","end":"2026-08-11T11:03:40.400313Z","steps":["trace[1124440468] 'process raft request' (duration: 248.87454ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:03:40.400567Z","caller":"traceutil/trace.go:171","msg":"trace[1846972699] linearizableReadLoop","detail":"{readStateIndex:2711; appliedIndex:2709; }","duration":"184.117429ms","start":"2026-08-11T11:03:40.216424Z","end":"2026-08-11T11:03:40.400542Z","steps":["trace[1846972699] 'read index received' (duration: 183.797809ms)","trace[1846972699] 'applied index is now lower than readState.Index' (duration: 318.61µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:03:40.400673Z","caller":"traceutil/trace.go:171","msg":"trace[1704509951] transaction","detail":"{read_only:false; response_revision:2620; number_of_response:1; }","duration":"203.527047ms","start":"2026-08-11T11:03:40.197138Z","end":"2026-08-11T11:03:40.400665Z","steps":["trace[1704509951] 'process raft request' (duration: 203.26041ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:03:40.400814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.378746ms","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-11T11:03:40.400859Z","caller":"traceutil/trace.go:171","msg":"trace[2048458185] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2620; }","duration":"184.475829ms","start":"2026-08-11T11:03:40.216369Z","end":"2026-08-11T11:03:40.400845Z","steps":["trace[2048458185] 'agreement among raft nodes before linearized reading' (duration: 184.394326ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:03:41.7537Z","caller":"traceutil/trace.go:171","msg":"trace[132667166] transaction","detail":"{read_only:false; response_revision:2624; number_of_response:1; }","duration":"382.619635ms","start":"2026-08-11T11:03:41.371041Z","end":"2026-08-11T11:03:41.75366Z","steps":["trace[132667166] 'process raft request' (duration: 382.281754ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:03:41.753938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:03:41.371012Z","time spent":"382.79704ms","remote":"127.0.0.1:51222","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-11T11:03:41.760117Z","caller":"traceutil/trace.go:171","msg":"trace[2124665589] transaction","detail":"{read_only:false; response_revision:2626; number_of_response:1; }","duration":"370.01519ms","start":"2026-08-11T11:03:41.390078Z","end":"2026-08-11T11:03:41.760093Z","steps":["trace[2124665589] 'process raft request' (duration: 369.909357ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:03:41.760125Z","caller":"traceutil/trace.go:171","msg":"trace[115024874] transaction","detail":"{read_only:false; response_revision:2625; number_of_response:1; }","duration":"376.40953ms","start":"2026-08-11T11:03:41.383674Z","end":"2026-08-11T11:03:41.760084Z","steps":["trace[115024874] 'process raft request' (duration: 376.159912ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:03:41.760225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:03:41.39006Z","time spent":"370.112652ms","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T11:03:41.760746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:03:41.383632Z","time spent":"376.580694ms","remote":"127.0.0.1:51222","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-11T11:03:41.780088Z","caller":"traceutil/trace.go:171","msg":"trace[1902188630] linearizableReadLoop","detail":"{readStateIndex:2717; appliedIndex:2714; }","duration":"366.393762ms","start":"2026-08-11T11:03:41.413661Z","end":"2026-08-11T11:03:41.780055Z","steps":["trace[1902188630] 'read index received' (duration: 339.730771ms)","trace[1902188630] 'applied index is now lower than readState.Index' (duration: 26.661101ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:03:41.780519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.830526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-08-11T11:03:41.780575Z","caller":"traceutil/trace.go:171","msg":"trace[1984741310] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2626; }","duration":"366.953619ms","start":"2026-08-11T11:03:41.413609Z","end":"2026-08-11T11:03:41.780563Z","steps":["trace[1984741310] 'agreement among raft nodes before linearized reading' (duration: 366.671781ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:03:41.780659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:03:41.413584Z","time spent":"367.064052ms","remote":"127.0.0.1:51158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-08-11T11:04:06.708242Z","caller":"traceutil/trace.go:171","msg":"trace[1528393227] linearizableReadLoop","detail":"{readStateIndex:2857; appliedIndex:2856; }","duration":"102.450707ms","start":"2026-08-11T11:04:06.605763Z","end":"2026-08-11T11:04:06.708214Z","steps":["trace[1528393227] 'read index received' (duration: 90.436909ms)","trace[1528393227] 'applied index is now lower than readState.Index' (duration: 12.012658ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:04:06.70839Z","caller":"traceutil/trace.go:171","msg":"trace[289898787] transaction","detail":"{read_only:false; response_revision:2759; number_of_response:1; }","duration":"139.266503ms","start":"2026-08-11T11:04:06.56911Z","end":"2026-08-11T11:04:06.708376Z","steps":["trace[289898787] 'process raft request' (duration: 127.176393ms)","trace[289898787] 'compare' (duration: 11.592387ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:04:06.708764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.968821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-11T11:04:06.708816Z","caller":"traceutil/trace.go:171","msg":"trace[457561886] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2759; }","duration":"103.102485ms","start":"2026-08-11T11:04:06.605701Z","end":"2026-08-11T11:04:06.708803Z","steps":["trace[457561886] 'agreement among raft nodes before linearized reading' (duration: 102.8989ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:04:06.709526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.454514ms","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-11T11:04:06.709675Z","caller":"traceutil/trace.go:171","msg":"trace[323341374] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2759; }","duration":"103.614818ms","start":"2026-08-11T11:04:06.606041Z","end":"2026-08-11T11:04:06.709655Z","steps":["trace[323341374] 'agreement among raft nodes before linearized reading' (duration: 102.881549ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:04:06.908232Z","caller":"traceutil/trace.go:171","msg":"trace[772756760] transaction","detail":"{read_only:false; response_revision:2760; number_of_response:1; }","duration":"189.713561ms","start":"2026-08-11T11:04:06.71848Z","end":"2026-08-11T11:04:06.908204Z","steps":["trace[772756760] 'process raft request' (duration: 189.211458ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:04:06.91334Z","caller":"traceutil/trace.go:171","msg":"trace[789857872] transaction","detail":"{read_only:false; response_revision:2761; number_of_response:1; }","duration":"194.616621ms","start":"2026-08-11T11:04:06.718698Z","end":"2026-08-11T11:04:06.913315Z","steps":["trace[789857872] 'process raft request' (duration: 194.480408ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:07:53.319807Z","caller":"traceutil/trace.go:171","msg":"trace[1816242026] transaction","detail":"{read_only:false; response_revision:4509; number_of_response:1; }","duration":"144.254811ms","start":"2026-08-11T11:07:53.175528Z","end":"2026-08-11T11:07:53.319783Z","steps":["trace[1816242026] 'process raft request' (duration: 102.361846ms)","trace[1816242026] 'compare' (duration: 41.799493ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:07:53.323233Z","caller":"traceutil/trace.go:171","msg":"trace[81164720] linearizableReadLoop","detail":"{readStateIndex:4680; appliedIndex:4676; }","duration":"143.682994ms","start":"2026-08-11T11:07:53.179525Z","end":"2026-08-11T11:07:53.323208Z","steps":["trace[81164720] 'read index received' (duration: 98.37962ms)","trace[81164720] 'applied index is now lower than readState.Index' (duration: 45.301794ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:07:53.325108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.54549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-08-11T11:07:53.326555Z","caller":"traceutil/trace.go:171","msg":"trace[1121211863] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4512; }","duration":"147.055321ms","start":"2026-08-11T11:07:53.179461Z","end":"2026-08-11T11:07:53.326516Z","steps":["trace[1121211863] 'agreement among raft nodes before linearized reading' (duration: 144.131769ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:07:53.323589Z","caller":"traceutil/trace.go:171","msg":"trace[1991380764] transaction","detail":"{read_only:false; response_revision:4510; number_of_response:1; }","duration":"147.997835ms","start":"2026-08-11T11:07:53.17553Z","end":"2026-08-11T11:07:53.323528Z","steps":["trace[1991380764] 'process raft request' (duration: 146.94425ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:07:53.32346Z","caller":"traceutil/trace.go:171","msg":"trace[53954749] transaction","detail":"{read_only:false; response_revision:4511; number_of_response:1; }","duration":"147.342226ms","start":"2026-08-11T11:07:53.176079Z","end":"2026-08-11T11:07:53.323422Z","steps":["trace[53954749] 'process raft request' (duration: 146.823138ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:07:53.323978Z","caller":"traceutil/trace.go:171","msg":"trace[522135064] transaction","detail":"{read_only:false; response_revision:4512; number_of_response:1; }","duration":"147.762201ms","start":"2026-08-11T11:07:53.176159Z","end":"2026-08-11T11:07:53.323922Z","steps":["trace[522135064] 'process raft request' (duration: 146.822159ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:07:58.690832Z","caller":"traceutil/trace.go:171","msg":"trace[1667431041] transaction","detail":"{read_only:false; response_revision:4662; number_of_response:1; }","duration":"121.513701ms","start":"2026-08-11T11:07:58.569294Z","end":"2026-08-11T11:07:58.690808Z","steps":["trace[1667431041] 'process raft request' (duration: 121.350499ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:07:58.698276Z","caller":"traceutil/trace.go:171","msg":"trace[360716633] transaction","detail":"{read_only:false; response_revision:4663; number_of_response:1; }","duration":"121.831345ms","start":"2026-08-11T11:07:58.576409Z","end":"2026-08-11T11:07:58.69824Z","steps":["trace[360716633] 'process raft request' (duration: 121.695524ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:08:04.176652Z","caller":"traceutil/trace.go:171","msg":"trace[2113062833] transaction","detail":"{read_only:false; response_revision:4771; number_of_response:1; }","duration":"174.734865ms","start":"2026-08-11T11:08:04.001884Z","end":"2026-08-11T11:08:04.176619Z","steps":["trace[2113062833] 'process raft request' (duration: 108.103427ms)","trace[2113062833] 'compare' (duration: 66.07769ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:08:04.569041Z","caller":"traceutil/trace.go:171","msg":"trace[1718101707] transaction","detail":"{read_only:false; response_revision:4780; number_of_response:1; }","duration":"222.322372ms","start":"2026-08-11T11:08:04.346692Z","end":"2026-08-11T11:08:04.569015Z","steps":["trace[1718101707] 'process raft request' (duration: 222.224161ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:08:04.569127Z","caller":"traceutil/trace.go:171","msg":"trace[1426477913] linearizableReadLoop","detail":"{readStateIndex:4958; appliedIndex:4955; }","duration":"185.247814ms","start":"2026-08-11T11:08:04.38387Z","end":"2026-08-11T11:08:04.569117Z","steps":["trace[1426477913] 'read index received' (duration: 184.92732ms)","trace[1426477913] 'applied index is now lower than readState.Index' (duration: 318.844µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:08:04.569201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.323215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T11:08:04.569235Z","caller":"traceutil/trace.go:171","msg":"trace[2014630877] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:4781; }","duration":"185.421327ms","start":"2026-08-11T11:08:04.383802Z","end":"2026-08-11T11:08:04.569223Z","steps":["trace[2014630877] 'agreement among raft nodes before linearized reading' (duration: 185.344606ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:08:04.569071Z","caller":"traceutil/trace.go:171","msg":"trace[2144310162] transaction","detail":"{read_only:false; response_revision:4779; number_of_response:1; }","duration":"222.577225ms","start":"2026-08-11T11:08:04.346471Z","end":"2026-08-11T11:08:04.569049Z","steps":["trace[2144310162] 'process raft request' (duration: 222.298622ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:08:04.569308Z","caller":"traceutil/trace.go:171","msg":"trace[1944665444] transaction","detail":"{read_only:false; response_revision:4781; number_of_response:1; }","duration":"222.519414ms","start":"2026-08-11T11:08:04.34675Z","end":"2026-08-11T11:08:04.56927Z","steps":["trace[1944665444] 'process raft request' (duration: 222.21932ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:08:20.010546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.130661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T11:08:20.010643Z","caller":"traceutil/trace.go:171","msg":"trace[1960016046] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4975; }","duration":"287.453427ms","start":"2026-08-11T11:08:19.723165Z","end":"2026-08-11T11:08:20.010618Z","steps":["trace[1960016046] 'range keys from in-memory index tree' (duration: 286.629734ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:08:20.010901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.653499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-11T11:08:20.010928Z","caller":"traceutil/trace.go:171","msg":"trace[829572334] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4975; }","duration":"259.72668ms","start":"2026-08-11T11:08:19.751195Z","end":"2026-08-11T11:08:20.010922Z","steps":["trace[829572334] 'range keys from in-memory index tree' (duration: 259.530307ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:08:20.011059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.026466ms","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-11T11:08:20.011083Z","caller":"traceutil/trace.go:171","msg":"trace[757537683] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4975; }","duration":"253.101406ms","start":"2026-08-11T11:08:19.757975Z","end":"2026-08-11T11:08:20.011077Z","steps":["trace[757537683] 'range keys from in-memory index tree' (duration: 252.913054ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:09:32.481752Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2892} {"level":"info","ts":"2026-08-11T11:09:32.575629Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2892,"took":"91.857034ms","hash":3907675080,"current-db-size-bytes":53166080,"current-db-size":"53 MB","current-db-size-in-use-bytes":29364224,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-11T11:09:32.575705Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3907675080,"revision":2892,"compact-revision":-1} {"level":"warn","ts":"2026-08-11T11:13:02.685617Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":199741613679927354,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T11:13:03.185893Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":199741613679927354,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T11:13:03.686911Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":199741613679927354,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T11:13:04.416254Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":199741613679927354,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T11:13:04.416789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.21965286s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-11T11:13:04.41686Z","caller":"traceutil/trace.go:171","msg":"trace[2091596654] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.219719102s","start":"2026-08-11T11:13:02.1971Z","end":"2026-08-11T11:13:04.416819Z","steps":["trace[2091596654] 'agreement among raft nodes before linearized reading' (duration: 2.219660401s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:13:04.416963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:13:02.197095Z","time spent":"2.219817454s","remote":"127.0.0.1:50972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/11 11:13:04 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-11T11:13:04.435096Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.762868879s","expected-duration":"1s"} {"level":"info","ts":"2026-08-11T11:13:04.454597Z","caller":"traceutil/trace.go:171","msg":"trace[1327646061] transaction","detail":"{read_only:false; response_revision:6946; number_of_response:1; }","duration":"2.003540288s","start":"2026-08-11T11:13:02.451032Z","end":"2026-08-11T11:13:04.454573Z","steps":["trace[1327646061] 'process raft request' (duration: 2.003482187s)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:13:04.454632Z","caller":"traceutil/trace.go:171","msg":"trace[1207826328] transaction","detail":"{read_only:false; response_revision:6945; number_of_response:1; }","duration":"2.26101742s","start":"2026-08-11T11:13:02.193582Z","end":"2026-08-11T11:13:04.454599Z","steps":["trace[1207826328] 'process raft request' (duration: 2.260778214s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:13:04.45475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:13:02.451004Z","time spent":"2.003663031s","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T11:13:04.454793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:13:02.193562Z","time spent":"2.261146682s","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T11:13:04.454917Z","caller":"traceutil/trace.go:171","msg":"trace[575899418] transaction","detail":"{read_only:false; response_revision:6947; number_of_response:1; }","duration":"2.003230651s","start":"2026-08-11T11:13:02.451679Z","end":"2026-08-11T11:13:04.45491Z","steps":["trace[575899418] 'process raft request' (duration: 2.002866442s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:13:04.45498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:13:02.451668Z","time spent":"2.003291672s","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T11:13:04.455091Z","caller":"traceutil/trace.go:171","msg":"trace[2009463368] transaction","detail":"{read_only:false; response_revision:6948; number_of_response:1; }","duration":"1.779868647s","start":"2026-08-11T11:13:02.675216Z","end":"2026-08-11T11:13:04.455085Z","steps":["trace[2009463368] 'process raft request' (duration: 1.779658412s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:13:04.455129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:13:02.675188Z","time spent":"1.779923668s","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T11:13:04.455164Z","caller":"traceutil/trace.go:171","msg":"trace[557574256] linearizableReadLoop","detail":"{readStateIndex:7197; appliedIndex:7192; }","duration":"2.269655134s","start":"2026-08-11T11:13:02.185389Z","end":"2026-08-11T11:13:04.455045Z","steps":["trace[557574256] 'read index received' (duration: 2.251441983s)","trace[557574256] 'applied index is now lower than readState.Index' (duration: 18.212421ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:13:04.455307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.2699169s","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-11T11:13:04.45534Z","caller":"traceutil/trace.go:171","msg":"trace[476844862] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6948; }","duration":"2.269970821s","start":"2026-08-11T11:13:02.185361Z","end":"2026-08-11T11:13:04.455331Z","steps":["trace[476844862] 'agreement among raft nodes before linearized reading' (duration: 2.269880419s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:13:04.455361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:13:02.185347Z","time spent":"2.270009432s","remote":"127.0.0.1:51222","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-11T11:13:04.455383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.26995182s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-11T11:13:04.455426Z","caller":"traceutil/trace.go:171","msg":"trace[645660203] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6948; }","duration":"2.270001112s","start":"2026-08-11T11:13:02.185412Z","end":"2026-08-11T11:13:04.455413Z","steps":["trace[645660203] 'agreement among raft nodes before linearized reading' (duration: 2.269864839s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:13:04.455467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:13:02.18541Z","time spent":"2.270047224s","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-11T11:13:04.455485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.712883059s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/horizon-6dc47b9dd7-w5mgx\" ","response":"range_response_count:1 size:9700"} {"level":"info","ts":"2026-08-11T11:13:04.455505Z","caller":"traceutil/trace.go:171","msg":"trace[630789762] range","detail":"{range_begin:/registry/pods/openstack/horizon-6dc47b9dd7-w5mgx; range_end:; response_count:1; response_revision:6948; }","duration":"1.712929019s","start":"2026-08-11T11:13:02.742571Z","end":"2026-08-11T11:13:04.4555Z","steps":["trace[630789762] 'agreement among raft nodes before linearized reading' (duration: 1.712866417s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:13:04.455526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:13:02.742553Z","time spent":"1.712965991s","remote":"127.0.0.1:51156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":9723,"request content":"key:\"/registry/pods/openstack/horizon-6dc47b9dd7-w5mgx\" "} {"level":"warn","ts":"2026-08-11T11:13:04.455596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.25896057s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-08-11T11:13:04.455632Z","caller":"traceutil/trace.go:171","msg":"trace[1895518451] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6948; }","duration":"2.259018562s","start":"2026-08-11T11:13:02.196602Z","end":"2026-08-11T11:13:04.455621Z","steps":["trace[1895518451] 'agreement among raft nodes before linearized reading' (duration: 2.25893762s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:13:04.45566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:13:02.196575Z","time spent":"2.259077494s","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-11T11:13:04.455913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.269651934s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-11T11:13:04.455954Z","caller":"traceutil/trace.go:171","msg":"trace[974044210] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6948; }","duration":"2.269695614s","start":"2026-08-11T11:13:02.186246Z","end":"2026-08-11T11:13:04.455941Z","steps":["trace[974044210] 'agreement among raft nodes before linearized reading' (duration: 2.269609872s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:13:04.455981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:13:02.18624Z","time spent":"2.269734965s","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-11T11:13:04.456039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.266230903s","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-11T11:13:04.456072Z","caller":"traceutil/trace.go:171","msg":"trace[440922135] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6948; }","duration":"2.266277584s","start":"2026-08-11T11:13:02.189787Z","end":"2026-08-11T11:13:04.456065Z","steps":["trace[440922135] 'agreement among raft nodes before linearized reading' (duration: 2.266200842s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:13:04.456091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:13:02.189782Z","time spent":"2.266304485s","remote":"127.0.0.1:51222","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-11T11:13:04.456084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.642141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T11:13:04.45612Z","caller":"traceutil/trace.go:171","msg":"trace[1551441470] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:6948; }","duration":"395.727433ms","start":"2026-08-11T11:13:04.060384Z","end":"2026-08-11T11:13:04.456112Z","steps":["trace[1551441470] 'agreement among raft nodes before linearized reading' (duration: 395.665842ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:13:04.456151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:13:04.06036Z","time spent":"395.785634ms","remote":"127.0.0.1:51354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-08-11T11:13:04.456158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.269095451s","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-11T11:13:04.456326Z","caller":"traceutil/trace.go:171","msg":"trace[324413647] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6948; }","duration":"2.269278285s","start":"2026-08-11T11:13:02.187012Z","end":"2026-08-11T11:13:04.45629Z","steps":["trace[324413647] 'agreement among raft nodes before linearized reading' (duration: 2.269079141s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:13:04.456366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:13:02.186996Z","time spent":"2.269356697s","remote":"127.0.0.1:54740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-08-11T11:13:04.457733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.27032459s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-11T11:13:04.45839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"927.026514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/horizon-6dc47b9dd7-5ppq9.18cabbddd2545554\" ","response":"range_response_count:1 size:856"} {"level":"info","ts":"2026-08-11T11:13:04.459363Z","caller":"traceutil/trace.go:171","msg":"trace[1058572164] range","detail":"{range_begin:/registry/events/openstack/horizon-6dc47b9dd7-5ppq9.18cabbddd2545554; range_end:; response_count:1; response_revision:6948; }","duration":"928.023837ms","start":"2026-08-11T11:13:03.531316Z","end":"2026-08-11T11:13:04.45934Z","steps":["trace[1058572164] 'agreement among raft nodes before linearized reading' (duration: 924.460224ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:13:04.460287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:13:03.531299Z","time spent":"928.96865ms","remote":"127.0.0.1:51052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":879,"request content":"key:\"/registry/events/openstack/horizon-6dc47b9dd7-5ppq9.18cabbddd2545554\" "} {"level":"info","ts":"2026-08-11T11:13:04.458827Z","caller":"traceutil/trace.go:171","msg":"trace[1096970386] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:6948; }","duration":"2.271820366s","start":"2026-08-11T11:13:02.186975Z","end":"2026-08-11T11:13:04.458795Z","steps":["trace[1096970386] 'agreement among raft nodes before linearized reading' (duration: 2.268884816s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:13:04.462758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:13:02.186971Z","time spent":"2.2757774s","remote":"127.0.0.1:51414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":6,"response size":30,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-08-11T11:14:33.222237Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":199741613679928637,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T11:14:33.722813Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":199741613679928637,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T11:14:34.544225Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":199741613679928637,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T11:14:34.723566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.001376226s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-11T11:14:34.723651Z","caller":"traceutil/trace.go:171","msg":"trace[1385719451] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001513678s","start":"2026-08-11T11:14:32.722121Z","end":"2026-08-11T11:14:34.723635Z","steps":["trace[1385719451] 'agreement among raft nodes before linearized reading' (duration: 2.001401026s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:14:34.723811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:32.722103Z","time spent":"2.001697533s","remote":"127.0.0.1:50972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-11T11:14:35.048443Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":199741613679928637,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T11:14:35.549099Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":199741613679928637,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T11:14:35.681393Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.979184746s","expected-duration":"1s"} {"level":"info","ts":"2026-08-11T11:14:35.682076Z","caller":"traceutil/trace.go:171","msg":"trace[1745380856] transaction","detail":"{read_only:false; response_revision:7412; number_of_response:1; }","duration":"2.979911592s","start":"2026-08-11T11:14:32.702129Z","end":"2026-08-11T11:14:35.682041Z","steps":["trace[1745380856] 'process raft request' (duration: 2.979644956s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:14:35.682369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:32.70211Z","time spent":"2.980040165s","remote":"127.0.0.1:50984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":25,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T11:14:35.684841Z","caller":"traceutil/trace.go:171","msg":"trace[607213345] transaction","detail":"{read_only:false; response_revision:7413; number_of_response:1; }","duration":"2.849587926s","start":"2026-08-11T11:14:32.835233Z","end":"2026-08-11T11:14:35.684821Z","steps":["trace[607213345] 'process raft request' (duration: 2.849402802s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:14:35.684987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:32.835203Z","time spent":"2.849701168s","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T11:14:35.685321Z","caller":"traceutil/trace.go:171","msg":"trace[1959080598] linearizableReadLoop","detail":"{readStateIndex:7683; appliedIndex:7678; }","duration":"2.963143614s","start":"2026-08-11T11:14:32.722155Z","end":"2026-08-11T11:14:35.685299Z","steps":["trace[1959080598] 'read index received' (duration: 2.959477998s)","trace[1959080598] 'applied index is now lower than readState.Index' (duration: 3.664336ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:14:35.685412Z","caller":"traceutil/trace.go:171","msg":"trace[618326962] transaction","detail":"{read_only:false; response_revision:7414; number_of_response:1; }","duration":"2.847099194s","start":"2026-08-11T11:14:32.8383Z","end":"2026-08-11T11:14:35.6854Z","steps":["trace[618326962] 'process raft request' (duration: 2.846480671s)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:14:35.685449Z","caller":"traceutil/trace.go:171","msg":"trace[1187679367] transaction","detail":"{read_only:false; response_revision:7415; number_of_response:1; }","duration":"2.847048712s","start":"2026-08-11T11:14:32.838391Z","end":"2026-08-11T11:14:35.685439Z","steps":["trace[1187679367] 'process raft request' (duration: 2.846794447s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:14:35.685475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:32.838286Z","time spent":"2.847148875s","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T11:14:35.685498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:32.83838Z","time spent":"2.847091564s","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T11:14:35.685559Z","caller":"traceutil/trace.go:171","msg":"trace[809800564] transaction","detail":"{read_only:false; response_revision:7416; number_of_response:1; }","duration":"2.847150925s","start":"2026-08-11T11:14:32.838398Z","end":"2026-08-11T11:14:35.685549Z","steps":["trace[809800564] 'process raft request' (duration: 2.846857799s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:14:35.685616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:32.838375Z","time spent":"2.847211146s","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T11:14:35.688171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.908373197s","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-11T11:14:35.68822Z","caller":"traceutil/trace.go:171","msg":"trace[1500457856] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:7416; }","duration":"2.908456498s","start":"2026-08-11T11:14:32.779753Z","end":"2026-08-11T11:14:35.688209Z","steps":["trace[1500457856] 'agreement among raft nodes before linearized reading' (duration: 2.908376176s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:14:35.68825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:32.779738Z","time spent":"2.908505249s","remote":"127.0.0.1:51410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-08-11T11:14:35.688428Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5562} {"level":"warn","ts":"2026-08-11T11:14:35.691827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.58919159s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-11T11:14:35.691881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.871871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T11:14:35.691889Z","caller":"traceutil/trace.go:171","msg":"trace[1676168957] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:7416; }","duration":"1.589293892s","start":"2026-08-11T11:14:34.102581Z","end":"2026-08-11T11:14:35.691875Z","steps":["trace[1676168957] 'agreement among raft nodes before linearized reading' (duration: 1.589159419s)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:14:35.691911Z","caller":"traceutil/trace.go:171","msg":"trace[447004349] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:7416; }","duration":"431.936544ms","start":"2026-08-11T11:14:35.259965Z","end":"2026-08-11T11:14:35.691901Z","steps":["trace[447004349] 'agreement among raft nodes before linearized reading' (duration: 431.857452ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:14:35.691924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:34.102535Z","time spent":"1.589380304s","remote":"127.0.0.1:51216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-08-11T11:14:35.691937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:35.259945Z","time spent":"431.986404ms","remote":"127.0.0.1:60018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":32,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true "} {"level":"warn","ts":"2026-08-11T11:14:35.692112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.141025589s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-11T11:14:35.692457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.77467205s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-08-11T11:14:35.692436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"967.817493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T11:14:35.692499Z","caller":"traceutil/trace.go:171","msg":"trace[923301580] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7416; }","duration":"2.774735751s","start":"2026-08-11T11:14:32.91775Z","end":"2026-08-11T11:14:35.692486Z","steps":["trace[923301580] 'agreement among raft nodes before linearized reading' (duration: 2.774643589s)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:14:35.692518Z","caller":"traceutil/trace.go:171","msg":"trace[1464806668] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7416; }","duration":"967.982085ms","start":"2026-08-11T11:14:34.724515Z","end":"2026-08-11T11:14:35.692497Z","steps":["trace[1464806668] 'agreement among raft nodes before linearized reading' (duration: 967.826372ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:14:35.692557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.678112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1986"} {"level":"warn","ts":"2026-08-11T11:14:35.692566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:34.724499Z","time spent":"968.058948ms","remote":"127.0.0.1:50982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-11T11:14:35.692586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.771373161s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-11T11:14:35.69259Z","caller":"traceutil/trace.go:171","msg":"trace[1661318431] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:7416; }","duration":"366.752264ms","start":"2026-08-11T11:14:35.32583Z","end":"2026-08-11T11:14:35.692582Z","steps":["trace[1661318431] 'agreement among raft nodes before linearized reading' (duration: 366.465958ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:14:35.692606Z","caller":"traceutil/trace.go:171","msg":"trace[1866802874] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7416; }","duration":"2.771392391s","start":"2026-08-11T11:14:32.921207Z","end":"2026-08-11T11:14:35.6926Z","steps":["trace[1866802874] 'agreement among raft nodes before linearized reading' (duration: 2.77133621s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:14:35.692617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:35.3258Z","time spent":"366.812165ms","remote":"127.0.0.1:51158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2009,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-08-11T11:14:35.692625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:32.921156Z","time spent":"2.771464404s","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-11T11:14:35.692639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.779490661s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-11T11:14:35.692468Z","caller":"traceutil/trace.go:171","msg":"trace[724970446] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:7416; }","duration":"1.141414817s","start":"2026-08-11T11:14:34.551021Z","end":"2026-08-11T11:14:35.692435Z","steps":["trace[724970446] 'agreement among raft nodes before linearized reading' (duration: 1.140965888s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:14:35.692153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.769285968s","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-11T11:14:35.692775Z","caller":"traceutil/trace.go:171","msg":"trace[309255525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7416; }","duration":"2.769926512s","start":"2026-08-11T11:14:32.92284Z","end":"2026-08-11T11:14:35.692766Z","steps":["trace[309255525] 'agreement among raft nodes before linearized reading' (duration: 2.769184216s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:14:35.69274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:34.550965Z","time spent":"1.141752345s","remote":"127.0.0.1:54740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-08-11T11:14:35.692528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:32.917741Z","time spent":"2.774781632s","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-11T11:14:35.692809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:32.922833Z","time spent":"2.769967182s","remote":"127.0.0.1:51222","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-11T11:14:35.692209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.589756861s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T11:14:35.692902Z","caller":"traceutil/trace.go:171","msg":"trace[555536756] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:7416; }","duration":"1.590481306s","start":"2026-08-11T11:14:34.10241Z","end":"2026-08-11T11:14:35.692891Z","steps":["trace[555536756] 'agreement among raft nodes before linearized reading' (duration: 1.589767981s)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:14:35.692672Z","caller":"traceutil/trace.go:171","msg":"trace[690948487] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7416; }","duration":"2.779557683s","start":"2026-08-11T11:14:32.913105Z","end":"2026-08-11T11:14:35.692663Z","steps":["trace[690948487] 'agreement among raft nodes before linearized reading' (duration: 2.7794755s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:14:35.692936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:32.913085Z","time spent":"2.779844968s","remote":"127.0.0.1:51222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-11T11:14:35.692262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.750379655s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T11:14:35.693022Z","caller":"traceutil/trace.go:171","msg":"trace[1368507719] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:7416; }","duration":"2.751149681s","start":"2026-08-11T11:14:32.941848Z","end":"2026-08-11T11:14:35.692998Z","steps":["trace[1368507719] 'agreement among raft nodes before linearized reading' (duration: 2.750379065s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:14:35.693138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:32.941837Z","time spent":"2.751253873s","remote":"127.0.0.1:51186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-08-11T11:14:35.692938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:34.102393Z","time spent":"1.590535438s","remote":"127.0.0.1:55314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-11T11:14:35.692368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.769450282s","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-11T11:14:35.69344Z","caller":"traceutil/trace.go:171","msg":"trace[1541031995] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7416; }","duration":"2.770548934s","start":"2026-08-11T11:14:32.922884Z","end":"2026-08-11T11:14:35.693432Z","steps":["trace[1541031995] 'agreement among raft nodes before linearized reading' (duration: 2.76940498s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:14:35.693468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:32.922873Z","time spent":"2.770586896s","remote":"127.0.0.1:51222","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-11T11:14:35.692255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.148179177s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130620"} {"level":"info","ts":"2026-08-11T11:14:35.693602Z","caller":"traceutil/trace.go:171","msg":"trace[1437652631] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:7416; }","duration":"1.149563506s","start":"2026-08-11T11:14:34.54403Z","end":"2026-08-11T11:14:35.693593Z","steps":["trace[1437652631] 'agreement among raft nodes before linearized reading' (duration: 1.148071966s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:14:35.693632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:34.54401Z","time spent":"1.149615067s","remote":"127.0.0.1:51042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":130643,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-08-11T11:14:35.697395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.145606424s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-08-11T11:14:35.697441Z","caller":"traceutil/trace.go:171","msg":"trace[795130477] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:7416; }","duration":"1.145704426s","start":"2026-08-11T11:14:34.551726Z","end":"2026-08-11T11:14:35.69743Z","steps":["trace[795130477] 'agreement among raft nodes before linearized reading' (duration: 1.144662054s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:14:35.69747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:14:34.551683Z","time spent":"1.145780607s","remote":"127.0.0.1:51046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":141,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-08-11T11:14:35.787911Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5562,"took":"97.939455ms","hash":1826705578,"current-db-size-bytes":53166080,"current-db-size":"53 MB","current-db-size-in-use-bytes":18481152,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-11T11:14:35.787996Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1826705578,"revision":5562,"compact-revision":2892}