{"level":"warn","ts":"2026-08-17T10:10:53.414493Z","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-17T10:10:53.414574Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.80: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.80:2380","--initial-cluster=instance=https://199.19.213.80:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.80:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.80: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-17T10:10:53.414719Z","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-17T10:10:53.414734Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.80:2380"]} {"level":"info","ts":"2026-08-17T10:10:53.414796Z","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-17T10:10:53.415442Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.80:2379"]} {"level":"info","ts":"2026-08-17T10:10:53.415563Z","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.80:2380"],"listen-peer-urls":["https://199.19.213.80:2380"],"advertise-client-urls":["https://199.19.213.80:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.80:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.80: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-17T10:10:53.420516Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.709273ms"} {"level":"info","ts":"2026-08-17T10:10:53.42952Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"95f079218969d088","cluster-id":"4cb7d1aa36c4178f"} {"level":"info","ts":"2026-08-17T10:10:53.429582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 switched to configuration voters=()"} {"level":"info","ts":"2026-08-17T10:10:53.429597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 became follower at term 0"} {"level":"info","ts":"2026-08-17T10:10:53.42968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 95f079218969d088 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-17T10:10:53.429687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 became follower at term 1"} {"level":"info","ts":"2026-08-17T10:10:53.429761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 switched to configuration voters=(10804268691008114824)"} {"level":"warn","ts":"2026-08-17T10:10:53.439268Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-17T10:10:53.440521Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-17T10:10:53.441402Z","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-17T10:10:53.444176Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"95f079218969d088","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-17T10:10:53.444378Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"95f079218969d088","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-17T10:10:53.444455Z","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-17T10:10:53.444596Z","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-17T10:10:53.444637Z","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-17T10:10:53.445767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 switched to configuration voters=(10804268691008114824)"} {"level":"info","ts":"2026-08-17T10:10:53.446178Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4cb7d1aa36c4178f","local-member-id":"95f079218969d088","added-peer-id":"95f079218969d088","added-peer-peer-urls":["https://199.19.213.80:2380"]} {"level":"info","ts":"2026-08-17T10:10:53.449503Z","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-17T10:10:53.449986Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.80:2380"} {"level":"info","ts":"2026-08-17T10:10:53.450019Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.80:2380"} {"level":"info","ts":"2026-08-17T10:10:53.452089Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-17T10:10:53.452041Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"95f079218969d088","initial-advertise-peer-urls":["https://199.19.213.80:2380"],"listen-peer-urls":["https://199.19.213.80:2380"],"advertise-client-urls":["https://199.19.213.80:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.80:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-17T10:10:54.130256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 is starting a new election at term 1"} {"level":"info","ts":"2026-08-17T10:10:54.130307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-17T10:10:54.130345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 received MsgPreVoteResp from 95f079218969d088 at term 1"} {"level":"info","ts":"2026-08-17T10:10:54.130359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 became candidate at term 2"} {"level":"info","ts":"2026-08-17T10:10:54.130367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 received MsgVoteResp from 95f079218969d088 at term 2"} {"level":"info","ts":"2026-08-17T10:10:54.130378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"95f079218969d088 became leader at term 2"} {"level":"info","ts":"2026-08-17T10:10:54.130391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 95f079218969d088 elected leader 95f079218969d088 at term 2"} {"level":"info","ts":"2026-08-17T10:10:54.131226Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-17T10:10:54.131763Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"95f079218969d088","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.80:2379]}","request-path":"/0/members/95f079218969d088/attributes","cluster-id":"4cb7d1aa36c4178f","publish-timeout":"7s"} {"level":"info","ts":"2026-08-17T10:10:54.131784Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-17T10:10:54.131795Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-17T10:10:54.132053Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-17T10:10:54.132068Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-17T10:10:54.132331Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4cb7d1aa36c4178f","local-member-id":"95f079218969d088","cluster-version":"3.5"} {"level":"info","ts":"2026-08-17T10:10:54.1324Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-17T10:10:54.132427Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-17T10:10:54.133861Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-17T10:10:54.133872Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.80:2379"} {"level":"info","ts":"2026-08-17T10:11:13.236002Z","caller":"traceutil/trace.go:171","msg":"trace[2026889318] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"240.576172ms","start":"2026-08-17T10:11:12.995398Z","end":"2026-08-17T10:11:13.235974Z","steps":["trace[2026889318] 'process raft request' (duration: 240.423167ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:11:13.751875Z","caller":"traceutil/trace.go:171","msg":"trace[1282271396] linearizableReadLoop","detail":"{readStateIndex:431; appliedIndex:430; }","duration":"115.740627ms","start":"2026-08-17T10:11:13.636111Z","end":"2026-08-17T10:11:13.751852Z","steps":["trace[1282271396] 'read index received' (duration: 115.51457ms)","trace[1282271396] 'applied index is now lower than readState.Index' (duration: 223.117µs)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:11:13.751943Z","caller":"traceutil/trace.go:171","msg":"trace[2037841296] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"178.402523ms","start":"2026-08-17T10:11:13.573505Z","end":"2026-08-17T10:11:13.751907Z","steps":["trace[2037841296] 'process raft request' (duration: 178.204667ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:11:13.75199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.866902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-17T10:11:13.752065Z","caller":"traceutil/trace.go:171","msg":"trace[1643415891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:417; }","duration":"115.982016ms","start":"2026-08-17T10:11:13.636069Z","end":"2026-08-17T10:11:13.752051Z","steps":["trace[1643415891] 'agreement among raft nodes before linearized reading' (duration: 115.875582ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:11:14.064901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.582275ms","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-17T10:11:14.065015Z","caller":"traceutil/trace.go:171","msg":"trace[1480068234] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:417; }","duration":"126.761631ms","start":"2026-08-17T10:11:13.938226Z","end":"2026-08-17T10:11:14.064988Z","steps":["trace[1480068234] 'range keys from in-memory index tree' (duration: 126.466651ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:11:29.122378Z","caller":"traceutil/trace.go:171","msg":"trace[244111704] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"108.541895ms","start":"2026-08-17T10:11:29.013821Z","end":"2026-08-17T10:11:29.122363Z","steps":["trace[244111704] 'process raft request' (duration: 108.453312ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:11:29.127443Z","caller":"traceutil/trace.go:171","msg":"trace[1821467537] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"112.617911ms","start":"2026-08-17T10:11:29.014792Z","end":"2026-08-17T10:11:29.12741Z","steps":["trace[1821467537] 'process raft request' (duration: 112.093202ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:11:29.127678Z","caller":"traceutil/trace.go:171","msg":"trace[1668894125] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"109.661645ms","start":"2026-08-17T10:11:29.017999Z","end":"2026-08-17T10:11:29.127661Z","steps":["trace[1668894125] 'process raft request' (duration: 108.93157ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:11:29.127832Z","caller":"traceutil/trace.go:171","msg":"trace[1601854892] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"108.092189ms","start":"2026-08-17T10:11:29.019733Z","end":"2026-08-17T10:11:29.127825Z","steps":["trace[1601854892] 'process raft request' (duration: 107.27374ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:11:29.12789Z","caller":"traceutil/trace.go:171","msg":"trace[1527828601] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"106.864286ms","start":"2026-08-17T10:11:29.021021Z","end":"2026-08-17T10:11:29.127885Z","steps":["trace[1527828601] 'process raft request' (duration: 106.016436ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:11:29.127948Z","caller":"traceutil/trace.go:171","msg":"trace[981962985] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"106.011145ms","start":"2026-08-17T10:11:29.021931Z","end":"2026-08-17T10:11:29.127942Z","steps":["trace[981962985] 'process raft request' (duration: 105.133274ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:11:35.134268Z","caller":"traceutil/trace.go:171","msg":"trace[1627698469] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"102.211848ms","start":"2026-08-17T10:11:35.03203Z","end":"2026-08-17T10:11:35.134242Z","steps":["trace[1627698469] 'read index received' (duration: 102.052922ms)","trace[1627698469] 'applied index is now lower than readState.Index' (duration: 157.866µs)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:11:35.134477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.399085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-17T10:11:35.13455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.420525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-17T10:11:35.134564Z","caller":"traceutil/trace.go:171","msg":"trace[1692920012] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:623; }","duration":"102.54236ms","start":"2026-08-17T10:11:35.032003Z","end":"2026-08-17T10:11:35.134546Z","steps":["trace[1692920012] 'agreement among raft nodes before linearized reading' (duration: 102.370334ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:11:35.134615Z","caller":"traceutil/trace.go:171","msg":"trace[40264522] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:623; }","duration":"102.530909ms","start":"2026-08-17T10:11:35.032068Z","end":"2026-08-17T10:11:35.134599Z","steps":["trace[40264522] 'agreement among raft nodes before linearized reading' (duration: 102.419805ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:11:35.134516Z","caller":"traceutil/trace.go:171","msg":"trace[16443066] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"150.979929ms","start":"2026-08-17T10:11:34.983375Z","end":"2026-08-17T10:11:35.134354Z","steps":["trace[16443066] 'process raft request' (duration: 150.72261ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:11:35.135083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.713486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-17T10:11:35.135152Z","caller":"traceutil/trace.go:171","msg":"trace[999779686] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:623; }","duration":"102.785999ms","start":"2026-08-17T10:11:35.032335Z","end":"2026-08-17T10:11:35.135121Z","steps":["trace[999779686] 'agreement among raft nodes before linearized reading' (duration: 102.715097ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:11:35.627736Z","caller":"traceutil/trace.go:171","msg":"trace[1557893488] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"311.884085ms","start":"2026-08-17T10:11:35.315827Z","end":"2026-08-17T10:11:35.627712Z","steps":["trace[1557893488] 'process raft request' (duration: 311.685458ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:11:35.628273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:11:35.315791Z","time spent":"312.01883ms","remote":"127.0.0.1:48876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-17T10:11:36.307124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.193265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-17T10:11:36.307151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.289267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fmspm\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-08-17T10:11:36.307215Z","caller":"traceutil/trace.go:171","msg":"trace[1334168883] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fmspm; range_end:; response_count:1; response_revision:625; }","duration":"600.428842ms","start":"2026-08-17T10:11:35.706769Z","end":"2026-08-17T10:11:36.307198Z","steps":["trace[1334168883] 'range keys from in-memory index tree' (duration: 600.118481ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:11:36.307215Z","caller":"traceutil/trace.go:171","msg":"trace[800508705] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:625; }","duration":"445.315989ms","start":"2026-08-17T10:11:35.861875Z","end":"2026-08-17T10:11:36.307191Z","steps":["trace[800508705] 'range keys from in-memory index tree' (duration: 445.018558ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:11:36.307255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:11:35.706737Z","time spent":"600.508944ms","remote":"127.0.0.1:48496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-fmspm\" "} {"level":"warn","ts":"2026-08-17T10:11:36.307281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:11:35.861854Z","time spent":"445.413983ms","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-17T10:11:36.307944Z","caller":"traceutil/trace.go:171","msg":"trace[2027324494] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"123.706717ms","start":"2026-08-17T10:11:36.184208Z","end":"2026-08-17T10:11:36.307915Z","steps":["trace[2027324494] 'read index received' (duration: 112.334382ms)","trace[2027324494] 'applied index is now lower than readState.Index' (duration: 11.371045ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:11:36.308234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.999137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-17T10:11:36.308321Z","caller":"traceutil/trace.go:171","msg":"trace[2117479536] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:626; }","duration":"124.150073ms","start":"2026-08-17T10:11:36.184159Z","end":"2026-08-17T10:11:36.308309Z","steps":["trace[2117479536] 'agreement among raft nodes before linearized reading' (duration: 123.892874ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:11:36.308525Z","caller":"traceutil/trace.go:171","msg":"trace[1511622953] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"261.02759ms","start":"2026-08-17T10:11:36.047479Z","end":"2026-08-17T10:11:36.308506Z","steps":["trace[1511622953] 'process raft request' (duration: 249.340144ms)","trace[1511622953] 'compare' (duration: 10.557685ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:11:36.821355Z","caller":"traceutil/trace.go:171","msg":"trace[421833085] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"107.731803ms","start":"2026-08-17T10:11:36.713593Z","end":"2026-08-17T10:11:36.821325Z","steps":["trace[421833085] 'process raft request' (duration: 107.532736ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:11:36.838208Z","caller":"traceutil/trace.go:171","msg":"trace[554289154] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"115.678823ms","start":"2026-08-17T10:11:36.722502Z","end":"2026-08-17T10:11:36.838181Z","steps":["trace[554289154] 'process raft request' (duration: 115.525688ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:11:38.003376Z","caller":"traceutil/trace.go:171","msg":"trace[1252865134] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"142.492071ms","start":"2026-08-17T10:11:37.860866Z","end":"2026-08-17T10:11:38.003358Z","steps":["trace[1252865134] 'process raft request' (duration: 142.380477ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:11:50.55835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.052261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-17T10:11:50.558504Z","caller":"traceutil/trace.go:171","msg":"trace[1568040721] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:782; }","duration":"183.231578ms","start":"2026-08-17T10:11:50.375241Z","end":"2026-08-17T10:11:50.558473Z","steps":["trace[1568040721] 'range keys from in-memory index tree' (duration: 182.830162ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:11:50.558519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.667951ms","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-17T10:11:50.55864Z","caller":"traceutil/trace.go:171","msg":"trace[983998228] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:782; }","duration":"179.843698ms","start":"2026-08-17T10:11:50.378767Z","end":"2026-08-17T10:11:50.558611Z","steps":["trace[983998228] 'range keys from in-memory index tree' (duration: 179.261976ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:12:22.174037Z","caller":"traceutil/trace.go:171","msg":"trace[1728023330] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"156.229606ms","start":"2026-08-17T10:12:22.017786Z","end":"2026-08-17T10:12:22.174016Z","steps":["trace[1728023330] 'process raft request' (duration: 155.992536ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:12:22.342515Z","caller":"traceutil/trace.go:171","msg":"trace[734410659] linearizableReadLoop","detail":"{readStateIndex:1231; appliedIndex:1230; }","duration":"163.808877ms","start":"2026-08-17T10:12:22.178678Z","end":"2026-08-17T10:12:22.342487Z","steps":["trace[734410659] 'read index received' (duration: 138.347315ms)","trace[734410659] 'applied index is now lower than readState.Index' (duration: 25.459921ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:12:22.342895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.080618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4dlkb\" ","response":"range_response_count:1 size:4128"} {"level":"info","ts":"2026-08-17T10:12:22.342997Z","caller":"traceutil/trace.go:171","msg":"trace[2053661107] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4dlkb; range_end:; response_count:1; response_revision:1194; }","duration":"164.236464ms","start":"2026-08-17T10:12:22.178733Z","end":"2026-08-17T10:12:22.34297Z","steps":["trace[2053661107] 'agreement among raft nodes before linearized reading' (duration: 163.949463ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:12:22.343515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.802847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:2929"} {"level":"info","ts":"2026-08-17T10:12:22.343576Z","caller":"traceutil/trace.go:171","msg":"trace[1682263829] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:1194; }","duration":"164.88496ms","start":"2026-08-17T10:12:22.178673Z","end":"2026-08-17T10:12:22.343558Z","steps":["trace[1682263829] 'agreement among raft nodes before linearized reading' (duration: 163.90763ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:13:09.070843Z","caller":"traceutil/trace.go:171","msg":"trace[182895550] linearizableReadLoop","detail":"{readStateIndex:1945; appliedIndex:1944; }","duration":"434.286856ms","start":"2026-08-17T10:13:08.636533Z","end":"2026-08-17T10:13:09.07082Z","steps":["trace[182895550] 'read index received' (duration: 392.479687ms)","trace[182895550] 'applied index is now lower than readState.Index' (duration: 41.806289ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:13:09.071176Z","caller":"traceutil/trace.go:171","msg":"trace[891305341] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"464.174092ms","start":"2026-08-17T10:13:08.606988Z","end":"2026-08-17T10:13:09.071162Z","steps":["trace[891305341] 'process raft request' (duration: 422.113842ms)","trace[891305341] 'compare' (duration: 41.436573ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:13:09.071381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.459533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-69e87d94-7fae-4ac9-83ca-385dd3b1aed3\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-08-17T10:13:09.071459Z","caller":"traceutil/trace.go:171","msg":"trace[1302507978] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-69e87d94-7fae-4ac9-83ca-385dd3b1aed3; range_end:; response_count:1; response_revision:1870; }","duration":"334.594598ms","start":"2026-08-17T10:13:08.736844Z","end":"2026-08-17T10:13:09.071439Z","steps":["trace[1302507978] 'agreement among raft nodes before linearized reading' (duration: 334.343028ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:13:09.071502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:13:08.73679Z","time spent":"334.702874ms","remote":"127.0.0.1:48496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-69e87d94-7fae-4ac9-83ca-385dd3b1aed3\" "} {"level":"warn","ts":"2026-08-17T10:13:09.071495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:13:08.606969Z","time spent":"464.247735ms","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-17T10:13:09.071532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.487139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-17T10:13:09.071499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.954864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-17T10:13:09.071594Z","caller":"traceutil/trace.go:171","msg":"trace[1242885437] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1870; }","duration":"435.118361ms","start":"2026-08-17T10:13:08.636457Z","end":"2026-08-17T10:13:09.071575Z","steps":["trace[1242885437] 'agreement among raft nodes before linearized reading' (duration: 434.972205ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:13:09.071635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:13:08.636425Z","time spent":"435.201225ms","remote":"127.0.0.1:48284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-17T10:13:09.07158Z","caller":"traceutil/trace.go:171","msg":"trace[1935927519] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1870; }","duration":"139.597514ms","start":"2026-08-17T10:13:08.931969Z","end":"2026-08-17T10:13:09.071566Z","steps":["trace[1935927519] 'agreement among raft nodes before linearized reading' (duration: 139.473349ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:13:09.071894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.527947ms","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-17T10:13:09.071988Z","caller":"traceutil/trace.go:171","msg":"trace[1198386439] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1870; }","duration":"121.664293ms","start":"2026-08-17T10:13:08.950303Z","end":"2026-08-17T10:13:09.071967Z","steps":["trace[1198386439] 'agreement among raft nodes before linearized reading' (duration: 121.12743ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:13:09.203701Z","caller":"traceutil/trace.go:171","msg":"trace[1564769145] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"126.766914ms","start":"2026-08-17T10:13:09.076909Z","end":"2026-08-17T10:13:09.203676Z","steps":["trace[1564769145] 'process raft request' (duration: 104.445544ms)","trace[1564769145] 'compare' (duration: 21.920513ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:13:09.204061Z","caller":"traceutil/trace.go:171","msg":"trace[167122924] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"126.386719ms","start":"2026-08-17T10:13:09.077615Z","end":"2026-08-17T10:13:09.204002Z","steps":["trace[167122924] 'process raft request' (duration: 126.021683ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:13:09.509871Z","caller":"traceutil/trace.go:171","msg":"trace[1794409905] linearizableReadLoop","detail":"{readStateIndex:1950; appliedIndex:1949; }","duration":"155.866136ms","start":"2026-08-17T10:13:09.353982Z","end":"2026-08-17T10:13:09.509848Z","steps":["trace[1794409905] 'read index received' (duration: 155.660128ms)","trace[1794409905] 'applied index is now lower than readState.Index' (duration: 205.148µs)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:13:09.509999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.002873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-17T10:13:09.510035Z","caller":"traceutil/trace.go:171","msg":"trace[510838869] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1875; }","duration":"156.097907ms","start":"2026-08-17T10:13:09.353925Z","end":"2026-08-17T10:13:09.510023Z","steps":["trace[510838869] 'agreement among raft nodes before linearized reading' (duration: 156.022024ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:13:09.510163Z","caller":"traceutil/trace.go:171","msg":"trace[1855648711] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"295.915972ms","start":"2026-08-17T10:13:09.214227Z","end":"2026-08-17T10:13:09.510143Z","steps":["trace[1855648711] 'process raft request' (duration: 295.489774ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:13:48.134895Z","caller":"traceutil/trace.go:171","msg":"trace[642039691] linearizableReadLoop","detail":"{readStateIndex:2217; appliedIndex:2216; }","duration":"297.531122ms","start":"2026-08-17T10:13:47.837319Z","end":"2026-08-17T10:13:48.13485Z","steps":["trace[642039691] 'read index received' (duration: 297.405382ms)","trace[642039691] 'applied index is now lower than readState.Index' (duration: 124.37µs)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:13:48.135148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.803581ms","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-17T10:13:48.135197Z","caller":"traceutil/trace.go:171","msg":"trace[885566784] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2134; }","duration":"297.914881ms","start":"2026-08-17T10:13:47.837264Z","end":"2026-08-17T10:13:48.135179Z","steps":["trace[885566784] 'agreement among raft nodes before linearized reading' (duration: 297.728751ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:13:48.135191Z","caller":"traceutil/trace.go:171","msg":"trace[1731459395] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"318.662152ms","start":"2026-08-17T10:13:47.816403Z","end":"2026-08-17T10:13:48.135065Z","steps":["trace[1731459395] 'process raft request' (duration: 318.260293ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:13:48.135496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:13:47.816388Z","time spent":"318.985852ms","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-17T10:13:49.454865Z","caller":"traceutil/trace.go:171","msg":"trace[2074539246] linearizableReadLoop","detail":"{readStateIndex:2222; appliedIndex:2221; }","duration":"184.831642ms","start":"2026-08-17T10:13:49.270004Z","end":"2026-08-17T10:13:49.454836Z","steps":["trace[2074539246] 'read index received' (duration: 184.689412ms)","trace[2074539246] 'applied index is now lower than readState.Index' (duration: 140.6µs)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:13:49.455068Z","caller":"traceutil/trace.go:171","msg":"trace[933624181] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"185.106151ms","start":"2026-08-17T10:13:49.269948Z","end":"2026-08-17T10:13:49.455054Z","steps":["trace[933624181] 'process raft request' (duration: 184.687042ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:13:49.45548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.446221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-17T10:13:49.455678Z","caller":"traceutil/trace.go:171","msg":"trace[140127802] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2139; }","duration":"185.702301ms","start":"2026-08-17T10:13:49.269958Z","end":"2026-08-17T10:13:49.45566Z","steps":["trace[140127802] 'agreement among raft nodes before linearized reading' (duration: 185.331301ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:13:49.7203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.655502ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-17T10:13:49.720546Z","caller":"traceutil/trace.go:171","msg":"trace[1572022783] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"260.427779ms","start":"2026-08-17T10:13:49.460089Z","end":"2026-08-17T10:13:49.720517Z","steps":["trace[1572022783] 'process raft request' (duration: 260.340339ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:13:49.720958Z","caller":"traceutil/trace.go:171","msg":"trace[44818596] linearizableReadLoop","detail":"{readStateIndex:2223; appliedIndex:2222; }","duration":"265.828562ms","start":"2026-08-17T10:13:49.455019Z","end":"2026-08-17T10:13:49.720848Z","steps":["trace[44818596] 'read index received' (duration: 80.475331ms)","trace[44818596] 'applied index is now lower than readState.Index' (duration: 185.348621ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:13:49.72117Z","caller":"traceutil/trace.go:171","msg":"trace[1084713930] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"388.71108ms","start":"2026-08-17T10:13:49.332423Z","end":"2026-08-17T10:13:49.721134Z","steps":["trace[1084713930] 'process raft request' (duration: 202.983799ms)","trace[1084713930] 'compare' (duration: 184.490182ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:13:49.721244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.30452ms","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-17T10:13:49.721283Z","caller":"traceutil/trace.go:171","msg":"trace[1367558327] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2141; }","duration":"340.38708ms","start":"2026-08-17T10:13:49.380885Z","end":"2026-08-17T10:13:49.721272Z","steps":["trace[1367558327] 'agreement among raft nodes before linearized reading' (duration: 340.26067ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:13:49.721322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:13:49.380864Z","time spent":"340.45004ms","remote":"127.0.0.1:48576","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-17T10:13:49.721362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:13:49.332396Z","time spent":"388.86898ms","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-17T10:13:49.721571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.531114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-17T10:13:49.72163Z","caller":"traceutil/trace.go:171","msg":"trace[738368454] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2141; }","duration":"344.694424ms","start":"2026-08-17T10:13:49.376918Z","end":"2026-08-17T10:13:49.721612Z","steps":["trace[738368454] 'agreement among raft nodes before linearized reading' (duration: 344.114695ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:13:49.722008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:13:49.376883Z","time spent":"344.941214ms","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-17T10:13:49.999211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.5098ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-17T10:13:50.000092Z","caller":"traceutil/trace.go:171","msg":"trace[281395463] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"196.134647ms","start":"2026-08-17T10:13:49.803898Z","end":"2026-08-17T10:13:50.000033Z","steps":["trace[281395463] 'process raft request' (duration: 41.713498ms)","trace[281395463] 'compare' (duration: 153.063741ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:15:12.000592Z","caller":"traceutil/trace.go:171","msg":"trace[1535051556] transaction","detail":"{read_only:false; response_revision:2693; number_of_response:1; }","duration":"154.105679ms","start":"2026-08-17T10:15:11.846459Z","end":"2026-08-17T10:15:12.000564Z","steps":["trace[1535051556] 'process raft request' (duration: 153.943726ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:15:12.199892Z","caller":"traceutil/trace.go:171","msg":"trace[612081413] transaction","detail":"{read_only:false; response_revision:2694; number_of_response:1; }","duration":"202.94161ms","start":"2026-08-17T10:15:11.996906Z","end":"2026-08-17T10:15:12.199847Z","steps":["trace[612081413] 'process raft request' (duration: 114.178002ms)","trace[612081413] 'compare' (duration: 88.554784ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:18:43.137181Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15026436143877036845,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-17T10:18:43.637627Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15026436143877036845,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-17T10:18:44.138219Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15026436143877036845,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-17T10:18:44.636903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000433818s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-17T10:18:44.636995Z","caller":"traceutil/trace.go:171","msg":"trace[1016637030] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000580023s","start":"2026-08-17T10:18:42.636395Z","end":"2026-08-17T10:18:44.636975Z","steps":["trace[1016637030] 'agreement among raft nodes before linearized reading' (duration: 2.000465429s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:44.637057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:42.636377Z","time spent":"2.000669357s","remote":"127.0.0.1:48284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/17 10:18:44 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-17T10:18:44.639091Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15026436143877036845,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-17T10:18:45.139816Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15026436143877036845,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-17T10:18:45.640918Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15026436143877036845,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-17T10:18:46.141951Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15026436143877036845,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-17T10:18:46.637491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000203779s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-17T10:18:46.637584Z","caller":"traceutil/trace.go:171","msg":"trace[1162132085] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000580202s","start":"2026-08-17T10:18:44.636983Z","end":"2026-08-17T10:18:46.637563Z","steps":["trace[1162132085] 'agreement among raft nodes before linearized reading' (duration: 2.000459538s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:46.637626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:44.636965Z","time spent":"2.000653495s","remote":"127.0.0.1:48298","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-17T10:18:46.642369Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15026436143877036845,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-17T10:18:46.926665Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.435106995s","expected-duration":"1s"} {"level":"info","ts":"2026-08-17T10:18:46.927047Z","caller":"traceutil/trace.go:171","msg":"trace[1985362989] transaction","detail":"{read_only:false; response_revision:4398; number_of_response:1; }","duration":"4.435675675s","start":"2026-08-17T10:18:42.491352Z","end":"2026-08-17T10:18:46.927028Z","steps":["trace[1985362989] 'process raft request' (duration: 4.435509919s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:46.927185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:42.491325Z","time spent":"4.435788919s","remote":"127.0.0.1:48818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15284,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-17T10:18:47.045939Z","caller":"traceutil/trace.go:171","msg":"trace[1189356660] transaction","detail":"{read_only:false; response_revision:4399; number_of_response:1; }","duration":"4.240919256s","start":"2026-08-17T10:18:42.804987Z","end":"2026-08-17T10:18:47.045907Z","steps":["trace[1189356660] 'process raft request' (duration: 4.240651936s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.046119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:42.804961Z","time spent":"4.241070841s","remote":"127.0.0.1:48576","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-17T10:18:47.046702Z","caller":"traceutil/trace.go:171","msg":"trace[1591373827] transaction","detail":"{read_only:false; response_revision:4400; number_of_response:1; }","duration":"4.139948296s","start":"2026-08-17T10:18:42.90673Z","end":"2026-08-17T10:18:47.046678Z","steps":["trace[1591373827] 'process raft request' (duration: 4.139090165s)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:18:47.047277Z","caller":"traceutil/trace.go:171","msg":"trace[361276110] transaction","detail":"{read_only:false; response_revision:4401; number_of_response:1; }","duration":"3.796475434s","start":"2026-08-17T10:18:43.250791Z","end":"2026-08-17T10:18:47.047266Z","steps":["trace[361276110] 'process raft request' (duration: 3.79582361s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.047353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:43.250771Z","time spent":"3.796537536s","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-17T10:18:47.047489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:42.906706Z","time spent":"4.14006463s","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-17T10:18:47.047566Z","caller":"traceutil/trace.go:171","msg":"trace[710461960] transaction","detail":"{read_only:false; response_revision:4402; number_of_response:1; }","duration":"3.676229604s","start":"2026-08-17T10:18:43.371328Z","end":"2026-08-17T10:18:47.047558Z","steps":["trace[710461960] 'process raft request' (duration: 3.675902812s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.047612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:43.371309Z","time spent":"3.676279455s","remote":"127.0.0.1:48576","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-17T10:18:47.047671Z","caller":"traceutil/trace.go:171","msg":"trace[282372236] transaction","detail":"{read_only:false; response_revision:4405; number_of_response:1; }","duration":"1.780341046s","start":"2026-08-17T10:18:45.267322Z","end":"2026-08-17T10:18:47.047663Z","steps":["trace[282372236] 'process raft request' (duration: 1.780214251s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.047712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:45.267298Z","time spent":"1.780395258s","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-17T10:18:47.047658Z","caller":"traceutil/trace.go:171","msg":"trace[2120989365] linearizableReadLoop","detail":"{readStateIndex:4577; appliedIndex:4566; }","duration":"4.411194821s","start":"2026-08-17T10:18:42.636448Z","end":"2026-08-17T10:18:47.047643Z","steps":["trace[2120989365] 'read index received' (duration: 4.2904315s)","trace[2120989365] 'applied index is now lower than readState.Index' (duration: 120.762571ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:18:47.047805Z","caller":"traceutil/trace.go:171","msg":"trace[1769309242] transaction","detail":"{read_only:false; response_revision:4404; number_of_response:1; }","duration":"1.986026199s","start":"2026-08-17T10:18:45.061737Z","end":"2026-08-17T10:18:47.047764Z","steps":["trace[1769309242] 'process raft request' (duration: 1.98576184s)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:18:47.047826Z","caller":"traceutil/trace.go:171","msg":"trace[257996410] transaction","detail":"{read_only:false; response_revision:4406; number_of_response:1; }","duration":"656.363276ms","start":"2026-08-17T10:18:46.391394Z","end":"2026-08-17T10:18:47.047757Z","steps":["trace[257996410] 'process raft request' (duration: 656.1824ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.047923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:45.061716Z","time spent":"1.986142904s","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-17T10:18:47.047612Z","caller":"traceutil/trace.go:171","msg":"trace[31893600] transaction","detail":"{read_only:false; response_revision:4403; number_of_response:1; }","duration":"3.294783737s","start":"2026-08-17T10:18:43.752813Z","end":"2026-08-17T10:18:47.047597Z","steps":["trace[31893600] 'process raft request' (duration: 3.294611621s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.048059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:46.391377Z","time spent":"656.573634ms","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-17T10:18:47.048163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.789343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-17T10:18:47.048183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.794457262s","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-17T10:18:47.048207Z","caller":"traceutil/trace.go:171","msg":"trace[529156517] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4407; }","duration":"3.794509154s","start":"2026-08-17T10:18:43.25369Z","end":"2026-08-17T10:18:47.0482Z","steps":["trace[529156517] 'agreement among raft nodes before linearized reading' (duration: 3.794460932s)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:18:47.048205Z","caller":"traceutil/trace.go:171","msg":"trace[484926105] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:4407; }","duration":"122.866327ms","start":"2026-08-17T10:18:46.925326Z","end":"2026-08-17T10:18:47.048192Z","steps":["trace[484926105] 'agreement among raft nodes before linearized reading' (duration: 122.796254ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.048227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:43.253677Z","time spent":"3.794544545s","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-17T10:18:47.04826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.216589014s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-17T10:18:47.048317Z","caller":"traceutil/trace.go:171","msg":"trace[360526369] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:4407; }","duration":"1.216686978s","start":"2026-08-17T10:18:45.831617Z","end":"2026-08-17T10:18:47.048304Z","steps":["trace[360526369] 'agreement among raft nodes before linearized reading' (duration: 1.216548263s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.048143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.794277506s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-17T10:18:47.048446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:45.831603Z","time spent":"1.216810953s","remote":"127.0.0.1:48364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":71,"response size":30,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-08-17T10:18:47.049329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.893637192s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-14b55bf4-8a37-4678-bc01-10ee8d3cad08\" ","response":"range_response_count:1 size:3759"} {"level":"info","ts":"2026-08-17T10:18:47.049359Z","caller":"traceutil/trace.go:171","msg":"trace[1612030455] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-14b55bf4-8a37-4678-bc01-10ee8d3cad08; range_end:; response_count:1; response_revision:4407; }","duration":"3.893697764s","start":"2026-08-17T10:18:43.155652Z","end":"2026-08-17T10:18:47.04935Z","steps":["trace[1612030455] 'agreement among raft nodes before linearized reading' (duration: 3.893626792s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.049359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.132090666s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-08-17T10:18:47.049436Z","caller":"traceutil/trace.go:171","msg":"trace[1843737526] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4407; }","duration":"2.13222133s","start":"2026-08-17T10:18:44.917204Z","end":"2026-08-17T10:18:47.049426Z","steps":["trace[1843737526] 'agreement among raft nodes before linearized reading' (duration: 2.131198793s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.049461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.093773504s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-08-17T10:18:47.049473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:44.917187Z","time spent":"2.132279402s","remote":"127.0.0.1:48496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12235,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-08-17T10:18:47.049481Z","caller":"traceutil/trace.go:171","msg":"trace[841678055] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4407; }","duration":"4.093817896s","start":"2026-08-17T10:18:42.955658Z","end":"2026-08-17T10:18:47.049475Z","steps":["trace[841678055] 'agreement among raft nodes before linearized reading' (duration: 4.093754123s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.047974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.180344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"warn","ts":"2026-08-17T10:18:47.04954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.202307ms","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-17T10:18:47.049561Z","caller":"traceutil/trace.go:171","msg":"trace[752658891] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4407; }","duration":"599.265618ms","start":"2026-08-17T10:18:46.450289Z","end":"2026-08-17T10:18:47.049555Z","steps":["trace[752658891] 'agreement among raft nodes before linearized reading' (duration: 599.229837ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.049579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:46.450271Z","time spent":"599.30327ms","remote":"127.0.0.1:60232","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":"info","ts":"2026-08-17T10:18:47.049628Z","caller":"traceutil/trace.go:171","msg":"trace[1798166538] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4407; }","duration":"111.76852ms","start":"2026-08-17T10:18:46.937776Z","end":"2026-08-17T10:18:47.049544Z","steps":["trace[1798166538] 'agreement among raft nodes before linearized reading' (duration: 110.158912ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.04972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.780799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-17T10:18:47.049744Z","caller":"traceutil/trace.go:171","msg":"trace[88441751] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4407; }","duration":"406.823521ms","start":"2026-08-17T10:18:46.642915Z","end":"2026-08-17T10:18:47.049739Z","steps":["trace[88441751] 'agreement among raft nodes before linearized reading' (duration: 406.78442ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.049758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:46.64291Z","time spent":"406.844831ms","remote":"127.0.0.1:48284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-17T10:18:47.049324Z","caller":"traceutil/trace.go:171","msg":"trace[1530266313] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4407; }","duration":"3.795441727s","start":"2026-08-17T10:18:43.253825Z","end":"2026-08-17T10:18:47.049267Z","steps":["trace[1530266313] 'agreement among raft nodes before linearized reading' (duration: 3.794283076s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.049664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.320111814s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-17T10:18:47.04988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:43.253806Z","time spent":"3.79606779s","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-17T10:18:47.049379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:43.155636Z","time spent":"3.893737816s","remote":"127.0.0.1:48496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3782,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-14b55bf4-8a37-4678-bc01-10ee8d3cad08\" "} {"level":"warn","ts":"2026-08-17T10:18:47.048315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.795733288s","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-17T10:18:47.050067Z","caller":"traceutil/trace.go:171","msg":"trace[1131953797] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4407; }","duration":"3.797514311s","start":"2026-08-17T10:18:43.252538Z","end":"2026-08-17T10:18:47.050052Z","steps":["trace[1131953797] 'agreement among raft nodes before linearized reading' (duration: 3.795739608s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.050107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:43.252518Z","time spent":"3.797578424s","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-17T10:18:47.047708Z","caller":"traceutil/trace.go:171","msg":"trace[1037139055] transaction","detail":"{read_only:false; response_revision:4407; number_of_response:1; }","duration":"406.2552ms","start":"2026-08-17T10:18:46.641441Z","end":"2026-08-17T10:18:47.047696Z","steps":["trace[1037139055] 'process raft request' (duration: 406.164887ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.050225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:46.641426Z","time spent":"408.77321ms","remote":"127.0.0.1:48384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-17T10:18:47.049503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:42.955645Z","time spent":"4.093854047s","remote":"127.0.0.1:48576","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-17T10:18:47.048053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.279648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:7 size:61048"} {"level":"info","ts":"2026-08-17T10:18:47.050471Z","caller":"traceutil/trace.go:171","msg":"trace[886078430] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:7; response_revision:4407; }","duration":"112.719284ms","start":"2026-08-17T10:18:46.937734Z","end":"2026-08-17T10:18:47.050454Z","steps":["trace[886078430] 'agreement among raft nodes before linearized reading' (duration: 110.250566ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.048099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.41961358s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-17T10:18:47.050588Z","caller":"traceutil/trace.go:171","msg":"trace[2114195968] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:4407; }","duration":"3.42213807s","start":"2026-08-17T10:18:43.628439Z","end":"2026-08-17T10:18:47.050577Z","steps":["trace[2114195968] 'agreement among raft nodes before linearized reading' (duration: 3.419618s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.050627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:43.628422Z","time spent":"3.422192332s","remote":"127.0.0.1:48818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":5,"response size":30,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-08-17T10:18:47.048098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.559668245s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-17T10:18:47.050952Z","caller":"traceutil/trace.go:171","msg":"trace[213578784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4407; }","duration":"3.562560968s","start":"2026-08-17T10:18:43.48838Z","end":"2026-08-17T10:18:47.050941Z","steps":["trace[213578784] 'agreement among raft nodes before linearized reading' (duration: 3.559684195s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.050991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:43.488357Z","time spent":"3.56262269s","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-17T10:18:47.047909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.276365657s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-097461a5-c3f9-462c-b08f-b9541ad65fd4\" ","response":"range_response_count:1 size:3773"} {"level":"info","ts":"2026-08-17T10:18:47.051132Z","caller":"traceutil/trace.go:171","msg":"trace[1503039285] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-097461a5-c3f9-462c-b08f-b9541ad65fd4; range_end:; response_count:1; response_revision:4407; }","duration":"4.279628523s","start":"2026-08-17T10:18:42.771494Z","end":"2026-08-17T10:18:47.051122Z","steps":["trace[1503039285] 'agreement among raft nodes before linearized reading' (duration: 4.276323285s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.051162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:42.771472Z","time spent":"4.279680675s","remote":"127.0.0.1:48496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3796,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-097461a5-c3f9-462c-b08f-b9541ad65fd4\" "} {"level":"info","ts":"2026-08-17T10:18:47.053419Z","caller":"traceutil/trace.go:171","msg":"trace[1062445460] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:4407; }","duration":"2.320375303s","start":"2026-08-17T10:18:44.729513Z","end":"2026-08-17T10:18:47.049888Z","steps":["trace[1062445460] 'agreement among raft nodes before linearized reading' (duration: 2.320124254s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:47.05362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:44.729497Z","time spent":"2.324106036s","remote":"127.0.0.1:37812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true "} {"level":"warn","ts":"2026-08-17T10:18:47.054131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:43.752785Z","time spent":"3.295353648s","remote":"127.0.0.1:48576","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-17T10:18:53.885407Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15026436143877037134,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-17T10:18:54.386346Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15026436143877037134,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-17T10:18:54.886761Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15026436143877037134,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-17T10:18:55.190599Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.813771624s","expected-duration":"1s"} {"level":"info","ts":"2026-08-17T10:18:55.250013Z","caller":"traceutil/trace.go:171","msg":"trace[1969006116] transaction","detail":"{read_only:false; response_revision:4541; number_of_response:1; }","duration":"1.890557335s","start":"2026-08-17T10:18:53.359428Z","end":"2026-08-17T10:18:55.249986Z","steps":["trace[1969006116] 'process raft request' (duration: 1.831493161s)","trace[1969006116] 'compare' (duration: 57.326602ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:18:55.250183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:53.359414Z","time spent":"1.890690309s","remote":"127.0.0.1:37806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-17T10:18:55.250199Z","caller":"traceutil/trace.go:171","msg":"trace[1213862697] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4542; }","duration":"1.870478764s","start":"2026-08-17T10:18:53.379708Z","end":"2026-08-17T10:18:55.250186Z","steps":["trace[1213862697] 'process raft request' (duration: 1.870022788s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:55.250311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:53.379693Z","time spent":"1.870535776s","remote":"127.0.0.1:48408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":95,"response count":0,"response size":41,"request content":"compare: success: > failure: >"} {"level":"info","ts":"2026-08-17T10:18:55.25104Z","caller":"traceutil/trace.go:171","msg":"trace[896495179] transaction","detail":"{read_only:false; response_revision:4543; number_of_response:1; }","duration":"808.845248ms","start":"2026-08-17T10:18:54.442149Z","end":"2026-08-17T10:18:55.250994Z","steps":["trace[896495179] 'process raft request' (duration: 807.701297ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:55.251201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:54.442126Z","time spent":"809.004664ms","remote":"127.0.0.1:48384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":854,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-17T10:18:55.253934Z","caller":"traceutil/trace.go:171","msg":"trace[1619508543] linearizableReadLoop","detail":"{readStateIndex:4720; appliedIndex:4716; }","duration":"1.876923215s","start":"2026-08-17T10:18:53.376997Z","end":"2026-08-17T10:18:55.25392Z","steps":["trace[1619508543] 'read index received' (duration: 1.813937181s)","trace[1619508543] 'applied index is now lower than readState.Index' (duration: 62.985324ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:18:55.254148Z","caller":"traceutil/trace.go:171","msg":"trace[720552622] transaction","detail":"{read_only:false; response_revision:4546; number_of_response:1; }","duration":"173.570872ms","start":"2026-08-17T10:18:55.080553Z","end":"2026-08-17T10:18:55.254124Z","steps":["trace[720552622] 'process raft request' (duration: 173.280511ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:18:55.254185Z","caller":"traceutil/trace.go:171","msg":"trace[106764112] transaction","detail":"{read_only:false; response_revision:4547; number_of_response:1; }","duration":"173.044502ms","start":"2026-08-17T10:18:55.081125Z","end":"2026-08-17T10:18:55.254169Z","steps":["trace[106764112] 'process raft request' (duration: 172.732651ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:18:55.254273Z","caller":"traceutil/trace.go:171","msg":"trace[263233898] transaction","detail":"{read_only:false; response_revision:4548; number_of_response:1; }","duration":"167.913898ms","start":"2026-08-17T10:18:55.086307Z","end":"2026-08-17T10:18:55.254221Z","steps":["trace[263233898] 'process raft request' (duration: 167.578116ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:55.254368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.816843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-17T10:18:55.254394Z","caller":"traceutil/trace.go:171","msg":"trace[697743898] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4548; }","duration":"155.849494ms","start":"2026-08-17T10:18:55.098537Z","end":"2026-08-17T10:18:55.254387Z","steps":["trace[697743898] 'agreement among raft nodes before linearized reading' (duration: 155.73595ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:18:55.254456Z","caller":"traceutil/trace.go:171","msg":"trace[994021263] transaction","detail":"{read_only:false; response_revision:4544; number_of_response:1; }","duration":"696.045155ms","start":"2026-08-17T10:18:54.558394Z","end":"2026-08-17T10:18:55.254439Z","steps":["trace[994021263] 'process raft request' (duration: 691.521313ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:18:55.254459Z","caller":"traceutil/trace.go:171","msg":"trace[1366202465] transaction","detail":"{read_only:false; response_revision:4545; number_of_response:1; }","duration":"174.791195ms","start":"2026-08-17T10:18:55.079653Z","end":"2026-08-17T10:18:55.254444Z","steps":["trace[1366202465] 'process raft request' (duration: 174.10137ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:55.254483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.50045ms","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-17T10:18:55.2545Z","caller":"traceutil/trace.go:171","msg":"trace[1154103070] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4548; }","duration":"148.563622ms","start":"2026-08-17T10:18:55.105931Z","end":"2026-08-17T10:18:55.254495Z","steps":["trace[1154103070] 'agreement among raft nodes before linearized reading' (duration: 148.51487ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:55.254542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:54.558372Z","time spent":"696.115058ms","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-17T10:18:55.254571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.280921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-17T10:18:55.254602Z","caller":"traceutil/trace.go:171","msg":"trace[1738428795] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4548; }","duration":"618.354734ms","start":"2026-08-17T10:18:54.63624Z","end":"2026-08-17T10:18:55.254595Z","steps":["trace[1738428795] 'agreement among raft nodes before linearized reading' (duration: 618.299702ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:55.254624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.83187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-17T10:18:55.254635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:54.636218Z","time spent":"618.410696ms","remote":"127.0.0.1:48284","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-17T10:18:55.254679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.136669ms","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-17T10:18:55.254697Z","caller":"traceutil/trace.go:171","msg":"trace[1157640449] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4548; }","duration":"155.18174ms","start":"2026-08-17T10:18:55.099511Z","end":"2026-08-17T10:18:55.254693Z","steps":["trace[1157640449] 'agreement among raft nodes before linearized reading' (duration: 155.136759ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:18:55.254639Z","caller":"traceutil/trace.go:171","msg":"trace[1570435495] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4548; }","duration":"151.895972ms","start":"2026-08-17T10:18:55.102738Z","end":"2026-08-17T10:18:55.254634Z","steps":["trace[1570435495] 'agreement among raft nodes before linearized reading' (duration: 151.854951ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:55.254582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.966372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-08-17T10:18:55.254703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.620666675s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-17T10:18:55.254783Z","caller":"traceutil/trace.go:171","msg":"trace[1419293158] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4548; }","duration":"150.208731ms","start":"2026-08-17T10:18:55.10457Z","end":"2026-08-17T10:18:55.254778Z","steps":["trace[1419293158] 'agreement among raft nodes before linearized reading' (duration: 149.972873ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:18:55.254814Z","caller":"traceutil/trace.go:171","msg":"trace[864404111] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:4548; }","duration":"1.620885473s","start":"2026-08-17T10:18:53.633909Z","end":"2026-08-17T10:18:55.254795Z","steps":["trace[864404111] 'agreement among raft nodes before linearized reading' (duration: 1.620592412s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:55.254943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:53.63389Z","time spent":"1.621000287s","remote":"127.0.0.1:48496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":31,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-08-17T10:18:55.255259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.813615173s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:1219"} {"level":"info","ts":"2026-08-17T10:18:55.255326Z","caller":"traceutil/trace.go:171","msg":"trace[327950748] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4548; }","duration":"1.813718746s","start":"2026-08-17T10:18:53.441592Z","end":"2026-08-17T10:18:55.255311Z","steps":["trace[327950748] 'agreement among raft nodes before linearized reading' (duration: 1.81353919s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:55.255355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:53.441577Z","time spent":"1.813772418s","remote":"127.0.0.1:48512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":1242,"request content":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus\" "} {"level":"warn","ts":"2026-08-17T10:18:55.255288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.744699938s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-08-17T10:18:55.255513Z","caller":"traceutil/trace.go:171","msg":"trace[623549595] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4548; }","duration":"1.744945387s","start":"2026-08-17T10:18:53.51055Z","end":"2026-08-17T10:18:55.255495Z","steps":["trace[623549595] 'agreement among raft nodes before linearized reading' (duration: 1.744094216s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:55.255624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:53.510534Z","time spent":"1.745044561s","remote":"127.0.0.1:48416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2207434,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"warn","ts":"2026-08-17T10:18:55.255862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.901493958s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-08-17T10:18:55.255898Z","caller":"traceutil/trace.go:171","msg":"trace[1885209553] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4548; }","duration":"1.90156667s","start":"2026-08-17T10:18:53.354324Z","end":"2026-08-17T10:18:55.25589Z","steps":["trace[1885209553] 'agreement among raft nodes before linearized reading' (duration: 1.901474697s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:55.255919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:53.354303Z","time spent":"1.901610942s","remote":"127.0.0.1:48506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":1308,"request content":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" "} {"level":"warn","ts":"2026-08-17T10:18:55.255985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.76674866s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-17T10:18:55.256015Z","caller":"traceutil/trace.go:171","msg":"trace[726410614] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:4548; }","duration":"1.766815383s","start":"2026-08-17T10:18:53.489193Z","end":"2026-08-17T10:18:55.256008Z","steps":["trace[726410614] 'agreement among raft nodes before linearized reading' (duration: 1.76563176s)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:18:55.256034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:18:53.489174Z","time spent":"1.766855773s","remote":"127.0.0.1:48878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":453,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-08-17T10:19:01.452189Z","caller":"traceutil/trace.go:171","msg":"trace[542704920] transaction","detail":"{read_only:false; response_revision:4657; number_of_response:1; }","duration":"147.702876ms","start":"2026-08-17T10:19:01.304465Z","end":"2026-08-17T10:19:01.452168Z","steps":["trace[542704920] 'process raft request' (duration: 147.585632ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:19:01.484772Z","caller":"traceutil/trace.go:171","msg":"trace[1771258074] transaction","detail":"{read_only:false; response_revision:4658; number_of_response:1; }","duration":"179.396801ms","start":"2026-08-17T10:19:01.305346Z","end":"2026-08-17T10:19:01.484743Z","steps":["trace[1771258074] 'process raft request' (duration: 162.877074ms)","trace[1771258074] 'compare' (duration: 16.31274ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:19:01.484906Z","caller":"traceutil/trace.go:171","msg":"trace[1393767158] transaction","detail":"{read_only:false; response_revision:4659; number_of_response:1; }","duration":"179.520836ms","start":"2026-08-17T10:19:01.305375Z","end":"2026-08-17T10:19:01.484896Z","steps":["trace[1393767158] 'process raft request' (duration: 179.321879ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:19:01.485133Z","caller":"traceutil/trace.go:171","msg":"trace[1669281077] linearizableReadLoop","detail":"{readStateIndex:4837; appliedIndex:4834; }","duration":"176.880181ms","start":"2026-08-17T10:19:01.308243Z","end":"2026-08-17T10:19:01.485123Z","steps":["trace[1669281077] 'read index received' (duration: 144.243512ms)","trace[1669281077] 'applied index is now lower than readState.Index' (duration: 32.635719ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:19:01.485169Z","caller":"traceutil/trace.go:171","msg":"trace[465910423] transaction","detail":"{read_only:false; response_revision:4660; number_of_response:1; }","duration":"179.661511ms","start":"2026-08-17T10:19:01.305483Z","end":"2026-08-17T10:19:01.485144Z","steps":["trace[465910423] 'process raft request' (duration: 179.36372ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:19:01.485366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.099389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-08-17T10:19:01.485384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.831637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-17T10:19:01.485431Z","caller":"traceutil/trace.go:171","msg":"trace[178875878] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4661; }","duration":"177.232784ms","start":"2026-08-17T10:19:01.30819Z","end":"2026-08-17T10:19:01.485415Z","steps":["trace[178875878] 'agreement among raft nodes before linearized reading' (duration: 177.023386ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:19:01.485547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.36695ms","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-17T10:19:01.485552Z","caller":"traceutil/trace.go:171","msg":"trace[1656593718] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4661; }","duration":"174.900479ms","start":"2026-08-17T10:19:01.31053Z","end":"2026-08-17T10:19:01.48543Z","steps":["trace[1656593718] 'agreement among raft nodes before linearized reading' (duration: 174.766424ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:19:01.48557Z","caller":"traceutil/trace.go:171","msg":"trace[994732441] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4661; }","duration":"174.415342ms","start":"2026-08-17T10:19:01.311148Z","end":"2026-08-17T10:19:01.485563Z","steps":["trace[994732441] 'agreement among raft nodes before linearized reading' (duration: 174.35704ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:19:01.485519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.104114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-08-17T10:19:01.48562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.446493ms","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-17T10:19:01.486039Z","caller":"traceutil/trace.go:171","msg":"trace[169683462] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4661; }","duration":"174.861357ms","start":"2026-08-17T10:19:01.311157Z","end":"2026-08-17T10:19:01.486018Z","steps":["trace[169683462] 'agreement among raft nodes before linearized reading' (duration: 174.426862ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:19:01.485917Z","caller":"traceutil/trace.go:171","msg":"trace[1121294903] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4661; }","duration":"173.52585ms","start":"2026-08-17T10:19:01.312369Z","end":"2026-08-17T10:19:01.485895Z","steps":["trace[1121294903] 'agreement among raft nodes before linearized reading' (duration: 172.98301ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:19:13.722681Z","caller":"traceutil/trace.go:171","msg":"trace[64643818] transaction","detail":"{read_only:false; response_revision:4816; number_of_response:1; }","duration":"217.877961ms","start":"2026-08-17T10:19:13.504783Z","end":"2026-08-17T10:19:13.722661Z","steps":["trace[64643818] 'process raft request' (duration: 217.731476ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:19:13.730461Z","caller":"traceutil/trace.go:171","msg":"trace[1246688873] linearizableReadLoop","detail":"{readStateIndex:5001; appliedIndex:4998; }","duration":"198.766855ms","start":"2026-08-17T10:19:13.531679Z","end":"2026-08-17T10:19:13.730446Z","steps":["trace[1246688873] 'read index received' (duration: 190.895428ms)","trace[1246688873] 'applied index is now lower than readState.Index' (duration: 7.870737ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:19:13.730562Z","caller":"traceutil/trace.go:171","msg":"trace[56403148] transaction","detail":"{read_only:false; response_revision:4820; number_of_response:1; }","duration":"196.615936ms","start":"2026-08-17T10:19:13.533923Z","end":"2026-08-17T10:19:13.730539Z","steps":["trace[56403148] 'process raft request' (duration: 196.497932ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:19:13.730622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.928991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-08-17T10:19:13.730653Z","caller":"traceutil/trace.go:171","msg":"trace[641279073] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4820; }","duration":"199.036734ms","start":"2026-08-17T10:19:13.531608Z","end":"2026-08-17T10:19:13.730644Z","steps":["trace[641279073] 'agreement among raft nodes before linearized reading' (duration: 198.91709ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:19:13.730643Z","caller":"traceutil/trace.go:171","msg":"trace[1331000727] transaction","detail":"{read_only:false; response_revision:4819; number_of_response:1; }","duration":"197.022871ms","start":"2026-08-17T10:19:13.533597Z","end":"2026-08-17T10:19:13.73062Z","steps":["trace[1331000727] 'process raft request' (duration: 196.803423ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:19:13.730555Z","caller":"traceutil/trace.go:171","msg":"trace[652270028] transaction","detail":"{read_only:false; response_revision:4818; number_of_response:1; }","duration":"201.244545ms","start":"2026-08-17T10:19:13.529276Z","end":"2026-08-17T10:19:13.730521Z","steps":["trace[652270028] 'process raft request' (duration: 201.098179ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:19:13.730725Z","caller":"traceutil/trace.go:171","msg":"trace[936416620] transaction","detail":"{read_only:false; response_revision:4817; number_of_response:1; }","duration":"225.399245ms","start":"2026-08-17T10:19:13.505289Z","end":"2026-08-17T10:19:13.730688Z","steps":["trace[936416620] 'process raft request' (duration: 225.00187ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:19:13.890312Z","caller":"traceutil/trace.go:171","msg":"trace[445498144] transaction","detail":"{read_only:false; response_revision:4822; number_of_response:1; }","duration":"160.192979ms","start":"2026-08-17T10:19:13.730094Z","end":"2026-08-17T10:19:13.890287Z","steps":["trace[445498144] 'process raft request' (duration: 160.140077ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:19:13.890423Z","caller":"traceutil/trace.go:171","msg":"trace[1968128601] transaction","detail":"{read_only:false; response_revision:4821; number_of_response:1; }","duration":"160.594863ms","start":"2026-08-17T10:19:13.72979Z","end":"2026-08-17T10:19:13.890385Z","steps":["trace[1968128601] 'process raft request' (duration: 70.680426ms)","trace[1968128601] 'compare' (duration: 89.660618ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:19:13.915725Z","caller":"traceutil/trace.go:171","msg":"trace[681247035] linearizableReadLoop","detail":"{readStateIndex:5006; appliedIndex:5003; }","duration":"185.19623ms","start":"2026-08-17T10:19:13.730512Z","end":"2026-08-17T10:19:13.915709Z","steps":["trace[681247035] 'read index received' (duration: 69.971741ms)","trace[681247035] 'applied index is now lower than readState.Index' (duration: 115.223569ms)"],"step_count":2} {"level":"warn","ts":"2026-08-17T10:19:13.916126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.251584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-08-17T10:19:13.916209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.721944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-w7mbq.18cc90691e7c6b3a\" ","response":"range_response_count:1 size:906"} {"level":"info","ts":"2026-08-17T10:19:13.916261Z","caller":"traceutil/trace.go:171","msg":"trace[1043991231] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-w7mbq.18cc90691e7c6b3a; range_end:; response_count:1; response_revision:4824; }","duration":"316.800427ms","start":"2026-08-17T10:19:13.599446Z","end":"2026-08-17T10:19:13.916247Z","steps":["trace[1043991231] 'agreement among raft nodes before linearized reading' (duration: 316.632621ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:19:13.916299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:19:13.59944Z","time spent":"316.850909ms","remote":"127.0.0.1:48384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":929,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-w7mbq.18cc90691e7c6b3a\" "} {"level":"info","ts":"2026-08-17T10:19:13.916241Z","caller":"traceutil/trace.go:171","msg":"trace[1686176555] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4824; }","duration":"314.440181ms","start":"2026-08-17T10:19:13.60178Z","end":"2026-08-17T10:19:13.91622Z","steps":["trace[1686176555] 'agreement among raft nodes before linearized reading' (duration: 314.157691ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:19:13.916434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:19:13.601759Z","time spent":"314.661358ms","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-17T10:19:13.916478Z","caller":"traceutil/trace.go:171","msg":"trace[2043609682] transaction","detail":"{read_only:false; response_revision:4823; number_of_response:1; }","duration":"186.227088ms","start":"2026-08-17T10:19:13.730242Z","end":"2026-08-17T10:19:13.916469Z","steps":["trace[2043609682] 'process raft request' (duration: 185.280464ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:19:13.916492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.702416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-9e5d34ab-9737-44cc-a096-c257598db83b\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-08-17T10:19:13.91655Z","caller":"traceutil/trace.go:171","msg":"trace[1704359216] range","detail":"{range_begin:/registry/persistentvolumes/pvc-9e5d34ab-9737-44cc-a096-c257598db83b; range_end:; response_count:1; response_revision:4824; }","duration":"183.774229ms","start":"2026-08-17T10:19:13.732761Z","end":"2026-08-17T10:19:13.916536Z","steps":["trace[1704359216] 'agreement among raft nodes before linearized reading' (duration: 183.588022ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:19:13.916441Z","caller":"traceutil/trace.go:171","msg":"trace[77266043] transaction","detail":"{read_only:false; response_revision:4824; number_of_response:1; }","duration":"185.416168ms","start":"2026-08-17T10:19:13.731007Z","end":"2026-08-17T10:19:13.916423Z","steps":["trace[77266043] 'process raft request' (duration: 184.660161ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:19:13.916805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.494922ms","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-17T10:19:13.916832Z","caller":"traceutil/trace.go:171","msg":"trace[1827711425] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4824; }","duration":"317.558794ms","start":"2026-08-17T10:19:13.599267Z","end":"2026-08-17T10:19:13.916826Z","steps":["trace[1827711425] 'agreement among raft nodes before linearized reading' (duration: 317.479621ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:19:13.916852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:19:13.599249Z","time spent":"317.598006ms","remote":"127.0.0.1:48576","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-17T10:19:13.916958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.823515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-08-17T10:19:13.917002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.455989ms","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-17T10:19:13.917025Z","caller":"traceutil/trace.go:171","msg":"trace[44616022] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4824; }","duration":"340.508371ms","start":"2026-08-17T10:19:13.576511Z","end":"2026-08-17T10:19:13.917019Z","steps":["trace[44616022] 'agreement among raft nodes before linearized reading' (duration: 340.443269ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:19:13.917044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:19:13.5765Z","time spent":"340.539252ms","remote":"127.0.0.1:48576","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":"info","ts":"2026-08-17T10:19:13.917Z","caller":"traceutil/trace.go:171","msg":"trace[1641708015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4824; }","duration":"314.882737ms","start":"2026-08-17T10:19:13.602107Z","end":"2026-08-17T10:19:13.91699Z","steps":["trace[1641708015] 'agreement among raft nodes before linearized reading' (duration: 314.773183ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:19:13.917165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:19:13.6021Z","time spent":"315.058723ms","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-17T10:19:13.916967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.097258ms","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-17T10:19:13.917699Z","caller":"traceutil/trace.go:171","msg":"trace[763475690] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4824; }","duration":"303.867525ms","start":"2026-08-17T10:19:13.613817Z","end":"2026-08-17T10:19:13.917685Z","steps":["trace[763475690] 'agreement among raft nodes before linearized reading' (duration: 302.946762ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:19:13.917976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-17T10:19:13.613801Z","time spent":"304.159897ms","remote":"127.0.0.1:48576","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-17T10:19:14.207511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.070721ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-17T10:19:14.207763Z","caller":"traceutil/trace.go:171","msg":"trace[386955147] transaction","detail":"{read_only:false; response_revision:4826; number_of_response:1; }","duration":"287.349978ms","start":"2026-08-17T10:19:13.920331Z","end":"2026-08-17T10:19:14.207681Z","steps":["trace[386955147] 'process raft request' (duration: 159.022618ms)","trace[386955147] 'compare' (duration: 127.821622ms)"],"step_count":2} {"level":"info","ts":"2026-08-17T10:19:14.208085Z","caller":"traceutil/trace.go:171","msg":"trace[1153774651] transaction","detail":"{read_only:false; response_revision:4827; number_of_response:1; }","duration":"286.802568ms","start":"2026-08-17T10:19:13.921265Z","end":"2026-08-17T10:19:14.208067Z","steps":["trace[1153774651] 'process raft request' (duration: 286.335631ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:19:14.208222Z","caller":"traceutil/trace.go:171","msg":"trace[1119428374] transaction","detail":"{read_only:false; response_revision:4830; number_of_response:1; }","duration":"284.874698ms","start":"2026-08-17T10:19:13.923321Z","end":"2026-08-17T10:19:14.208196Z","steps":["trace[1119428374] 'process raft request' (duration: 284.821316ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:19:14.208453Z","caller":"traceutil/trace.go:171","msg":"trace[186902672] transaction","detail":"{read_only:false; response_revision:4828; number_of_response:1; }","duration":"287.025746ms","start":"2026-08-17T10:19:13.921415Z","end":"2026-08-17T10:19:14.208441Z","steps":["trace[186902672] 'process raft request' (duration: 286.552509ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:19:14.20855Z","caller":"traceutil/trace.go:171","msg":"trace[401765236] transaction","detail":"{read_only:false; response_revision:4829; number_of_response:1; }","duration":"287.000656ms","start":"2026-08-17T10:19:13.921539Z","end":"2026-08-17T10:19:14.20854Z","steps":["trace[401765236] 'process raft request' (duration: 286.550729ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:20:33.238404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.90025ms","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-17T10:20:33.238513Z","caller":"traceutil/trace.go:171","msg":"trace[1051606737] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5471; }","duration":"242.129309ms","start":"2026-08-17T10:20:32.99636Z","end":"2026-08-17T10:20:33.23849Z","steps":["trace[1051606737] 'count revisions from in-memory index tree' (duration: 241.416111ms)"],"step_count":1} {"level":"warn","ts":"2026-08-17T10:20:33.238812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.427329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:1 size:8314"} {"level":"info","ts":"2026-08-17T10:20:33.238936Z","caller":"traceutil/trace.go:171","msg":"trace[2052829619] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:1; response_revision:5471; }","duration":"203.627668ms","start":"2026-08-17T10:20:33.035286Z","end":"2026-08-17T10:20:33.238914Z","steps":["trace[2052829619] 'range keys from in-memory index tree' (duration: 203.042966ms)"],"step_count":1} {"level":"info","ts":"2026-08-17T10:20:54.159995Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2915} {"level":"info","ts":"2026-08-17T10:20:54.26553Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2915,"took":"103.62642ms","hash":477366783,"current-db-size-bytes":55062528,"current-db-size":"55 MB","current-db-size-in-use-bytes":29741056,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-17T10:20:54.265629Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":477366783,"revision":2915,"compact-revision":-1} {"level":"info","ts":"2026-08-17T10:25:54.166136Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5627} {"level":"info","ts":"2026-08-17T10:25:54.274786Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5627,"took":"107.497704ms","hash":3649921812,"current-db-size-bytes":55062528,"current-db-size":"55 MB","current-db-size-in-use-bytes":18317312,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-17T10:25:54.274855Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3649921812,"revision":5627,"compact-revision":2915}