{"level":"warn","ts":"2026-08-14T08:54:10.197173Z","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-14T08:54:10.19735Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.35:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.35:2380","--initial-cluster=instance=https://199.204.45.35:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.35:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.35: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-14T08:54:10.197474Z","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-14T08:54:10.197496Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-08-14T08:54:10.197537Z","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-14T08:54:10.198542Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"]} {"level":"info","ts":"2026-08-14T08:54:10.19866Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.35: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-14T08:54:10.204349Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.365921ms"} {"level":"info","ts":"2026-08-14T08:54:10.210653Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fb85913747d92cac","cluster-id":"636a84d5a3ba9c31"} {"level":"info","ts":"2026-08-14T08:54:10.210744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=()"} {"level":"info","ts":"2026-08-14T08:54:10.210774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 0"} {"level":"info","ts":"2026-08-14T08:54:10.210786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fb85913747d92cac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-14T08:54:10.210807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 1"} {"level":"info","ts":"2026-08-14T08:54:10.210858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"warn","ts":"2026-08-14T08:54:10.21753Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-14T08:54:10.218867Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-14T08:54:10.220128Z","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-14T08:54:10.223122Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fb85913747d92cac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-14T08:54:10.22339Z","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-14T08:54:10.223503Z","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-14T08:54:10.223363Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fb85913747d92cac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-14T08:54:10.223523Z","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-14T08:54:10.225331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"info","ts":"2026-08-14T08:54:10.238648Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","added-peer-id":"fb85913747d92cac","added-peer-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-08-14T08:54:10.240293Z","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-14T08:54:10.24043Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-08-14T08:54:10.240479Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-08-14T08:54:10.240706Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fb85913747d92cac","initial-advertise-peer-urls":["https://199.204.45.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-14T08:54:10.240945Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-14T08:54:11.211721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac is starting a new election at term 1"} {"level":"info","ts":"2026-08-14T08:54:11.211819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became pre-candidate at term 1"} {"level":"info","ts":"2026-08-14T08:54:11.21188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgPreVoteResp from fb85913747d92cac at term 1"} {"level":"info","ts":"2026-08-14T08:54:11.211912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became candidate at term 2"} {"level":"info","ts":"2026-08-14T08:54:11.211938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgVoteResp from fb85913747d92cac at term 2"} {"level":"info","ts":"2026-08-14T08:54:11.211977Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became leader at term 2"} {"level":"info","ts":"2026-08-14T08:54:11.212001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fb85913747d92cac elected leader fb85913747d92cac at term 2"} {"level":"info","ts":"2026-08-14T08:54:11.213148Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T08:54:11.214159Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fb85913747d92cac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.35:2379]}","request-path":"/0/members/fb85913747d92cac/attributes","cluster-id":"636a84d5a3ba9c31","publish-timeout":"7s"} {"level":"info","ts":"2026-08-14T08:54:11.214215Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-14T08:54:11.214175Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-14T08:54:11.214697Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-14T08:54:11.214768Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-14T08:54:11.216578Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-14T08:54:11.217484Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.35:2379"} {"level":"info","ts":"2026-08-14T08:54:11.222397Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T08:54:11.222695Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T08:54:11.222779Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-14T08:54:33.424886Z","caller":"traceutil/trace.go:171","msg":"trace[1528898504] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"128.762006ms","start":"2026-08-14T08:54:33.296113Z","end":"2026-08-14T08:54:33.424875Z","steps":["trace[1528898504] 'process raft request' (duration: 128.599073ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:54:33.424868Z","caller":"traceutil/trace.go:171","msg":"trace[1162953491] transaction","detail":"{read_only:false; number_of_response:1; response_revision:445; }","duration":"128.616023ms","start":"2026-08-14T08:54:33.296226Z","end":"2026-08-14T08:54:33.424842Z","steps":["trace[1162953491] 'process raft request' (duration: 128.565091ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:54:33.424866Z","caller":"traceutil/trace.go:171","msg":"trace[784681322] transaction","detail":"{read_only:false; number_of_response:1; response_revision:444; }","duration":"131.585296ms","start":"2026-08-14T08:54:33.293242Z","end":"2026-08-14T08:54:33.424827Z","steps":["trace[784681322] 'process raft request' (duration: 106.410395ms)","trace[784681322] 'compare' (duration: 24.981257ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T08:54:33.425739Z","caller":"traceutil/trace.go:171","msg":"trace[26625417] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"110.393471ms","start":"2026-08-14T08:54:33.315331Z","end":"2026-08-14T08:54:33.425724Z","steps":["trace[26625417] 'process raft request' (duration: 110.34044ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:54:33.425918Z","caller":"traceutil/trace.go:171","msg":"trace[59010512] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"113.743944ms","start":"2026-08-14T08:54:33.312162Z","end":"2026-08-14T08:54:33.425906Z","steps":["trace[59010512] 'process raft request' (duration: 113.055178ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:54:40.956279Z","caller":"traceutil/trace.go:171","msg":"trace[1851671940] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:495; }","duration":"115.726294ms","start":"2026-08-14T08:54:40.840524Z","end":"2026-08-14T08:54:40.95625Z","steps":["trace[1851671940] 'read index received' (duration: 115.475649ms)","trace[1851671940] 'applied index is now lower than readState.Index' (duration: 248.985µs)"],"step_count":2} {"level":"warn","ts":"2026-08-14T08:54:40.956591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.986279ms","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-14T08:54:40.956756Z","caller":"traceutil/trace.go:171","msg":"trace[1969586823] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:475; }","duration":"116.254165ms","start":"2026-08-14T08:54:40.840473Z","end":"2026-08-14T08:54:40.956727Z","steps":["trace[1969586823] 'agreement among raft nodes before linearized reading' (duration: 115.886267ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:54:40.957562Z","caller":"traceutil/trace.go:171","msg":"trace[210613005] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"126.87658ms","start":"2026-08-14T08:54:40.83063Z","end":"2026-08-14T08:54:40.957507Z","steps":["trace[210613005] 'process raft request' (duration: 125.429369ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:54:47.299854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.567339ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-14T08:54:47.300371Z","caller":"traceutil/trace.go:171","msg":"trace[674996246] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"222.060013ms","start":"2026-08-14T08:54:47.078284Z","end":"2026-08-14T08:54:47.300344Z","steps":["trace[674996246] 'process raft request' (duration: 221.853389ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:54:47.300412Z","caller":"traceutil/trace.go:171","msg":"trace[131424489] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"208.934658ms","start":"2026-08-14T08:54:47.091458Z","end":"2026-08-14T08:54:47.300392Z","steps":["trace[131424489] 'process raft request' (duration: 208.782855ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:54:47.300669Z","caller":"traceutil/trace.go:171","msg":"trace[2092239568] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"203.181597ms","start":"2026-08-14T08:54:47.097472Z","end":"2026-08-14T08:54:47.300654Z","steps":["trace[2092239568] 'process raft request' (duration: 202.905252ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:54:47.300726Z","caller":"traceutil/trace.go:171","msg":"trace[1851372383] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"185.707702ms","start":"2026-08-14T08:54:47.11501Z","end":"2026-08-14T08:54:47.300717Z","steps":["trace[1851372383] 'process raft request' (duration: 185.590709ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:54:47.300828Z","caller":"traceutil/trace.go:171","msg":"trace[403054143] linearizableReadLoop","detail":"{readStateIndex:556; appliedIndex:547; }","duration":"178.075122ms","start":"2026-08-14T08:54:47.122719Z","end":"2026-08-14T08:54:47.300794Z","steps":["trace[403054143] 'read index received' (duration: 52.787927ms)","trace[403054143] 'applied index is now lower than readState.Index' (duration: 125.286255ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T08:54:47.300838Z","caller":"traceutil/trace.go:171","msg":"trace[1070568553] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"174.017817ms","start":"2026-08-14T08:54:47.12681Z","end":"2026-08-14T08:54:47.300828Z","steps":["trace[1070568553] 'process raft request' (duration: 173.848643ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:54:47.300651Z","caller":"traceutil/trace.go:171","msg":"trace[1025749178] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"203.216528ms","start":"2026-08-14T08:54:47.09738Z","end":"2026-08-14T08:54:47.300597Z","steps":["trace[1025749178] 'process raft request' (duration: 202.956462ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:54:47.300339Z","caller":"traceutil/trace.go:171","msg":"trace[1433862671] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"222.170596ms","start":"2026-08-14T08:54:47.078138Z","end":"2026-08-14T08:54:47.300308Z","steps":["trace[1433862671] 'process raft request' (duration: 221.862729ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:54:47.300677Z","caller":"traceutil/trace.go:171","msg":"trace[1249274314] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"202.428861ms","start":"2026-08-14T08:54:47.098231Z","end":"2026-08-14T08:54:47.30066Z","steps":["trace[1249274314] 'process raft request' (duration: 202.286308ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:54:47.300724Z","caller":"traceutil/trace.go:171","msg":"trace[1251159502] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"203.35432ms","start":"2026-08-14T08:54:47.097358Z","end":"2026-08-14T08:54:47.300712Z","steps":["trace[1251159502] 'process raft request' (duration: 202.930992ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:54:47.300917Z","caller":"traceutil/trace.go:171","msg":"trace[1794961175] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"141.889484ms","start":"2026-08-14T08:54:47.158999Z","end":"2026-08-14T08:54:47.300889Z","steps":["trace[1794961175] 'process raft request' (duration: 141.71746ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:54:47.300999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.244255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-14T08:54:47.30028Z","caller":"traceutil/trace.go:171","msg":"trace[340323726] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"222.096675ms","start":"2026-08-14T08:54:47.078147Z","end":"2026-08-14T08:54:47.300243Z","steps":["trace[340323726] 'process raft request' (duration: 97.3404ms)","trace[340323726] 'compare' (duration: 123.188972ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T08:54:47.301468Z","caller":"traceutil/trace.go:171","msg":"trace[104858794] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:536; }","duration":"178.761766ms","start":"2026-08-14T08:54:47.122687Z","end":"2026-08-14T08:54:47.301448Z","steps":["trace[104858794] 'agreement among raft nodes before linearized reading' (duration: 178.194864ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:54:47.312954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.290869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-14T08:54:47.313121Z","caller":"traceutil/trace.go:171","msg":"trace[963124887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:537; }","duration":"182.492474ms","start":"2026-08-14T08:54:47.130605Z","end":"2026-08-14T08:54:47.313098Z","steps":["trace[963124887] 'agreement among raft nodes before linearized reading' (duration: 182.112286ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:54:53.597543Z","caller":"traceutil/trace.go:171","msg":"trace[803855583] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"217.246411ms","start":"2026-08-14T08:54:53.380269Z","end":"2026-08-14T08:54:53.597516Z","steps":["trace[803855583] 'process raft request' (duration: 217.084528ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:54:54.10421Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219123753284806531,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-14T08:54:54.183731Z","caller":"traceutil/trace.go:171","msg":"trace[625643485] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"775.756902ms","start":"2026-08-14T08:54:53.407962Z","end":"2026-08-14T08:54:54.183719Z","steps":["trace[625643485] 'process raft request' (duration: 775.549858ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:54:54.183711Z","caller":"traceutil/trace.go:171","msg":"trace[401632424] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"775.817464ms","start":"2026-08-14T08:54:53.407811Z","end":"2026-08-14T08:54:54.183628Z","steps":["trace[401632424] 'process raft request' (duration: 775.518497ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:54:54.18396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:54:53.407939Z","time spent":"775.844254ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T08:54:54.184184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:54:53.40779Z","time spent":"776.009677ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T08:54:54.20163Z","caller":"traceutil/trace.go:171","msg":"trace[1874448657] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:659; }","duration":"598.252475ms","start":"2026-08-14T08:54:53.603344Z","end":"2026-08-14T08:54:54.201596Z","steps":["trace[1874448657] 'read index received' (duration: 580.024798ms)","trace[1874448657] 'applied index is now lower than readState.Index' (duration: 18.226487ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T08:54:54.201777Z","caller":"traceutil/trace.go:171","msg":"trace[455063493] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"667.83584ms","start":"2026-08-14T08:54:53.53393Z","end":"2026-08-14T08:54:54.201766Z","steps":["trace[455063493] 'process raft request' (duration: 649.833557ms)","trace[455063493] 'compare' (duration: 17.36605ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T08:54:54.201947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.22407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wgw5m\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-08-14T08:54:54.202646Z","caller":"traceutil/trace.go:171","msg":"trace[1164189700] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wgw5m; range_end:; response_count:1; response_revision:635; }","duration":"302.941814ms","start":"2026-08-14T08:54:53.899673Z","end":"2026-08-14T08:54:54.202615Z","steps":["trace[1164189700] 'agreement among raft nodes before linearized reading' (duration: 302.204629ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:54:54.202712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:54:53.899657Z","time spent":"303.042646ms","remote":"127.0.0.1:41360","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-wgw5m\" "} {"level":"warn","ts":"2026-08-14T08:54:54.20192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:54:53.533897Z","time spent":"667.928362ms","remote":"127.0.0.1:41260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T08:54:54.201978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.599313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T08:54:54.202993Z","caller":"traceutil/trace.go:171","msg":"trace[1755507812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"599.678535ms","start":"2026-08-14T08:54:53.603293Z","end":"2026-08-14T08:54:54.202972Z","steps":["trace[1755507812] 'agreement among raft nodes before linearized reading' (duration: 598.554262ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:54:54.203057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:54:53.603273Z","time spent":"599.765727ms","remote":"127.0.0.1:41136","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-14T08:54:55.275608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.561122ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T08:54:55.276066Z","caller":"traceutil/trace.go:171","msg":"trace[812782160] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"1.053426602s","start":"2026-08-14T08:54:54.222279Z","end":"2026-08-14T08:54:55.275705Z","steps":["trace[812782160] 'process raft request' (duration: 358.677556ms)","trace[812782160] 'compare' (duration: 694.161864ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T08:54:55.276322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:54:54.222263Z","time spent":"1.053856451s","remote":"127.0.0.1:41186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T08:54:55.285058Z","caller":"traceutil/trace.go:171","msg":"trace[1290847994] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:665; }","duration":"209.257532ms","start":"2026-08-14T08:54:55.075772Z","end":"2026-08-14T08:54:55.28503Z","steps":["trace[1290847994] 'read index received' (duration: 209.036898ms)","trace[1290847994] 'applied index is now lower than readState.Index' (duration: 219.454µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T08:54:55.285199Z","caller":"traceutil/trace.go:171","msg":"trace[1319923063] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"1.015405234s","start":"2026-08-14T08:54:54.269763Z","end":"2026-08-14T08:54:55.285169Z","steps":["trace[1319923063] 'process raft request' (duration: 1.015152609s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:54:55.285343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.693614ms","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-14T08:54:55.285394Z","caller":"traceutil/trace.go:171","msg":"trace[1814083548] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"170.772856ms","start":"2026-08-14T08:54:55.114605Z","end":"2026-08-14T08:54:55.285378Z","steps":["trace[1814083548] 'agreement among raft nodes before linearized reading' (duration: 170.613843ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:54:55.285366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.591179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-14T08:54:55.285353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:54:54.269729Z","time spent":"1.015555797s","remote":"127.0.0.1:41418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T08:54:55.28545Z","caller":"traceutil/trace.go:171","msg":"trace[65354586] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:638; }","duration":"209.724023ms","start":"2026-08-14T08:54:55.075712Z","end":"2026-08-14T08:54:55.285436Z","steps":["trace[65354586] 'agreement among raft nodes before linearized reading' (duration: 209.451437ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:54:57.217348Z","caller":"traceutil/trace.go:171","msg":"trace[1898380961] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"138.726034ms","start":"2026-08-14T08:54:57.078603Z","end":"2026-08-14T08:54:57.217329Z","steps":["trace[1898380961] 'process raft request' (duration: 138.623732ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:55:08.373649Z","caller":"traceutil/trace.go:171","msg":"trace[586260011] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"111.395768ms","start":"2026-08-14T08:55:08.262224Z","end":"2026-08-14T08:55:08.373619Z","steps":["trace[586260011] 'process raft request' (duration: 108.136321ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:55:11.216349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.52128ms","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-14T08:55:11.216443Z","caller":"traceutil/trace.go:171","msg":"trace[302016411] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:800; }","duration":"496.670872ms","start":"2026-08-14T08:55:10.71975Z","end":"2026-08-14T08:55:11.216421Z","steps":["trace[302016411] 'range keys from in-memory index tree' (duration: 496.295315ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:55:11.216875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.301631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T08:55:11.217067Z","caller":"traceutil/trace.go:171","msg":"trace[520131470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:800; }","duration":"612.452644ms","start":"2026-08-14T08:55:10.604499Z","end":"2026-08-14T08:55:11.216952Z","steps":["trace[520131470] 'range keys from in-memory index tree' (duration: 612.090196ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:55:11.217103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:55:10.719721Z","time spent":"497.324955ms","remote":"127.0.0.1:41446","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-14T08:55:11.217185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:55:10.604472Z","time spent":"612.643238ms","remote":"127.0.0.1:41136","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-14T08:55:11.226319Z","caller":"traceutil/trace.go:171","msg":"trace[451550155] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"218.829509ms","start":"2026-08-14T08:55:11.00748Z","end":"2026-08-14T08:55:11.226309Z","steps":["trace[451550155] 'process raft request' (duration: 218.648125ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:55:57.604014Z","caller":"traceutil/trace.go:171","msg":"trace[757982901] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"106.228106ms","start":"2026-08-14T08:55:57.497759Z","end":"2026-08-14T08:55:57.603987Z","steps":["trace[757982901] 'process raft request' (duration: 105.889599ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:56:29.614256Z","caller":"traceutil/trace.go:171","msg":"trace[50921028] linearizableReadLoop","detail":"{readStateIndex:1959; appliedIndex:1958; }","duration":"258.387596ms","start":"2026-08-14T08:56:29.355531Z","end":"2026-08-14T08:56:29.613918Z","steps":["trace[50921028] 'read index received' (duration: 252.28591ms)","trace[50921028] 'applied index is now lower than readState.Index' (duration: 6.100166ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T08:56:29.614324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.771776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-621a62e7-25a8-47a8-8c1e-56c3082d4a82\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-08-14T08:56:29.614002Z","caller":"traceutil/trace.go:171","msg":"trace[1909098111] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"369.472431ms","start":"2026-08-14T08:56:29.244502Z","end":"2026-08-14T08:56:29.613975Z","steps":["trace[1909098111] 'process raft request' (duration: 363.301223ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:56:29.614396Z","caller":"traceutil/trace.go:171","msg":"trace[766491020] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-621a62e7-25a8-47a8-8c1e-56c3082d4a82; range_end:; response_count:1; response_revision:1884; }","duration":"258.8889ms","start":"2026-08-14T08:56:29.355491Z","end":"2026-08-14T08:56:29.61438Z","steps":["trace[766491020] 'agreement among raft nodes before linearized reading' (duration: 258.679305ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:56:29.614577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:56:29.244481Z","time spent":"369.944595ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T08:56:29.654018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.088194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-621a62e7-25a8-47a8-8c1e-56c3082d4a82\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-08-14T08:56:29.654146Z","caller":"traceutil/trace.go:171","msg":"trace[2129938986] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-621a62e7-25a8-47a8-8c1e-56c3082d4a82; range_end:; response_count:1; response_revision:1884; }","duration":"271.282868ms","start":"2026-08-14T08:56:29.382838Z","end":"2026-08-14T08:56:29.65412Z","steps":["trace[2129938986] 'agreement among raft nodes before linearized reading' (duration: 270.908298ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:56:29.768879Z","caller":"traceutil/trace.go:171","msg":"trace[679016989] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"106.515071ms","start":"2026-08-14T08:56:29.662338Z","end":"2026-08-14T08:56:29.768853Z","steps":["trace[679016989] 'process raft request' (duration: 106.245664ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:56:30.101177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.662736ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T08:56:30.101284Z","caller":"traceutil/trace.go:171","msg":"trace[1216767082] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"252.397979ms","start":"2026-08-14T08:56:29.848865Z","end":"2026-08-14T08:56:30.101263Z","steps":["trace[1216767082] 'process raft request' (duration: 112.561127ms)","trace[1216767082] 'compare' (duration: 139.564175ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T08:56:30.118478Z","caller":"traceutil/trace.go:171","msg":"trace[591958798] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"269.37868ms","start":"2026-08-14T08:56:29.849079Z","end":"2026-08-14T08:56:30.118457Z","steps":["trace[591958798] 'process raft request' (duration: 269.268277ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:56:30.11849Z","caller":"traceutil/trace.go:171","msg":"trace[1556637895] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"269.408259ms","start":"2026-08-14T08:56:29.849016Z","end":"2026-08-14T08:56:30.118424Z","steps":["trace[1556637895] 'process raft request' (duration: 269.246255ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:56:30.118959Z","caller":"traceutil/trace.go:171","msg":"trace[268228171] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"269.8336ms","start":"2026-08-14T08:56:29.849096Z","end":"2026-08-14T08:56:30.118929Z","steps":["trace[268228171] 'process raft request' (duration: 269.303156ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:56:30.120056Z","caller":"traceutil/trace.go:171","msg":"trace[978856531] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"269.973804ms","start":"2026-08-14T08:56:29.850061Z","end":"2026-08-14T08:56:30.120035Z","steps":["trace[978856531] 'process raft request' (duration: 268.813033ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:56:30.120286Z","caller":"traceutil/trace.go:171","msg":"trace[1619040813] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"269.706948ms","start":"2026-08-14T08:56:29.850564Z","end":"2026-08-14T08:56:30.120271Z","steps":["trace[1619040813] 'process raft request' (duration: 269.40566ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:56:30.120446Z","caller":"traceutil/trace.go:171","msg":"trace[929206130] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"268.952417ms","start":"2026-08-14T08:56:29.851483Z","end":"2026-08-14T08:56:30.120436Z","steps":["trace[929206130] 'process raft request' (duration: 268.66951ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:56:30.120679Z","caller":"traceutil/trace.go:171","msg":"trace[79609488] linearizableReadLoop","detail":"{readStateIndex:1969; appliedIndex:1962; }","duration":"240.08112ms","start":"2026-08-14T08:56:29.880572Z","end":"2026-08-14T08:56:30.120653Z","steps":["trace[79609488] 'read index received' (duration: 80.852402ms)","trace[79609488] 'applied index is now lower than readState.Index' (duration: 159.227088ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T08:56:30.120799Z","caller":"traceutil/trace.go:171","msg":"trace[1889302648] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"199.372183ms","start":"2026-08-14T08:56:29.921415Z","end":"2026-08-14T08:56:30.120788Z","steps":["trace[1889302648] 'process raft request' (duration: 198.979163ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:56:30.120896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.309177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T08:56:30.121394Z","caller":"traceutil/trace.go:171","msg":"trace[1586293466] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1894; }","duration":"240.861533ms","start":"2026-08-14T08:56:29.880509Z","end":"2026-08-14T08:56:30.12137Z","steps":["trace[1586293466] 'agreement among raft nodes before linearized reading' (duration: 240.333759ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:56:30.12256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.872055ms","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-14T08:56:30.122711Z","caller":"traceutil/trace.go:171","msg":"trace[203999204] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1894; }","duration":"168.011588ms","start":"2026-08-14T08:56:29.95461Z","end":"2026-08-14T08:56:30.122622Z","steps":["trace[203999204] 'agreement among raft nodes before linearized reading' (duration: 166.710123ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:56:36.919451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.749868ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T08:56:36.919584Z","caller":"traceutil/trace.go:171","msg":"trace[607700283] linearizableReadLoop","detail":"{readStateIndex:2038; appliedIndex:2037; }","duration":"146.386298ms","start":"2026-08-14T08:56:36.773176Z","end":"2026-08-14T08:56:36.919562Z","steps":["trace[607700283] 'read index received' (duration: 9.382792ms)","trace[607700283] 'applied index is now lower than readState.Index' (duration: 137.002056ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T08:56:36.919756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.570383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-14T08:56:36.919797Z","caller":"traceutil/trace.go:171","msg":"trace[53098998] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1960; }","duration":"146.640855ms","start":"2026-08-14T08:56:36.773143Z","end":"2026-08-14T08:56:36.919784Z","steps":["trace[53098998] 'agreement among raft nodes before linearized reading' (duration: 146.477271ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:56:36.919849Z","caller":"traceutil/trace.go:171","msg":"trace[1036779445] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"234.491112ms","start":"2026-08-14T08:56:36.68532Z","end":"2026-08-14T08:56:36.919811Z","steps":["trace[1036779445] 'process raft request' (duration: 97.286671ms)","trace[1036779445] 'compare' (duration: 136.645697ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T08:57:03.230317Z","caller":"traceutil/trace.go:171","msg":"trace[1122814656] linearizableReadLoop","detail":"{readStateIndex:2206; appliedIndex:2205; }","duration":"117.491134ms","start":"2026-08-14T08:57:03.112803Z","end":"2026-08-14T08:57:03.230294Z","steps":["trace[1122814656] 'read index received' (duration: 117.350461ms)","trace[1122814656] 'applied index is now lower than readState.Index' (duration: 139.583µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T08:57:03.230494Z","caller":"traceutil/trace.go:171","msg":"trace[200676698] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"124.362719ms","start":"2026-08-14T08:57:03.106094Z","end":"2026-08-14T08:57:03.230457Z","steps":["trace[200676698] 'process raft request' (duration: 124.048142ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:57:03.230928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.111811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-14T08:57:03.231308Z","caller":"traceutil/trace.go:171","msg":"trace[1709976396] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2123; }","duration":"118.278414ms","start":"2026-08-14T08:57:03.112753Z","end":"2026-08-14T08:57:03.231032Z","steps":["trace[1709976396] 'agreement among raft nodes before linearized reading' (duration: 117.819373ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:57:03.431698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.020754ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T08:57:03.431905Z","caller":"traceutil/trace.go:171","msg":"trace[1637227806] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"196.338344ms","start":"2026-08-14T08:57:03.235538Z","end":"2026-08-14T08:57:03.431876Z","steps":["trace[1637227806] 'process raft request' (duration: 46.051453ms)","trace[1637227806] 'compare' (duration: 149.87328ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T08:57:04.058504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.754088ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T08:57:04.058713Z","caller":"traceutil/trace.go:171","msg":"trace[1613031293] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"277.286974ms","start":"2026-08-14T08:57:03.781388Z","end":"2026-08-14T08:57:04.058675Z","steps":["trace[1613031293] 'process raft request' (duration: 119.196698ms)","trace[1613031293] 'compare' (duration: 157.574873ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T08:57:04.530521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.740312ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T08:57:04.530653Z","caller":"traceutil/trace.go:171","msg":"trace[262979598] linearizableReadLoop","detail":"{readStateIndex:2212; appliedIndex:2211; }","duration":"278.196628ms","start":"2026-08-14T08:57:04.252436Z","end":"2026-08-14T08:57:04.530632Z","steps":["trace[262979598] 'read index received' (duration: 133.123597ms)","trace[262979598] 'applied index is now lower than readState.Index' (duration: 145.071111ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T08:57:04.530737Z","caller":"traceutil/trace.go:171","msg":"trace[805830009] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"336.671555ms","start":"2026-08-14T08:57:04.194049Z","end":"2026-08-14T08:57:04.530721Z","steps":["trace[805830009] 'process raft request' (duration: 191.584864ms)","trace[805830009] 'compare' (duration: 144.563478ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T08:57:04.530828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:57:04.194027Z","time spent":"336.752898ms","remote":"127.0.0.1:41186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T08:57:04.531041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.606478ms","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-14T08:57:04.53109Z","caller":"traceutil/trace.go:171","msg":"trace[4099656] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2128; }","duration":"278.68559ms","start":"2026-08-14T08:57:04.252392Z","end":"2026-08-14T08:57:04.531078Z","steps":["trace[4099656] 'agreement among raft nodes before linearized reading' (duration: 278.483866ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T08:57:04.818758Z","caller":"traceutil/trace.go:171","msg":"trace[509893200] linearizableReadLoop","detail":"{readStateIndex:2213; appliedIndex:2212; }","duration":"288.043217ms","start":"2026-08-14T08:57:04.530689Z","end":"2026-08-14T08:57:04.818732Z","steps":["trace[509893200] 'read index received' (duration: 230.064383ms)","trace[509893200] 'applied index is now lower than readState.Index' (duration: 57.977534ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T08:57:04.81885Z","caller":"traceutil/trace.go:171","msg":"trace[1265726489] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"369.902031ms","start":"2026-08-14T08:57:04.448916Z","end":"2026-08-14T08:57:04.818818Z","steps":["trace[1265726489] 'process raft request' (duration: 311.814293ms)","trace[1265726489] 'compare' (duration: 57.824891ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T08:57:04.818955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.197749ms","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-14T08:57:04.819Z","caller":"traceutil/trace.go:171","msg":"trace[990013818] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2129; }","duration":"506.28509ms","start":"2026-08-14T08:57:04.312704Z","end":"2026-08-14T08:57:04.818989Z","steps":["trace[990013818] 'agreement among raft nodes before linearized reading' (duration: 506.151507ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:57:04.818958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.22671ms","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-14T08:57:04.819031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:57:04.312688Z","time spent":"506.336371ms","remote":"127.0.0.1:41446","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-14T08:57:04.819054Z","caller":"traceutil/trace.go:171","msg":"trace[600543784] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2129; }","duration":"475.366394ms","start":"2026-08-14T08:57:04.343671Z","end":"2026-08-14T08:57:04.819037Z","steps":["trace[600543784] 'agreement among raft nodes before linearized reading' (duration: 475.136529ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:57:04.819096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:57:04.448898Z","time spent":"370.096487ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T08:57:04.819112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:57:04.34365Z","time spent":"475.436086ms","remote":"127.0.0.1:41446","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-14T08:57:04.818979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.822544ms","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-14T08:57:04.819783Z","caller":"traceutil/trace.go:171","msg":"trace[1126252814] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2129; }","duration":"380.672905ms","start":"2026-08-14T08:57:04.439085Z","end":"2026-08-14T08:57:04.819758Z","steps":["trace[1126252814] 'agreement among raft nodes before linearized reading' (duration: 379.70618ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:57:04.819839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:57:04.439062Z","time spent":"380.757748ms","remote":"127.0.0.1:54502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-08-14T08:57:04.85147Z","caller":"traceutil/trace.go:171","msg":"trace[293322945] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"316.898192ms","start":"2026-08-14T08:57:04.534552Z","end":"2026-08-14T08:57:04.851451Z","steps":["trace[293322945] 'process raft request' (duration: 316.781899ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:57:04.851616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:57:04.534528Z","time spent":"317.022436ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T08:57:04.867278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.383887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-08-14T08:57:04.867365Z","caller":"traceutil/trace.go:171","msg":"trace[1697872168] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:2133; }","duration":"334.538401ms","start":"2026-08-14T08:57:04.532809Z","end":"2026-08-14T08:57:04.867348Z","steps":["trace[1697872168] 'agreement among raft nodes before linearized reading' (duration: 334.384236ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:57:04.867394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:57:04.532786Z","time spent":"334.600653ms","remote":"127.0.0.1:41336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-08-14T08:57:04.867587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.772677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T08:57:04.867614Z","caller":"traceutil/trace.go:171","msg":"trace[1951791593] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2133; }","duration":"266.829988ms","start":"2026-08-14T08:57:04.600777Z","end":"2026-08-14T08:57:04.867607Z","steps":["trace[1951791593] 'agreement among raft nodes before linearized reading' (duration: 266.784367ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:58:21.36776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.541808ms","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-14T08:58:21.367859Z","caller":"traceutil/trace.go:171","msg":"trace[1348780957] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2643; }","duration":"190.680591ms","start":"2026-08-14T08:58:21.177159Z","end":"2026-08-14T08:58:21.36784Z","steps":["trace[1348780957] 'range keys from in-memory index tree' (duration: 190.385835ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:58:21.367779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.471325ms","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-14T08:58:21.368015Z","caller":"traceutil/trace.go:171","msg":"trace[1486806751] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2643; }","duration":"172.765841ms","start":"2026-08-14T08:58:21.195225Z","end":"2026-08-14T08:58:21.367991Z","steps":["trace[1486806751] 'range keys from in-memory index tree' (duration: 172.25462ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:58:21.368024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.689891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-14T08:58:21.368118Z","caller":"traceutil/trace.go:171","msg":"trace[2018285681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2643; }","duration":"176.818695ms","start":"2026-08-14T08:58:21.191283Z","end":"2026-08-14T08:58:21.368102Z","steps":["trace[2018285681] 'range keys from in-memory index tree' (duration: 176.517148ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:58:51.576501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.958531ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T08:58:51.576622Z","caller":"traceutil/trace.go:171","msg":"trace[707867943] linearizableReadLoop","detail":"{readStateIndex:2918; appliedIndex:2917; }","duration":"253.584086ms","start":"2026-08-14T08:58:51.323021Z","end":"2026-08-14T08:58:51.576605Z","steps":["trace[707867943] 'read index received' (duration: 9.365938ms)","trace[707867943] 'applied index is now lower than readState.Index' (duration: 244.216678ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T08:58:51.576659Z","caller":"traceutil/trace.go:171","msg":"trace[1920108509] transaction","detail":"{read_only:false; response_revision:2810; number_of_response:1; }","duration":"320.922482ms","start":"2026-08-14T08:58:51.255701Z","end":"2026-08-14T08:58:51.576624Z","steps":["trace[1920108509] 'process raft request' (duration: 76.738986ms)","trace[1920108509] 'compare' (duration: 243.742117ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T08:58:51.576734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.706289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T08:58:51.576769Z","caller":"traceutil/trace.go:171","msg":"trace[1867420587] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:2810; }","duration":"253.74285ms","start":"2026-08-14T08:58:51.323013Z","end":"2026-08-14T08:58:51.576756Z","steps":["trace[1867420587] 'agreement among raft nodes before linearized reading' (duration: 253.677208ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T08:58:51.576821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T08:58:51.255673Z","time spent":"321.068665ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T08:58:57.113968Z","caller":"traceutil/trace.go:171","msg":"trace[102819979] transaction","detail":"{read_only:false; response_revision:2839; number_of_response:1; }","duration":"228.637098ms","start":"2026-08-14T08:58:56.88531Z","end":"2026-08-14T08:58:57.113947Z","steps":["trace[102819979] 'process raft request' (duration: 228.520645ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:39.28546Z","caller":"traceutil/trace.go:171","msg":"trace[2045706924] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4634; }","duration":"163.310177ms","start":"2026-08-14T09:02:39.122119Z","end":"2026-08-14T09:02:39.285429Z","steps":["trace[2045706924] 'process raft request' (duration: 152.859495ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:40.199056Z","caller":"traceutil/trace.go:171","msg":"trace[1928234099] linearizableReadLoop","detail":"{readStateIndex:4824; appliedIndex:4823; }","duration":"119.012983ms","start":"2026-08-14T09:02:40.080019Z","end":"2026-08-14T09:02:40.199032Z","steps":["trace[1928234099] 'read index received' (duration: 118.802578ms)","trace[1928234099] 'applied index is now lower than readState.Index' (duration: 209.385µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:02:40.199229Z","caller":"traceutil/trace.go:171","msg":"trace[1619675387] transaction","detail":"{read_only:false; response_revision:4647; number_of_response:1; }","duration":"152.333114ms","start":"2026-08-14T09:02:40.04683Z","end":"2026-08-14T09:02:40.199163Z","steps":["trace[1619675387] 'process raft request' (duration: 152.046738ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:40.199354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.319609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9bf4c058-c15b-499f-80be-6e6db8e13f3c\" ","response":"range_response_count:1 size:4052"} {"level":"info","ts":"2026-08-14T09:02:40.199401Z","caller":"traceutil/trace.go:171","msg":"trace[832525889] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9bf4c058-c15b-499f-80be-6e6db8e13f3c; range_end:; response_count:1; response_revision:4647; }","duration":"119.43521ms","start":"2026-08-14T09:02:40.079954Z","end":"2026-08-14T09:02:40.199389Z","steps":["trace[832525889] 'agreement among raft nodes before linearized reading' (duration: 119.211246ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:40.61793Z","caller":"traceutil/trace.go:171","msg":"trace[450954884] transaction","detail":"{read_only:false; response_revision:4648; number_of_response:1; }","duration":"410.669018ms","start":"2026-08-14T09:02:40.20724Z","end":"2026-08-14T09:02:40.617909Z","steps":["trace[450954884] 'process raft request' (duration: 409.680318ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:40.618029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:40.207203Z","time spent":"410.76899ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4052,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:02:40.620493Z","caller":"traceutil/trace.go:171","msg":"trace[1633129830] linearizableReadLoop","detail":"{readStateIndex:4826; appliedIndex:4824; }","duration":"101.839655ms","start":"2026-08-14T09:02:40.518634Z","end":"2026-08-14T09:02:40.620474Z","steps":["trace[1633129830] 'read index received' (duration: 98.294763ms)","trace[1633129830] 'applied index is now lower than readState.Index' (duration: 3.543962ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:02:40.620672Z","caller":"traceutil/trace.go:171","msg":"trace[390895274] transaction","detail":"{read_only:false; response_revision:4649; number_of_response:1; }","duration":"138.318833ms","start":"2026-08-14T09:02:40.482322Z","end":"2026-08-14T09:02:40.620641Z","steps":["trace[390895274] 'process raft request' (duration: 138.049237ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:40.620804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.167792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9bf4c058-c15b-499f-80be-6e6db8e13f3c\" ","response":"range_response_count:1 size:4067"} {"level":"info","ts":"2026-08-14T09:02:40.620906Z","caller":"traceutil/trace.go:171","msg":"trace[213401366] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9bf4c058-c15b-499f-80be-6e6db8e13f3c; range_end:; response_count:1; response_revision:4650; }","duration":"102.296154ms","start":"2026-08-14T09:02:40.5186Z","end":"2026-08-14T09:02:40.620896Z","steps":["trace[213401366] 'agreement among raft nodes before linearized reading' (duration: 102.072ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:43.802784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.751438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-rbghw\" ","response":"range_response_count:1 size:5147"} {"level":"info","ts":"2026-08-14T09:02:43.802876Z","caller":"traceutil/trace.go:171","msg":"trace[375214404] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-rbghw; range_end:; response_count:1; response_revision:4727; }","duration":"192.875631ms","start":"2026-08-14T09:02:43.609965Z","end":"2026-08-14T09:02:43.802841Z","steps":["trace[375214404] 'range keys from in-memory index tree' (duration: 192.543004ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:43.803143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.990173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:02:43.803175Z","caller":"traceutil/trace.go:171","msg":"trace[1533661499] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:4727; }","duration":"308.063804ms","start":"2026-08-14T09:02:43.495104Z","end":"2026-08-14T09:02:43.803168Z","steps":["trace[1533661499] 'count revisions from in-memory index tree' (duration: 307.914872ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:43.803196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:43.495084Z","time spent":"308.104605ms","remote":"127.0.0.1:41416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:02:43.804502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.088227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:02:43.804572Z","caller":"traceutil/trace.go:171","msg":"trace[1151611711] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4727; }","duration":"201.201179ms","start":"2026-08-14T09:02:43.603352Z","end":"2026-08-14T09:02:43.804553Z","steps":["trace[1151611711] 'range keys from in-memory index tree' (duration: 199.79262ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:44.019871Z","caller":"traceutil/trace.go:171","msg":"trace[728680868] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"210.343414ms","start":"2026-08-14T09:02:43.809501Z","end":"2026-08-14T09:02:44.019845Z","steps":["trace[728680868] 'process raft request' (duration: 210.055528ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:44.441024Z","caller":"traceutil/trace.go:171","msg":"trace[1981538473] transaction","detail":"{read_only:false; response_revision:4730; number_of_response:1; }","duration":"414.822637ms","start":"2026-08-14T09:02:44.026174Z","end":"2026-08-14T09:02:44.440996Z","steps":["trace[1981538473] 'process raft request' (duration: 414.557532ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:44.4412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:44.026152Z","time spent":"414.96259ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1853,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:02:44.44128Z","caller":"traceutil/trace.go:171","msg":"trace[1618772146] linearizableReadLoop","detail":"{readStateIndex:4911; appliedIndex:4909; }","duration":"412.655122ms","start":"2026-08-14T09:02:44.028603Z","end":"2026-08-14T09:02:44.441259Z","steps":["trace[1618772146] 'read index received' (duration: 63.783236ms)","trace[1618772146] 'applied index is now lower than readState.Index' (duration: 348.871206ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:02:44.44151Z","caller":"traceutil/trace.go:171","msg":"trace[1123338784] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"412.865318ms","start":"2026-08-14T09:02:44.028636Z","end":"2026-08-14T09:02:44.441501Z","steps":["trace[1123338784] 'process raft request' (duration: 412.260995ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:44.441618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:44.028623Z","time spent":"412.914488ms","remote":"127.0.0.1:47432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4883,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:02:44.441691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.077981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:02:44.441741Z","caller":"traceutil/trace.go:171","msg":"trace[1717465771] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:4731; }","duration":"413.147913ms","start":"2026-08-14T09:02:44.028582Z","end":"2026-08-14T09:02:44.44173Z","steps":["trace[1717465771] 'agreement among raft nodes before linearized reading' (duration: 413.060171ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:44.441784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:44.028576Z","time spent":"413.196514ms","remote":"127.0.0.1:41648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":16,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:02:44.474788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.088044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:02:44.474821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.16023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-k7d7c\" ","response":"range_response_count:1 size:9670"} {"level":"info","ts":"2026-08-14T09:02:44.474877Z","caller":"traceutil/trace.go:171","msg":"trace[231547971] transaction","detail":"{read_only:false; response_revision:4733; number_of_response:1; }","duration":"260.123256ms","start":"2026-08-14T09:02:44.214714Z","end":"2026-08-14T09:02:44.474837Z","steps":["trace[231547971] 'process raft request' (duration: 259.755899ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:44.474915Z","caller":"traceutil/trace.go:171","msg":"trace[712658401] transaction","detail":"{read_only:false; response_revision:4734; number_of_response:1; }","duration":"196.414012ms","start":"2026-08-14T09:02:44.278492Z","end":"2026-08-14T09:02:44.474906Z","steps":["trace[712658401] 'process raft request' (duration: 196.059434ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:44.474945Z","caller":"traceutil/trace.go:171","msg":"trace[130583020] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-k7d7c; range_end:; response_count:1; response_revision:4734; }","duration":"339.364846ms","start":"2026-08-14T09:02:44.135535Z","end":"2026-08-14T09:02:44.4749Z","steps":["trace[130583020] 'agreement among raft nodes before linearized reading' (duration: 339.07955ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:44.475103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:44.135512Z","time spent":"339.498698ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":9693,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-k7d7c\" "} {"level":"warn","ts":"2026-08-14T09:02:44.47516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.815186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.35\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-14T09:02:44.474864Z","caller":"traceutil/trace.go:171","msg":"trace[837197375] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:4734; }","duration":"252.207937ms","start":"2026-08-14T09:02:44.222641Z","end":"2026-08-14T09:02:44.474849Z","steps":["trace[837197375] 'agreement among raft nodes before linearized reading' (duration: 252.081245ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:44.475342Z","caller":"traceutil/trace.go:171","msg":"trace[83371435] transaction","detail":"{read_only:false; response_revision:4732; number_of_response:1; }","duration":"338.888656ms","start":"2026-08-14T09:02:44.136282Z","end":"2026-08-14T09:02:44.47517Z","steps":["trace[83371435] 'process raft request' (duration: 337.980718ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:44.475463Z","caller":"traceutil/trace.go:171","msg":"trace[1226748522] range","detail":"{range_begin:/registry/masterleases/199.204.45.35; range_end:; response_count:1; response_revision:4734; }","duration":"293.896578ms","start":"2026-08-14T09:02:44.181286Z","end":"2026-08-14T09:02:44.475182Z","steps":["trace[1226748522] 'agreement among raft nodes before linearized reading' (duration: 293.750725ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:44.47578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:44.136267Z","time spent":"339.391046ms","remote":"127.0.0.1:41232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":904,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-14T09:02:44.558093Z","caller":"traceutil/trace.go:171","msg":"trace[1598036731] transaction","detail":"{read_only:false; response_revision:4735; number_of_response:1; }","duration":"107.11914ms","start":"2026-08-14T09:02:44.450929Z","end":"2026-08-14T09:02:44.558048Z","steps":["trace[1598036731] 'process raft request' (duration: 85.876302ms)","trace[1598036731] 'compare' (duration: 21.106616ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:02:50.78278Z","caller":"traceutil/trace.go:171","msg":"trace[2061243321] linearizableReadLoop","detail":"{readStateIndex:5022; appliedIndex:5021; }","duration":"178.864674ms","start":"2026-08-14T09:02:50.60389Z","end":"2026-08-14T09:02:50.782755Z","steps":["trace[2061243321] 'read index received' (duration: 177.965695ms)","trace[2061243321] 'applied index is now lower than readState.Index' (duration: 897.669µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:02:50.782884Z","caller":"traceutil/trace.go:171","msg":"trace[1836626158] transaction","detail":"{read_only:false; response_revision:4838; number_of_response:1; }","duration":"285.776089ms","start":"2026-08-14T09:02:50.497097Z","end":"2026-08-14T09:02:50.782873Z","steps":["trace[1836626158] 'process raft request' (duration: 285.448173ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:50.782989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.093259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:02:50.783044Z","caller":"traceutil/trace.go:171","msg":"trace[1912838916] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4838; }","duration":"179.180401ms","start":"2026-08-14T09:02:50.603837Z","end":"2026-08-14T09:02:50.783018Z","steps":["trace[1912838916] 'agreement among raft nodes before linearized reading' (duration: 179.085869ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:51.114994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.343177ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:02:51.115304Z","caller":"traceutil/trace.go:171","msg":"trace[365873535] transaction","detail":"{read_only:false; response_revision:4839; number_of_response:1; }","duration":"431.151248ms","start":"2026-08-14T09:02:50.684108Z","end":"2026-08-14T09:02:51.115259Z","steps":["trace[365873535] 'process raft request' (duration: 232.451324ms)","trace[365873535] 'compare' (duration: 197.961039ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:02:51.115458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:50.684076Z","time spent":"431.301551ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:02:51.115512Z","caller":"traceutil/trace.go:171","msg":"trace[1159787556] linearizableReadLoop","detail":"{readStateIndex:5024; appliedIndex:5022; }","duration":"332.621442ms","start":"2026-08-14T09:02:50.782847Z","end":"2026-08-14T09:02:51.115468Z","steps":["trace[1159787556] 'read index received' (duration: 133.721874ms)","trace[1159787556] 'applied index is now lower than readState.Index' (duration: 198.898688ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:02:51.115791Z","caller":"traceutil/trace.go:171","msg":"trace[1223444184] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"423.642627ms","start":"2026-08-14T09:02:50.692095Z","end":"2026-08-14T09:02:51.115738Z","steps":["trace[1223444184] 'process raft request' (duration: 423.271839ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:51.115858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.385312ms","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":"warn","ts":"2026-08-14T09:02:51.115899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:50.692073Z","time spent":"423.754578ms","remote":"127.0.0.1:41446","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-14T09:02:51.115927Z","caller":"traceutil/trace.go:171","msg":"trace[157829500] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:4840; }","duration":"488.493764ms","start":"2026-08-14T09:02:50.62742Z","end":"2026-08-14T09:02:51.115914Z","steps":["trace[157829500] 'agreement among raft nodes before linearized reading' (duration: 488.342461ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:51.115966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:50.627404Z","time spent":"488.550485ms","remote":"127.0.0.1:41208","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":"info","ts":"2026-08-14T09:02:51.212993Z","caller":"traceutil/trace.go:171","msg":"trace[1572668872] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"426.595716ms","start":"2026-08-14T09:02:50.786347Z","end":"2026-08-14T09:02:51.212943Z","steps":["trace[1572668872] 'process raft request' (duration: 426.468774ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:51.213076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.166958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-08-14T09:02:51.213078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.678813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:02:51.213138Z","caller":"traceutil/trace.go:171","msg":"trace[103709901] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4841; }","duration":"361.26037ms","start":"2026-08-14T09:02:50.851861Z","end":"2026-08-14T09:02:51.213122Z","steps":["trace[103709901] 'agreement among raft nodes before linearized reading' (duration: 361.078736ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:51.213145Z","caller":"traceutil/trace.go:171","msg":"trace[1178984635] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:4841; }","duration":"198.807396ms","start":"2026-08-14T09:02:51.014323Z","end":"2026-08-14T09:02:51.213131Z","steps":["trace[1178984635] 'agreement among raft nodes before linearized reading' (duration: 198.675394ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:51.21315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.36063ms","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-14T09:02:51.213217Z","caller":"traceutil/trace.go:171","msg":"trace[2057249553] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4841; }","duration":"284.478453ms","start":"2026-08-14T09:02:50.928725Z","end":"2026-08-14T09:02:51.213203Z","steps":["trace[2057249553] 'agreement among raft nodes before linearized reading' (duration: 284.253619ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:51.213257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.962953ms","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-14T09:02:51.213319Z","caller":"traceutil/trace.go:171","msg":"trace[64531834] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4841; }","duration":"356.061645ms","start":"2026-08-14T09:02:50.857248Z","end":"2026-08-14T09:02:51.21331Z","steps":["trace[64531834] 'agreement among raft nodes before linearized reading' (duration: 355.947193ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:51.213345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:50.857228Z","time spent":"356.111377ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-14T09:02:51.213327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:50.786328Z","time spent":"426.76602ms","remote":"127.0.0.1:41232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":853,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-14T09:02:51.213385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.318623ms","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-14T09:02:51.213176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:50.851844Z","time spent":"361.324021ms","remote":"127.0.0.1:41446","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":"info","ts":"2026-08-14T09:02:51.213449Z","caller":"traceutil/trace.go:171","msg":"trace[1672735829] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4841; }","duration":"377.400246ms","start":"2026-08-14T09:02:50.83603Z","end":"2026-08-14T09:02:51.21343Z","steps":["trace[1672735829] 'agreement among raft nodes before linearized reading' (duration: 377.292973ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:51.213499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:50.836013Z","time spent":"377.477446ms","remote":"127.0.0.1:41446","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-14T09:02:51.213243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.907523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16084"} {"level":"info","ts":"2026-08-14T09:02:51.213581Z","caller":"traceutil/trace.go:171","msg":"trace[874156425] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4841; }","duration":"426.26642ms","start":"2026-08-14T09:02:50.787297Z","end":"2026-08-14T09:02:51.213563Z","steps":["trace[874156425] 'agreement among raft nodes before linearized reading' (duration: 425.741739ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:51.213635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.304227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"warn","ts":"2026-08-14T09:02:51.213652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:50.787257Z","time spent":"426.374763ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":16107,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-08-14T09:02:51.213673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.412133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:02:51.213786Z","caller":"traceutil/trace.go:171","msg":"trace[1788298540] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4841; }","duration":"428.577247ms","start":"2026-08-14T09:02:50.785184Z","end":"2026-08-14T09:02:51.213761Z","steps":["trace[1788298540] 'agreement among raft nodes before linearized reading' (duration: 427.73221ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:51.213711Z","caller":"traceutil/trace.go:171","msg":"trace[1479476029] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4841; }","duration":"402.419119ms","start":"2026-08-14T09:02:50.811271Z","end":"2026-08-14T09:02:51.213691Z","steps":["trace[1479476029] 'agreement among raft nodes before linearized reading' (duration: 401.683944ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:51.213854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:50.785163Z","time spent":"428.675059ms","remote":"127.0.0.1:41150","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-14T09:02:51.213913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:50.81125Z","time spent":"402.639514ms","remote":"127.0.0.1:41320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-08-14T09:02:51.369906Z","caller":"traceutil/trace.go:171","msg":"trace[21902297] linearizableReadLoop","detail":"{readStateIndex:5026; appliedIndex:5025; }","duration":"152.094305ms","start":"2026-08-14T09:02:51.217791Z","end":"2026-08-14T09:02:51.369885Z","steps":["trace[21902297] 'read index received' (duration: 121.58237ms)","trace[21902297] 'applied index is now lower than readState.Index' (duration: 30.511155ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:02:51.369952Z","caller":"traceutil/trace.go:171","msg":"trace[1069503291] transaction","detail":"{read_only:false; response_revision:4842; number_of_response:1; }","duration":"243.609969ms","start":"2026-08-14T09:02:51.126319Z","end":"2026-08-14T09:02:51.369929Z","steps":["trace[1069503291] 'process raft request' (duration: 212.974941ms)","trace[1069503291] 'compare' (duration: 30.489595ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:02:51.371144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.33398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-9bf4c058-c15b-499f-80be-6e6db8e13f3c\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-08-14T09:02:51.371608Z","caller":"traceutil/trace.go:171","msg":"trace[1055774165] range","detail":"{range_begin:/registry/persistentvolumes/pvc-9bf4c058-c15b-499f-80be-6e6db8e13f3c; range_end:; response_count:1; response_revision:4842; }","duration":"153.474102ms","start":"2026-08-14T09:02:51.21776Z","end":"2026-08-14T09:02:51.371234Z","steps":["trace[1055774165] 'agreement among raft nodes before linearized reading' (duration: 152.202886ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:51.406773Z","caller":"traceutil/trace.go:171","msg":"trace[1839284887] transaction","detail":"{read_only:false; response_revision:4844; number_of_response:1; }","duration":"187.875326ms","start":"2026-08-14T09:02:51.218871Z","end":"2026-08-14T09:02:51.406746Z","steps":["trace[1839284887] 'process raft request' (duration: 187.788234ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:51.406801Z","caller":"traceutil/trace.go:171","msg":"trace[918980670] transaction","detail":"{read_only:false; response_revision:4843; number_of_response:1; }","duration":"188.751564ms","start":"2026-08-14T09:02:51.21801Z","end":"2026-08-14T09:02:51.406761Z","steps":["trace[918980670] 'process raft request' (duration: 188.513749ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:51.407064Z","caller":"traceutil/trace.go:171","msg":"trace[12977912] transaction","detail":"{read_only:false; response_revision:4845; number_of_response:1; }","duration":"186.767084ms","start":"2026-08-14T09:02:51.220281Z","end":"2026-08-14T09:02:51.407048Z","steps":["trace[12977912] 'process raft request' (duration: 186.424186ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:51.407208Z","caller":"traceutil/trace.go:171","msg":"trace[2010869300] transaction","detail":"{read_only:false; response_revision:4846; number_of_response:1; }","duration":"186.717772ms","start":"2026-08-14T09:02:51.220466Z","end":"2026-08-14T09:02:51.407184Z","steps":["trace[2010869300] 'process raft request' (duration: 186.441816ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:51.40733Z","caller":"traceutil/trace.go:171","msg":"trace[587335588] transaction","detail":"{read_only:false; response_revision:4847; number_of_response:1; }","duration":"179.890665ms","start":"2026-08-14T09:02:51.227421Z","end":"2026-08-14T09:02:51.407312Z","steps":["trace[587335588] 'process raft request' (duration: 179.63544ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:51.407358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.420735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:02:51.407464Z","caller":"traceutil/trace.go:171","msg":"trace[2042825618] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:4847; }","duration":"177.562637ms","start":"2026-08-14T09:02:51.229887Z","end":"2026-08-14T09:02:51.40745Z","steps":["trace[2042825618] 'agreement among raft nodes before linearized reading' (duration: 177.373014ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:51.407478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.488267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-6f9465b5f4-xc987.18cba084be41b18b\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-08-14T09:02:51.407668Z","caller":"traceutil/trace.go:171","msg":"trace[1438703429] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-6f9465b5f4-xc987.18cba084be41b18b; range_end:; response_count:1; response_revision:4847; }","duration":"189.711581ms","start":"2026-08-14T09:02:51.217943Z","end":"2026-08-14T09:02:51.407654Z","steps":["trace[1438703429] 'agreement among raft nodes before linearized reading' (duration: 189.415255ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:51.407826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.090495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c306ee24-c005-4efc-9b6c-3c8478134035\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-08-14T09:02:51.407882Z","caller":"traceutil/trace.go:171","msg":"trace[958303881] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c306ee24-c005-4efc-9b6c-3c8478134035; range_end:; response_count:1; response_revision:4847; }","duration":"149.178356ms","start":"2026-08-14T09:02:51.258691Z","end":"2026-08-14T09:02:51.40787Z","steps":["trace[958303881] 'agreement among raft nodes before linearized reading' (duration: 149.003803ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:51.926182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.937427ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:02:51.926553Z","caller":"traceutil/trace.go:171","msg":"trace[1009470092] transaction","detail":"{read_only:false; response_revision:4849; number_of_response:1; }","duration":"510.472436ms","start":"2026-08-14T09:02:51.416028Z","end":"2026-08-14T09:02:51.9265Z","steps":["trace[1009470092] 'process raft request' (duration: 384.13148ms)","trace[1009470092] 'compare' (duration: 125.356316ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:02:51.926754Z","caller":"traceutil/trace.go:171","msg":"trace[586694332] transaction","detail":"{read_only:false; response_revision:4851; number_of_response:1; }","duration":"510.212191ms","start":"2026-08-14T09:02:51.416474Z","end":"2026-08-14T09:02:51.926686Z","steps":["trace[586694332] 'process raft request' (duration: 509.923675ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:51.926796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:51.416016Z","time spent":"510.6884ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1851,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:02:51.926576Z","caller":"traceutil/trace.go:171","msg":"trace[769311991] transaction","detail":"{read_only:false; response_revision:4852; number_of_response:1; }","duration":"509.798192ms","start":"2026-08-14T09:02:51.416756Z","end":"2026-08-14T09:02:51.926554Z","steps":["trace[769311991] 'process raft request' (duration: 509.711851ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:51.927033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:51.416692Z","time spent":"510.293133ms","remote":"127.0.0.1:41336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1271,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:02:51.926645Z","caller":"traceutil/trace.go:171","msg":"trace[2111235406] transaction","detail":"{read_only:false; response_revision:4850; number_of_response:1; }","duration":"510.462035ms","start":"2026-08-14T09:02:51.416163Z","end":"2026-08-14T09:02:51.926625Z","steps":["trace[2111235406] 'process raft request' (duration: 510.118899ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:51.927126Z","caller":"traceutil/trace.go:171","msg":"trace[57485241] transaction","detail":"{read_only:false; response_revision:4853; number_of_response:1; }","duration":"509.912064ms","start":"2026-08-14T09:02:51.417186Z","end":"2026-08-14T09:02:51.927098Z","steps":["trace[57485241] 'process raft request' (duration: 509.328612ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:51.927303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:51.416468Z","time spent":"510.371384ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1391,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:02:51.92732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:51.417177Z","time spent":"510.044307ms","remote":"127.0.0.1:41336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":848,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:02:51.927792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:51.416157Z","time spent":"511.005516ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:02:52.846032Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.045766528s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-14T09:02:52.98677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"914.650247ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:02:52.986895Z","caller":"traceutil/trace.go:171","msg":"trace[2019416750] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4853; }","duration":"914.791049ms","start":"2026-08-14T09:02:52.072085Z","end":"2026-08-14T09:02:52.986876Z","steps":["trace[2019416750] 'range keys from in-memory index tree' (duration: 914.632746ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:52.987196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.873748ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:02:52.987367Z","caller":"traceutil/trace.go:171","msg":"trace[1047021514] transaction","detail":"{read_only:false; response_revision:4855; number_of_response:1; }","duration":"198.439998ms","start":"2026-08-14T09:02:52.78891Z","end":"2026-08-14T09:02:52.98735Z","steps":["trace[1047021514] 'process raft request' (duration: 198.376967ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:02:52.987388Z","caller":"traceutil/trace.go:171","msg":"trace[681880569] linearizableReadLoop","detail":"{readStateIndex:5038; appliedIndex:5032; }","duration":"1.383438272s","start":"2026-08-14T09:02:51.60393Z","end":"2026-08-14T09:02:52.987368Z","steps":["trace[681880569] 'read index received' (duration: 196.274575ms)","trace[681880569] 'applied index is now lower than readState.Index' (duration: 1.187161187s)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:02:52.987445Z","caller":"traceutil/trace.go:171","msg":"trace[686799508] transaction","detail":"{read_only:false; response_revision:4854; number_of_response:1; }","duration":"1.549001458s","start":"2026-08-14T09:02:51.438384Z","end":"2026-08-14T09:02:52.987386Z","steps":["trace[686799508] 'process raft request' (duration: 1.407855314s)","trace[686799508] 'compare' (duration: 140.645213ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:02:52.98759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:51.438369Z","time spent":"1.549143931s","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3750,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:02:52.987649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.383747718s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:02:52.987718Z","caller":"traceutil/trace.go:171","msg":"trace[1797689403] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4855; }","duration":"1.38385555s","start":"2026-08-14T09:02:51.603851Z","end":"2026-08-14T09:02:52.987707Z","steps":["trace[1797689403] 'agreement among raft nodes before linearized reading' (duration: 1.383692766s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:52.987793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:51.603832Z","time spent":"1.383949583s","remote":"127.0.0.1:41136","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-14T09:02:52.988145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.191228149s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:02:52.988211Z","caller":"traceutil/trace.go:171","msg":"trace[1478618987] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:4855; }","duration":"1.1913344s","start":"2026-08-14T09:02:51.796861Z","end":"2026-08-14T09:02:52.988196Z","steps":["trace[1478618987] 'agreement among raft nodes before linearized reading' (duration: 1.191231838s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:52.988299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:51.796842Z","time spent":"1.191442143s","remote":"127.0.0.1:35528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:02:52.988794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.363179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:02:52.988856Z","caller":"traceutil/trace.go:171","msg":"trace[1582071810] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4855; }","duration":"144.451579ms","start":"2026-08-14T09:02:52.844386Z","end":"2026-08-14T09:02:52.988838Z","steps":["trace[1582071810] 'agreement among raft nodes before linearized reading' (duration: 144.362248ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:52.989057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.110129285s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-08-14T09:02:52.989117Z","caller":"traceutil/trace.go:171","msg":"trace[616499702] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4855; }","duration":"1.110230357s","start":"2026-08-14T09:02:51.878871Z","end":"2026-08-14T09:02:52.989101Z","steps":["trace[616499702] 'agreement among raft nodes before linearized reading' (duration: 1.110064683s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:52.989153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:51.878849Z","time spent":"1.110295648s","remote":"127.0.0.1:41320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-08-14T09:02:52.989571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.097226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c306ee24-c005-4efc-9b6c-3c8478134035\" ","response":"range_response_count:1 size:3765"} {"level":"info","ts":"2026-08-14T09:02:52.989673Z","caller":"traceutil/trace.go:171","msg":"trace[718156598] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c306ee24-c005-4efc-9b6c-3c8478134035; range_end:; response_count:1; response_revision:4855; }","duration":"573.244048ms","start":"2026-08-14T09:02:52.416408Z","end":"2026-08-14T09:02:52.989652Z","steps":["trace[718156598] 'agreement among raft nodes before linearized reading' (duration: 572.668467ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:02:52.990163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:02:52.416388Z","time spent":"573.75648ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3788,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c306ee24-c005-4efc-9b6c-3c8478134035\" "} {"level":"info","ts":"2026-08-14T09:02:53.205309Z","caller":"traceutil/trace.go:171","msg":"trace[1912318494] transaction","detail":"{read_only:false; response_revision:4856; number_of_response:1; }","duration":"148.227516ms","start":"2026-08-14T09:02:53.057046Z","end":"2026-08-14T09:02:53.205273Z","steps":["trace[1912318494] 'process raft request' (duration: 135.781296ms)","trace[1912318494] 'compare' (duration: 12.287397ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:02:56.365821Z","caller":"traceutil/trace.go:171","msg":"trace[1029519313] transaction","detail":"{read_only:false; response_revision:4915; number_of_response:1; }","duration":"134.545929ms","start":"2026-08-14T09:02:56.231256Z","end":"2026-08-14T09:02:56.365802Z","steps":["trace[1029519313] 'process raft request' (duration: 134.418777ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:00.254357Z","caller":"traceutil/trace.go:171","msg":"trace[1753103403] linearizableReadLoop","detail":"{readStateIndex:5143; appliedIndex:5142; }","duration":"109.654248ms","start":"2026-08-14T09:03:00.144682Z","end":"2026-08-14T09:03:00.254337Z","steps":["trace[1753103403] 'read index received' (duration: 101.538394ms)","trace[1753103403] 'applied index is now lower than readState.Index' (duration: 8.115234ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:03:00.254608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.892412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-08-14T09:03:00.254647Z","caller":"traceutil/trace.go:171","msg":"trace[180191415] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4956; }","duration":"109.962723ms","start":"2026-08-14T09:03:00.144667Z","end":"2026-08-14T09:03:00.25463Z","steps":["trace[180191415] 'agreement among raft nodes before linearized reading' (duration: 109.754779ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:00.254626Z","caller":"traceutil/trace.go:171","msg":"trace[784682738] transaction","detail":"{read_only:false; response_revision:4956; number_of_response:1; }","duration":"112.27247ms","start":"2026-08-14T09:03:00.142295Z","end":"2026-08-14T09:03:00.254567Z","steps":["trace[784682738] 'process raft request' (duration: 103.872811ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:02.661449Z","caller":"traceutil/trace.go:171","msg":"trace[162508729] transaction","detail":"{read_only:false; response_revision:4992; number_of_response:1; }","duration":"200.726748ms","start":"2026-08-14T09:03:02.460675Z","end":"2026-08-14T09:03:02.661402Z","steps":["trace[162508729] 'process raft request' (duration: 126.203899ms)","trace[162508729] 'compare' (duration: 73.857355ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:03:02.662125Z","caller":"traceutil/trace.go:171","msg":"trace[5254925] transaction","detail":"{read_only:false; response_revision:4993; number_of_response:1; }","duration":"199.971063ms","start":"2026-08-14T09:03:02.462081Z","end":"2026-08-14T09:03:02.662053Z","steps":["trace[5254925] 'process raft request' (duration: 199.272049ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:02.662341Z","caller":"traceutil/trace.go:171","msg":"trace[1980188549] transaction","detail":"{read_only:false; response_revision:4994; number_of_response:1; }","duration":"199.264969ms","start":"2026-08-14T09:03:02.463047Z","end":"2026-08-14T09:03:02.662312Z","steps":["trace[1980188549] 'process raft request' (duration: 198.910772ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:02.662747Z","caller":"traceutil/trace.go:171","msg":"trace[1602665531] transaction","detail":"{read_only:false; response_revision:4996; number_of_response:1; }","duration":"194.537694ms","start":"2026-08-14T09:03:02.468172Z","end":"2026-08-14T09:03:02.66271Z","steps":["trace[1602665531] 'process raft request' (duration: 194.175127ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:02.662869Z","caller":"traceutil/trace.go:171","msg":"trace[22545439] transaction","detail":"{read_only:false; response_revision:4995; number_of_response:1; }","duration":"198.471033ms","start":"2026-08-14T09:03:02.464388Z","end":"2026-08-14T09:03:02.662859Z","steps":["trace[22545439] 'process raft request' (duration: 197.613446ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:07.233211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.006321ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:03:07.233473Z","caller":"traceutil/trace.go:171","msg":"trace[1521638978] transaction","detail":"{read_only:false; response_revision:5038; number_of_response:1; }","duration":"199.281377ms","start":"2026-08-14T09:03:07.034166Z","end":"2026-08-14T09:03:07.233447Z","steps":["trace[1521638978] 'process raft request' (duration: 97.921898ms)","trace[1521638978] 'compare' (duration: 100.839018ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:03:07.23358Z","caller":"traceutil/trace.go:171","msg":"trace[848233301] linearizableReadLoop","detail":"{readStateIndex:5228; appliedIndex:5227; }","duration":"161.511947ms","start":"2026-08-14T09:03:07.072051Z","end":"2026-08-14T09:03:07.233563Z","steps":["trace[848233301] 'read index received' (duration: 59.926064ms)","trace[848233301] 'applied index is now lower than readState.Index' (duration: 101.584153ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:03:07.23371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.65443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-c306ee24-c005-4efc-9b6c-3c8478134035\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-08-14T09:03:07.233733Z","caller":"traceutil/trace.go:171","msg":"trace[1357971566] range","detail":"{range_begin:/registry/persistentvolumes/pvc-c306ee24-c005-4efc-9b6c-3c8478134035; range_end:; response_count:1; response_revision:5038; }","duration":"161.706681ms","start":"2026-08-14T09:03:07.072016Z","end":"2026-08-14T09:03:07.233723Z","steps":["trace[1357971566] 'agreement among raft nodes before linearized reading' (duration: 161.593249ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:07.234251Z","caller":"traceutil/trace.go:171","msg":"trace[1420522645] transaction","detail":"{read_only:false; response_revision:5042; number_of_response:1; }","duration":"158.499587ms","start":"2026-08-14T09:03:07.075742Z","end":"2026-08-14T09:03:07.234242Z","steps":["trace[1420522645] 'process raft request' (duration: 158.425685ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:07.234539Z","caller":"traceutil/trace.go:171","msg":"trace[1530355272] transaction","detail":"{read_only:false; response_revision:5041; number_of_response:1; }","duration":"159.420995ms","start":"2026-08-14T09:03:07.075091Z","end":"2026-08-14T09:03:07.234512Z","steps":["trace[1530355272] 'process raft request' (duration: 159.051227ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:07.234633Z","caller":"traceutil/trace.go:171","msg":"trace[1453750207] transaction","detail":"{read_only:false; response_revision:5040; number_of_response:1; }","duration":"159.718781ms","start":"2026-08-14T09:03:07.074906Z","end":"2026-08-14T09:03:07.234625Z","steps":["trace[1453750207] 'process raft request' (duration: 159.1959ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:07.234852Z","caller":"traceutil/trace.go:171","msg":"trace[488634595] transaction","detail":"{read_only:false; response_revision:5039; number_of_response:1; }","duration":"159.956726ms","start":"2026-08-14T09:03:07.074887Z","end":"2026-08-14T09:03:07.234844Z","steps":["trace[488634595] 'process raft request' (duration: 158.496966ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:08.713744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.004888051s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:03:08.713833Z","caller":"traceutil/trace.go:171","msg":"trace[1229187013] transaction","detail":"{read_only:false; response_revision:5043; number_of_response:1; }","duration":"1.445723495s","start":"2026-08-14T09:03:07.26809Z","end":"2026-08-14T09:03:08.713813Z","steps":["trace[1229187013] 'process raft request' (duration: 440.70148ms)","trace[1229187013] 'compare' (duration: 1.004513084s)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:03:08.713902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:03:07.26806Z","time spent":"1.445810287s","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:03:08.95053Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.241668372s","expected-duration":"1s"} {"level":"info","ts":"2026-08-14T09:03:08.995832Z","caller":"traceutil/trace.go:171","msg":"trace[298320030] linearizableReadLoop","detail":"{readStateIndex:5234; appliedIndex:5232; }","duration":"1.605758911s","start":"2026-08-14T09:03:07.390049Z","end":"2026-08-14T09:03:08.995808Z","steps":["trace[298320030] 'read index received' (duration: 318.81929ms)","trace[298320030] 'applied index is now lower than readState.Index' (duration: 1.286938511s)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:03:08.99586Z","caller":"traceutil/trace.go:171","msg":"trace[1055692975] transaction","detail":"{read_only:false; response_revision:5044; number_of_response:1; }","duration":"1.690025835s","start":"2026-08-14T09:03:07.305793Z","end":"2026-08-14T09:03:08.995819Z","steps":["trace[1055692975] 'process raft request' (duration: 1.644924299s)","trace[1055692975] 'compare' (duration: 44.840102ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:03:08.995946Z","caller":"traceutil/trace.go:171","msg":"trace[1495778747] transaction","detail":"{read_only:false; response_revision:5045; number_of_response:1; }","duration":"1.567953881s","start":"2026-08-14T09:03:07.427981Z","end":"2026-08-14T09:03:08.995935Z","steps":["trace[1495778747] 'process raft request' (duration: 1.567775318s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:08.996046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:03:07.305769Z","time spent":"1.690177138s","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:03:08.996104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:03:07.427956Z","time spent":"1.568016983s","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:03:08.996445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.606376064s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1986"} {"level":"info","ts":"2026-08-14T09:03:08.996687Z","caller":"traceutil/trace.go:171","msg":"trace[724789401] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:5045; }","duration":"1.606632319s","start":"2026-08-14T09:03:07.390015Z","end":"2026-08-14T09:03:08.996647Z","steps":["trace[724789401] 'agreement among raft nodes before linearized reading' (duration: 1.606247871s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:08.99704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:03:07.389997Z","time spent":"1.607025906s","remote":"127.0.0.1:41374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2009,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-08-14T09:03:09.089808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.486197226s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-14T09:03:09.089827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.58828609s","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-14T09:03:09.089871Z","caller":"traceutil/trace.go:171","msg":"trace[1366330966] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5046; }","duration":"1.486309679s","start":"2026-08-14T09:03:07.603546Z","end":"2026-08-14T09:03:09.089856Z","steps":["trace[1366330966] 'agreement among raft nodes before linearized reading' (duration: 1.486217318s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:09.089876Z","caller":"traceutil/trace.go:171","msg":"trace[1622616683] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5046; }","duration":"1.588371901s","start":"2026-08-14T09:03:07.501491Z","end":"2026-08-14T09:03:09.089863Z","steps":["trace[1622616683] 'agreement among raft nodes before linearized reading' (duration: 1.588257098s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:09.089868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.140648209s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"warn","ts":"2026-08-14T09:03:09.089877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.37745799s","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-14T09:03:09.089939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.851455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:03:09.089934Z","caller":"traceutil/trace.go:171","msg":"trace[1879316049] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:5046; }","duration":"1.377592884s","start":"2026-08-14T09:03:07.712327Z","end":"2026-08-14T09:03:09.08992Z","steps":["trace[1879316049] 'agreement among raft nodes before linearized reading' (duration: 1.377473392s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:09.089963Z","caller":"traceutil/trace.go:171","msg":"trace[376873357] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:5046; }","duration":"662.911715ms","start":"2026-08-14T09:03:08.427046Z","end":"2026-08-14T09:03:09.089958Z","steps":["trace[376873357] 'agreement among raft nodes before linearized reading' (duration: 662.870315ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:09.089983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:03:07.712307Z","time spent":"1.377662745s","remote":"127.0.0.1:41336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":37,"response size":30,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:03:09.090007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:03:08.427026Z","time spent":"662.948317ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":9,"response size":30,"request content":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:03:09.090046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.090835538s","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-14T09:03:09.090104Z","caller":"traceutil/trace.go:171","msg":"trace[148984500] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5046; }","duration":"1.09089388s","start":"2026-08-14T09:03:07.999197Z","end":"2026-08-14T09:03:09.090091Z","steps":["trace[148984500] 'agreement among raft nodes before linearized reading' (duration: 1.090762106s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:09.09015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:03:07.99915Z","time spent":"1.090989271s","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-14T09:03:09.089931Z","caller":"traceutil/trace.go:171","msg":"trace[671440946] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5046; }","duration":"1.140738141s","start":"2026-08-14T09:03:07.949171Z","end":"2026-08-14T09:03:09.089909Z","steps":["trace[671440946] 'agreement among raft nodes before linearized reading' (duration: 1.140475046s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:09.090277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:03:07.949158Z","time spent":"1.141076898s","remote":"127.0.0.1:41320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-08-14T09:03:09.089899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:03:07.603523Z","time spent":"1.486369931s","remote":"127.0.0.1:41136","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-14T09:03:09.090414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.584579545s","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-14T09:03:09.090467Z","caller":"traceutil/trace.go:171","msg":"trace[519751782] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5046; }","duration":"1.584657766s","start":"2026-08-14T09:03:07.505799Z","end":"2026-08-14T09:03:09.090457Z","steps":["trace[519751782] 'agreement among raft nodes before linearized reading' (duration: 1.584496213s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:09.089909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:03:07.501472Z","time spent":"1.588429613s","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-14T09:03:09.090525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:03:07.505788Z","time spent":"1.584726388s","remote":"127.0.0.1:41446","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-14T09:03:09.090523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.51816947s","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-14T09:03:09.090602Z","caller":"traceutil/trace.go:171","msg":"trace[555563268] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5046; }","duration":"1.518312332s","start":"2026-08-14T09:03:07.572271Z","end":"2026-08-14T09:03:09.090583Z","steps":["trace[555563268] 'agreement among raft nodes before linearized reading' (duration: 1.517392064s)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:09.090625Z","caller":"traceutil/trace.go:171","msg":"trace[1997321770] transaction","detail":"{read_only:false; response_revision:5046; number_of_response:1; }","duration":"859.62349ms","start":"2026-08-14T09:03:08.23097Z","end":"2026-08-14T09:03:09.090593Z","steps":["trace[1997321770] 'process raft request' (duration: 858.556229ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:09.090663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:03:07.572243Z","time spent":"1.518409014s","remote":"127.0.0.1:41446","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-14T09:03:09.090711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.514649378s","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-14T09:03:09.090734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:03:08.230945Z","time spent":"859.728622ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:03:09.090744Z","caller":"traceutil/trace.go:171","msg":"trace[1899666041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5046; }","duration":"1.51470094s","start":"2026-08-14T09:03:07.576033Z","end":"2026-08-14T09:03:09.090734Z","steps":["trace[1899666041] 'agreement among raft nodes before linearized reading' (duration: 1.514590428s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:09.090533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.859316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"warn","ts":"2026-08-14T09:03:09.090822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:03:07.57602Z","time spent":"1.51477294s","remote":"127.0.0.1:41446","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":"info","ts":"2026-08-14T09:03:09.090825Z","caller":"traceutil/trace.go:171","msg":"trace[904368422] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5046; }","duration":"193.217273ms","start":"2026-08-14T09:03:08.897581Z","end":"2026-08-14T09:03:09.090798Z","steps":["trace[904368422] 'agreement among raft nodes before linearized reading' (duration: 192.151752ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:09.090949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.144213952s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:17144"} {"level":"info","ts":"2026-08-14T09:03:09.090996Z","caller":"traceutil/trace.go:171","msg":"trace[48734155] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5046; }","duration":"1.144291903s","start":"2026-08-14T09:03:07.94668Z","end":"2026-08-14T09:03:09.090972Z","steps":["trace[48734155] 'agreement among raft nodes before linearized reading' (duration: 1.142971547s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:09.091015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:03:07.946658Z","time spent":"1.144352344s","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":17167,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-08-14T09:03:09.366732Z","caller":"traceutil/trace.go:171","msg":"trace[543603299] transaction","detail":"{read_only:false; response_revision:5057; number_of_response:1; }","duration":"146.680738ms","start":"2026-08-14T09:03:09.22003Z","end":"2026-08-14T09:03:09.366711Z","steps":["trace[543603299] 'process raft request' (duration: 146.547876ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:09.374649Z","caller":"traceutil/trace.go:171","msg":"trace[861627156] transaction","detail":"{read_only:false; response_revision:5058; number_of_response:1; }","duration":"136.577395ms","start":"2026-08-14T09:03:09.238048Z","end":"2026-08-14T09:03:09.374625Z","steps":["trace[861627156] 'process raft request' (duration: 136.233878ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:39.04905Z","caller":"traceutil/trace.go:171","msg":"trace[1803670919] transaction","detail":"{read_only:false; response_revision:5231; number_of_response:1; }","duration":"221.11466ms","start":"2026-08-14T09:03:38.827909Z","end":"2026-08-14T09:03:39.049023Z","steps":["trace[1803670919] 'process raft request' (duration: 220.913266ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:47.158983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.871181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/keystone-credential-keys\" ","response":"range_response_count:1 size:353"} {"level":"info","ts":"2026-08-14T09:03:47.159107Z","caller":"traceutil/trace.go:171","msg":"trace[1427115117] range","detail":"{range_begin:/registry/secrets/openstack/keystone-credential-keys; range_end:; response_count:1; response_revision:5370; }","duration":"208.012365ms","start":"2026-08-14T09:03:46.951074Z","end":"2026-08-14T09:03:47.159087Z","steps":["trace[1427115117] 'range keys from in-memory index tree' (duration: 207.536394ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:47.560324Z","caller":"traceutil/trace.go:171","msg":"trace[1151956952] linearizableReadLoop","detail":"{readStateIndex:5574; appliedIndex:5573; }","duration":"150.657166ms","start":"2026-08-14T09:03:47.409643Z","end":"2026-08-14T09:03:47.5603Z","steps":["trace[1151956952] 'read index received' (duration: 150.485313ms)","trace[1151956952] 'applied index is now lower than readState.Index' (duration: 170.943µs)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:03:47.560435Z","caller":"traceutil/trace.go:171","msg":"trace[468036797] transaction","detail":"{read_only:false; response_revision:5375; number_of_response:1; }","duration":"158.692016ms","start":"2026-08-14T09:03:47.401731Z","end":"2026-08-14T09:03:47.560423Z","steps":["trace[468036797] 'process raft request' (duration: 158.309039ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:47.560675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.011894ms","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-14T09:03:47.560756Z","caller":"traceutil/trace.go:171","msg":"trace[165210419] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5375; }","duration":"151.116015ms","start":"2026-08-14T09:03:47.409617Z","end":"2026-08-14T09:03:47.560733Z","steps":["trace[165210419] 'agreement among raft nodes before linearized reading' (duration: 150.934452ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:47.568109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.492673ms","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-14T09:03:47.568151Z","caller":"traceutil/trace.go:171","msg":"trace[1908199008] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5376; }","duration":"133.586304ms","start":"2026-08-14T09:03:47.434554Z","end":"2026-08-14T09:03:47.56814Z","steps":["trace[1908199008] 'agreement among raft nodes before linearized reading' (duration: 133.479792ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:47.568432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.140796ms","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-14T09:03:47.568456Z","caller":"traceutil/trace.go:171","msg":"trace[275393471] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5376; }","duration":"126.180106ms","start":"2026-08-14T09:03:47.44227Z","end":"2026-08-14T09:03:47.568451Z","steps":["trace[275393471] 'agreement among raft nodes before linearized reading' (duration: 126.109265ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:03:47.568536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.90285ms","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-14T09:03:47.568555Z","caller":"traceutil/trace.go:171","msg":"trace[1172029001] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5376; }","duration":"132.956031ms","start":"2026-08-14T09:03:47.435594Z","end":"2026-08-14T09:03:47.56855Z","steps":["trace[1172029001] 'agreement among raft nodes before linearized reading' (duration: 132.90818ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:49.3828Z","caller":"traceutil/trace.go:171","msg":"trace[1879489209] transaction","detail":"{read_only:false; response_revision:5385; number_of_response:1; }","duration":"131.009711ms","start":"2026-08-14T09:03:49.251775Z","end":"2026-08-14T09:03:49.382785Z","steps":["trace[1879489209] 'process raft request' (duration: 130.758436ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:03:49.383003Z","caller":"traceutil/trace.go:171","msg":"trace[338209150] transaction","detail":"{read_only:false; response_revision:5384; number_of_response:1; }","duration":"144.736776ms","start":"2026-08-14T09:03:49.23787Z","end":"2026-08-14T09:03:49.382607Z","steps":["trace[338209150] 'process raft request' (duration: 55.037612ms)","trace[338209150] 'compare' (duration: 89.060312ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:04:04.117945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.20209ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:04:04.118039Z","caller":"traceutil/trace.go:171","msg":"trace[794149549] linearizableReadLoop","detail":"{readStateIndex:5690; appliedIndex:5689; }","duration":"317.286202ms","start":"2026-08-14T09:04:03.80074Z","end":"2026-08-14T09:04:04.118026Z","steps":["trace[794149549] 'read index received' (duration: 57.827546ms)","trace[794149549] 'applied index is now lower than readState.Index' (duration: 259.457585ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:04:04.118207Z","caller":"traceutil/trace.go:171","msg":"trace[1148655423] transaction","detail":"{read_only:false; response_revision:5487; number_of_response:1; }","duration":"410.711578ms","start":"2026-08-14T09:04:03.707451Z","end":"2026-08-14T09:04:04.118163Z","steps":["trace[1148655423] 'process raft request' (duration: 151.180782ms)","trace[1148655423] 'compare' (duration: 259.029817ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:04:04.118392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:03.707424Z","time spent":"410.867913ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:04:04.119014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.289491ms","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-14T09:04:04.119057Z","caller":"traceutil/trace.go:171","msg":"trace[1661900031] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5487; }","duration":"318.381874ms","start":"2026-08-14T09:04:03.800665Z","end":"2026-08-14T09:04:04.119047Z","steps":["trace[1661900031] 'agreement among raft nodes before linearized reading' (duration: 318.236451ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:04.119091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:03.800616Z","time spent":"318.463635ms","remote":"127.0.0.1:41446","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-14T09:04:04.119126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.889974ms","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-14T09:04:04.119168Z","caller":"traceutil/trace.go:171","msg":"trace[1938905351] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5487; }","duration":"267.967907ms","start":"2026-08-14T09:04:03.851191Z","end":"2026-08-14T09:04:04.119159Z","steps":["trace[1938905351] 'agreement among raft nodes before linearized reading' (duration: 267.802823ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:04.119327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.22982ms","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-14T09:04:04.119355Z","caller":"traceutil/trace.go:171","msg":"trace[365683423] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5487; }","duration":"267.280582ms","start":"2026-08-14T09:04:03.852068Z","end":"2026-08-14T09:04:04.119349Z","steps":["trace[365683423] 'agreement among raft nodes before linearized reading' (duration: 267.203491ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:04.119665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.790843ms","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-14T09:04:04.119772Z","caller":"traceutil/trace.go:171","msg":"trace[306162625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5487; }","duration":"266.981306ms","start":"2026-08-14T09:04:03.852766Z","end":"2026-08-14T09:04:04.119748Z","steps":["trace[306162625] 'agreement among raft nodes before linearized reading' (duration: 266.456855ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:04:04.396256Z","caller":"traceutil/trace.go:171","msg":"trace[1897102806] transaction","detail":"{read_only:false; response_revision:5488; number_of_response:1; }","duration":"272.085698ms","start":"2026-08-14T09:04:04.124147Z","end":"2026-08-14T09:04:04.396232Z","steps":["trace[1897102806] 'process raft request' (duration: 220.431356ms)","trace[1897102806] 'compare' (duration: 51.337796ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:04:04.396583Z","caller":"traceutil/trace.go:171","msg":"trace[1920396078] transaction","detail":"{read_only:false; response_revision:5489; number_of_response:1; }","duration":"272.420925ms","start":"2026-08-14T09:04:04.12414Z","end":"2026-08-14T09:04:04.396561Z","steps":["trace[1920396078] 'process raft request' (duration: 272.052747ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:04:04.561125Z","caller":"traceutil/trace.go:171","msg":"trace[938278203] transaction","detail":"{read_only:false; response_revision:5490; number_of_response:1; }","duration":"436.853631ms","start":"2026-08-14T09:04:04.124243Z","end":"2026-08-14T09:04:04.561096Z","steps":["trace[938278203] 'process raft request' (duration: 389.172039ms)","trace[938278203] 'compare' (duration: 47.450997ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:04:04.561384Z","caller":"traceutil/trace.go:171","msg":"trace[1734444847] linearizableReadLoop","detail":"{readStateIndex:5694; appliedIndex:5690; }","duration":"376.131788ms","start":"2026-08-14T09:04:04.185243Z","end":"2026-08-14T09:04:04.561375Z","steps":["trace[1734444847] 'read index received' (duration: 159.351795ms)","trace[1734444847] 'applied index is now lower than readState.Index' (duration: 216.779213ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:04:04.561537Z","caller":"traceutil/trace.go:171","msg":"trace[1000334846] transaction","detail":"{read_only:false; response_revision:5492; number_of_response:1; }","duration":"225.954266ms","start":"2026-08-14T09:04:04.335529Z","end":"2026-08-14T09:04:04.561484Z","steps":["trace[1000334846] 'process raft request' (duration: 225.525637ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:04.561641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.397662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.35\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-14T09:04:04.561718Z","caller":"traceutil/trace.go:171","msg":"trace[1792632340] range","detail":"{range_begin:/registry/masterleases/199.204.45.35; range_end:; response_count:1; response_revision:5492; }","duration":"376.521355ms","start":"2026-08-14T09:04:04.185179Z","end":"2026-08-14T09:04:04.5617Z","steps":["trace[1792632340] 'agreement among raft nodes before linearized reading' (duration: 376.316111ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:04.56177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:04.185157Z","time spent":"376.601637ms","remote":"127.0.0.1:41186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.35\" "} {"level":"info","ts":"2026-08-14T09:04:04.561321Z","caller":"traceutil/trace.go:171","msg":"trace[1127697659] transaction","detail":"{read_only:false; response_revision:5491; number_of_response:1; }","duration":"436.922432ms","start":"2026-08-14T09:04:04.124378Z","end":"2026-08-14T09:04:04.561301Z","steps":["trace[1127697659] 'process raft request' (duration: 436.636417ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:04.561874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:04.124359Z","time spent":"437.477364ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:04:04.561892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:04.124215Z","time spent":"437.177517ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:04:04.660305Z","caller":"traceutil/trace.go:171","msg":"trace[268021142] transaction","detail":"{read_only:false; response_revision:5493; number_of_response:1; }","duration":"269.547567ms","start":"2026-08-14T09:04:04.390721Z","end":"2026-08-14T09:04:04.660268Z","steps":["trace[268021142] 'process raft request' (duration: 269.292393ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:04.660627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.618419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-14T09:04:04.66072Z","caller":"traceutil/trace.go:171","msg":"trace[248689904] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:5493; }","duration":"282.761761ms","start":"2026-08-14T09:04:04.377934Z","end":"2026-08-14T09:04:04.660696Z","steps":["trace[248689904] 'agreement among raft nodes before linearized reading' (duration: 282.521626ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:04.860493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.449966ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-08-14T09:04:04.860595Z","caller":"traceutil/trace.go:171","msg":"trace[878982517] linearizableReadLoop","detail":"{readStateIndex:5697; appliedIndex:5696; }","duration":"200.413966ms","start":"2026-08-14T09:04:04.660162Z","end":"2026-08-14T09:04:04.860576Z","steps":["trace[878982517] 'read index received' (duration: 58.934938ms)","trace[878982517] 'applied index is now lower than readState.Index' (duration: 141.477348ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:04:04.860881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.721512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:04:04.860973Z","caller":"traceutil/trace.go:171","msg":"trace[263442853] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5493; }","duration":"256.856934ms","start":"2026-08-14T09:04:04.604097Z","end":"2026-08-14T09:04:04.860954Z","steps":["trace[263442853] 'agreement among raft nodes before linearized reading' (duration: 256.7104ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:05.269716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.205999ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:04:05.269957Z","caller":"traceutil/trace.go:171","msg":"trace[1144610564] transaction","detail":"{read_only:false; response_revision:5494; number_of_response:1; }","duration":"445.417902ms","start":"2026-08-14T09:04:04.824465Z","end":"2026-08-14T09:04:05.269883Z","steps":["trace[1144610564] 'process raft request' (duration: 152.951127ms)","trace[1144610564] 'compare' (duration: 292.048327ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:04:05.270199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:04.824448Z","time spent":"445.629466ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:04:05.270488Z","caller":"traceutil/trace.go:171","msg":"trace[1785733007] linearizableReadLoop","detail":"{readStateIndex:5698; appliedIndex:5697; }","duration":"409.8452ms","start":"2026-08-14T09:04:04.860621Z","end":"2026-08-14T09:04:05.270466Z","steps":["trace[1785733007] 'read index received' (duration: 116.892286ms)","trace[1785733007] 'applied index is now lower than readState.Index' (duration: 292.901604ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:04:05.270583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.400671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:04:05.270604Z","caller":"traceutil/trace.go:171","msg":"trace[1569757113] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5494; }","duration":"447.462163ms","start":"2026-08-14T09:04:04.823134Z","end":"2026-08-14T09:04:05.270596Z","steps":["trace[1569757113] 'agreement among raft nodes before linearized reading' (duration: 447.412462ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:05.270634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:04.823113Z","time spent":"447.517054ms","remote":"127.0.0.1:41418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" "} {"level":"warn","ts":"2026-08-14T09:04:05.27081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.661677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:04:05.271011Z","caller":"traceutil/trace.go:171","msg":"trace[126302147] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5494; }","duration":"447.887641ms","start":"2026-08-14T09:04:04.823063Z","end":"2026-08-14T09:04:05.270951Z","steps":["trace[126302147] 'agreement among raft nodes before linearized reading' (duration: 447.598075ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:05.271229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:04.823045Z","time spent":"448.141796ms","remote":"127.0.0.1:41418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/keystone-db-sync\" "} {"level":"info","ts":"2026-08-14T09:04:05.271083Z","caller":"traceutil/trace.go:171","msg":"trace[671371033] transaction","detail":"{read_only:false; response_revision:5495; number_of_response:1; }","duration":"409.436883ms","start":"2026-08-14T09:04:04.861637Z","end":"2026-08-14T09:04:05.271074Z","steps":["trace[671371033] 'process raft request' (duration: 409.219478ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:05.271551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:04.861622Z","time spent":"409.765899ms","remote":"127.0.0.1:41186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:04:06.707286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.203238575s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:04:06.707404Z","caller":"traceutil/trace.go:171","msg":"trace[2016555121] transaction","detail":"{read_only:false; response_revision:5496; number_of_response:1; }","duration":"1.441774742s","start":"2026-08-14T09:04:05.265605Z","end":"2026-08-14T09:04:06.70738Z","steps":["trace[2016555121] 'process raft request' (duration: 238.372503ms)","trace[2016555121] 'compare' (duration: 1.202684534s)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:04:06.707452Z","caller":"traceutil/trace.go:171","msg":"trace[148992383] transaction","detail":"{read_only:false; response_revision:5498; number_of_response:1; }","duration":"1.243447769s","start":"2026-08-14T09:04:05.463991Z","end":"2026-08-14T09:04:06.707439Z","steps":["trace[148992383] 'process raft request' (duration: 1.243416508s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:06.707507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:05.46396Z","time spent":"1.243525731s","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:04:06.707645Z","caller":"traceutil/trace.go:171","msg":"trace[1503956368] linearizableReadLoop","detail":"{readStateIndex:5700; appliedIndex:5699; }","duration":"1.437115619s","start":"2026-08-14T09:04:05.270523Z","end":"2026-08-14T09:04:06.707638Z","steps":["trace[1503956368] 'read index received' (duration: 233.616439ms)","trace[1503956368] 'applied index is now lower than readState.Index' (duration: 1.20349844s)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:04:06.707783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.845856467s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:04:06.707812Z","caller":"traceutil/trace.go:171","msg":"trace[1799936112] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5498; }","duration":"1.84592023s","start":"2026-08-14T09:04:04.861886Z","end":"2026-08-14T09:04:06.707807Z","steps":["trace[1799936112] 'agreement among raft nodes before linearized reading' (duration: 1.845863728s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:06.707826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:04.861872Z","time spent":"1.84595187s","remote":"127.0.0.1:41150","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-14T09:04:06.707512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:05.26556Z","time spent":"1.441893944s","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:04:06.707599Z","caller":"traceutil/trace.go:171","msg":"trace[1882591825] transaction","detail":"{read_only:false; response_revision:5497; number_of_response:1; }","duration":"1.252113692s","start":"2026-08-14T09:04:05.455479Z","end":"2026-08-14T09:04:06.707593Z","steps":["trace[1882591825] 'process raft request' (duration: 1.251885578s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:06.708677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:05.455438Z","time spent":"1.253144502s","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-14T09:04:06.858584Z","caller":"traceutil/trace.go:171","msg":"trace[45533607] transaction","detail":"{read_only:false; response_revision:5499; number_of_response:1; }","duration":"733.893517ms","start":"2026-08-14T09:04:06.124662Z","end":"2026-08-14T09:04:06.858556Z","steps":["trace[45533607] 'process raft request' (duration: 712.851155ms)","trace[45533607] 'compare' (duration: 20.798966ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:04:06.858705Z","caller":"traceutil/trace.go:171","msg":"trace[1669974667] linearizableReadLoop","detail":"{readStateIndex:5704; appliedIndex:5702; }","duration":"151.011099ms","start":"2026-08-14T09:04:06.70767Z","end":"2026-08-14T09:04:06.858681Z","steps":["trace[1669974667] 'read index received' (duration: 129.858806ms)","trace[1669974667] 'applied index is now lower than readState.Index' (duration: 21.151013ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:04:06.85878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.951253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:04:06.858817Z","caller":"traceutil/trace.go:171","msg":"trace[1829464697] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:5500; }","duration":"326.001674ms","start":"2026-08-14T09:04:06.532805Z","end":"2026-08-14T09:04:06.858807Z","steps":["trace[1829464697] 'agreement among raft nodes before linearized reading' (duration: 325.916423ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:06.858841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:06.532717Z","time spent":"326.118387ms","remote":"127.0.0.1:45138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-08-14T09:04:06.858885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.067423ms","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-14T09:04:06.858909Z","caller":"traceutil/trace.go:171","msg":"trace[209724665] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5500; }","duration":"459.125465ms","start":"2026-08-14T09:04:06.399778Z","end":"2026-08-14T09:04:06.858903Z","steps":["trace[209724665] 'agreement among raft nodes before linearized reading' (duration: 459.018133ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:06.858929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:06.399758Z","time spent":"459.166287ms","remote":"127.0.0.1:41446","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":"info","ts":"2026-08-14T09:04:06.858957Z","caller":"traceutil/trace.go:171","msg":"trace[421014530] transaction","detail":"{read_only:false; response_revision:5500; number_of_response:1; }","duration":"721.748973ms","start":"2026-08-14T09:04:06.137202Z","end":"2026-08-14T09:04:06.858951Z","steps":["trace[421014530] 'process raft request' (duration: 721.308624ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:06.859013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:06.137178Z","time spent":"721.796574ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:04:06.859059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.274297ms","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-14T09:04:06.859077Z","caller":"traceutil/trace.go:171","msg":"trace[1706769153] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5500; }","duration":"459.322069ms","start":"2026-08-14T09:04:06.399749Z","end":"2026-08-14T09:04:06.859071Z","steps":["trace[1706769153] 'agreement among raft nodes before linearized reading' (duration: 459.232157ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:06.859101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.826451ms","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-14T09:04:06.859114Z","caller":"traceutil/trace.go:171","msg":"trace[1630086697] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5500; }","duration":"291.866833ms","start":"2026-08-14T09:04:06.567243Z","end":"2026-08-14T09:04:06.85911Z","steps":["trace[1630086697] 'agreement among raft nodes before linearized reading' (duration: 291.824821ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:06.859155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.880126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"warn","ts":"2026-08-14T09:04:06.859177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.336651ms","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-14T09:04:06.859181Z","caller":"traceutil/trace.go:171","msg":"trace[1406423340] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5500; }","duration":"649.904946ms","start":"2026-08-14T09:04:06.209269Z","end":"2026-08-14T09:04:06.859174Z","steps":["trace[1406423340] 'agreement among raft nodes before linearized reading' (duration: 649.840896ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:04:06.859188Z","caller":"traceutil/trace.go:171","msg":"trace[467992974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5500; }","duration":"292.389522ms","start":"2026-08-14T09:04:06.566795Z","end":"2026-08-14T09:04:06.859185Z","steps":["trace[467992974] 'agreement among raft nodes before linearized reading' (duration: 292.356572ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:06.859198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:06.209245Z","time spent":"649.949228ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-08-14T09:04:06.859099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:06.399729Z","time spent":"459.36643ms","remote":"127.0.0.1:41446","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-14T09:04:06.859309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:06.124642Z","time spent":"734.08687ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-14T09:04:06.859375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.66943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:04:06.859402Z","caller":"traceutil/trace.go:171","msg":"trace[2116207767] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5500; }","duration":"144.720983ms","start":"2026-08-14T09:04:06.714674Z","end":"2026-08-14T09:04:06.859395Z","steps":["trace[2116207767] 'agreement among raft nodes before linearized reading' (duration: 144.682872ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:06.859518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.585527015s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"warn","ts":"2026-08-14T09:04:06.859353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.127021742s","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-14T09:04:06.859538Z","caller":"traceutil/trace.go:171","msg":"trace[405467789] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:5500; }","duration":"1.585581546s","start":"2026-08-14T09:04:05.273952Z","end":"2026-08-14T09:04:06.859534Z","steps":["trace[405467789] 'agreement among raft nodes before linearized reading' (duration: 1.585540905s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:06.859552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:05.273932Z","time spent":"1.585616158s","remote":"127.0.0.1:41336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-08-14T09:04:06.859546Z","caller":"traceutil/trace.go:171","msg":"trace[1500544734] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5500; }","duration":"1.127251697s","start":"2026-08-14T09:04:05.732287Z","end":"2026-08-14T09:04:06.859539Z","steps":["trace[1500544734] 'agreement among raft nodes before linearized reading' (duration: 1.127023533s)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:04:06.859576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:04:05.732267Z","time spent":"1.127301628s","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-14T09:04:10.539641Z","caller":"traceutil/trace.go:171","msg":"trace[1394423220] transaction","detail":"{read_only:false; response_revision:5520; number_of_response:1; }","duration":"158.790392ms","start":"2026-08-14T09:04:10.380812Z","end":"2026-08-14T09:04:10.539602Z","steps":["trace[1394423220] 'process raft request' (duration: 84.076799ms)","trace[1394423220] 'compare' (duration: 74.491999ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:04:11.25052Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2914} {"level":"info","ts":"2026-08-14T09:04:11.352408Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2914,"took":"100.903316ms","hash":2337521691,"current-db-size-bytes":53485568,"current-db-size":"54 MB","current-db-size-in-use-bytes":28979200,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-14T09:04:11.352451Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2337521691,"revision":2914,"compact-revision":-1} {"level":"info","ts":"2026-08-14T09:06:53.448803Z","caller":"traceutil/trace.go:171","msg":"trace[1691950470] linearizableReadLoop","detail":"{readStateIndex:6891; appliedIndex:6888; }","duration":"103.813479ms","start":"2026-08-14T09:06:53.344964Z","end":"2026-08-14T09:06:53.448778Z","steps":["trace[1691950470] 'read index received' (duration: 44.443072ms)","trace[1691950470] 'applied index is now lower than readState.Index' (duration: 59.369457ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:06:53.448973Z","caller":"traceutil/trace.go:171","msg":"trace[950349374] transaction","detail":"{read_only:false; response_revision:6647; number_of_response:1; }","duration":"111.533022ms","start":"2026-08-14T09:06:53.337411Z","end":"2026-08-14T09:06:53.448944Z","steps":["trace[950349374] 'process raft request' (duration: 109.689846ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:06:53.449114Z","caller":"traceutil/trace.go:171","msg":"trace[2026799402] transaction","detail":"{read_only:false; response_revision:6648; number_of_response:1; }","duration":"110.91413ms","start":"2026-08-14T09:06:53.338187Z","end":"2026-08-14T09:06:53.449101Z","steps":["trace[2026799402] 'process raft request' (duration: 110.546703ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:06:53.449119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.134016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"info","ts":"2026-08-14T09:06:53.449205Z","caller":"traceutil/trace.go:171","msg":"trace[894211381] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6648; }","duration":"104.270718ms","start":"2026-08-14T09:06:53.344913Z","end":"2026-08-14T09:06:53.449184Z","steps":["trace[894211381] 'agreement among raft nodes before linearized reading' (duration: 104.024903ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:06:56.665132Z","caller":"traceutil/trace.go:171","msg":"trace[201520144] transaction","detail":"{read_only:false; response_revision:6670; number_of_response:1; }","duration":"140.69322ms","start":"2026-08-14T09:06:56.524416Z","end":"2026-08-14T09:06:56.665109Z","steps":["trace[201520144] 'process raft request' (duration: 140.540417ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:09:11.284208Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5543} {"level":"info","ts":"2026-08-14T09:09:11.678523Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5543,"took":"392.50912ms","hash":3044534193,"current-db-size-bytes":53485568,"current-db-size":"54 MB","current-db-size-in-use-bytes":18604032,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-08-14T09:09:11.678609Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3044534193,"revision":5543,"compact-revision":2914} {"level":"warn","ts":"2026-08-14T09:09:41.732752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.387091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:09:41.732846Z","caller":"traceutil/trace.go:171","msg":"trace[21986660] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7587; }","duration":"128.544694ms","start":"2026-08-14T09:09:41.604282Z","end":"2026-08-14T09:09:41.732826Z","steps":["trace[21986660] 'range keys from in-memory index tree' (duration: 128.299429ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:09:41.733126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.318522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:775"} {"level":"info","ts":"2026-08-14T09:09:41.733152Z","caller":"traceutil/trace.go:171","msg":"trace[1592476364] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:7587; }","duration":"314.375252ms","start":"2026-08-14T09:09:41.418769Z","end":"2026-08-14T09:09:41.733144Z","steps":["trace[1592476364] 'range keys from in-memory index tree' (duration: 314.23755ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:09:41.733167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:09:41.418754Z","time spent":"314.409592ms","remote":"127.0.0.1:41534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":798,"request content":"key:\"/registry/clusterrolebindings/system:controller:horizontal-pod-autoscaler\" "} {"level":"warn","ts":"2026-08-14T09:09:41.733212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.805155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:persistent-volume-binder\" ","response":"range_response_count:1 size:1078"} {"level":"info","ts":"2026-08-14T09:09:41.733307Z","caller":"traceutil/trace.go:171","msg":"trace[686880108] range","detail":"{range_begin:/registry/clusterroles/system:controller:persistent-volume-binder; range_end:; response_count:1; response_revision:7587; }","duration":"333.940019ms","start":"2026-08-14T09:09:41.399346Z","end":"2026-08-14T09:09:41.733286Z","steps":["trace[686880108] 'range keys from in-memory index tree' (duration: 333.717515ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:09:41.733377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:09:41.39933Z","time spent":"334.035251ms","remote":"127.0.0.1:41532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":1101,"request content":"key:\"/registry/clusterroles/system:controller:persistent-volume-binder\" "} {"level":"info","ts":"2026-08-14T09:09:53.251024Z","caller":"traceutil/trace.go:171","msg":"trace[635725007] transaction","detail":"{read_only:false; response_revision:7645; number_of_response:1; }","duration":"102.853046ms","start":"2026-08-14T09:09:53.148144Z","end":"2026-08-14T09:09:53.250997Z","steps":["trace[635725007] 'process raft request' (duration: 102.162221ms)"],"step_count":1} {"level":"info","ts":"2026-08-14T09:10:21.580521Z","caller":"traceutil/trace.go:171","msg":"trace[1711640039] transaction","detail":"{read_only:false; response_revision:7789; number_of_response:1; }","duration":"146.258404ms","start":"2026-08-14T09:10:21.434238Z","end":"2026-08-14T09:10:21.580496Z","steps":["trace[1711640039] 'process raft request' (duration: 98.48808ms)","trace[1711640039] 'compare' (duration: 47.420627ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:10:21.994579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.701025ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-14T09:10:21.994706Z","caller":"traceutil/trace.go:171","msg":"trace[1172712149] linearizableReadLoop","detail":"{readStateIndex:8080; appliedIndex:8079; }","duration":"410.487302ms","start":"2026-08-14T09:10:21.584197Z","end":"2026-08-14T09:10:21.994685Z","steps":["trace[1172712149] 'read index received' (duration: 225.535053ms)","trace[1172712149] 'applied index is now lower than readState.Index' (duration: 184.950439ms)"],"step_count":2} {"level":"info","ts":"2026-08-14T09:10:21.99507Z","caller":"traceutil/trace.go:171","msg":"trace[650274251] transaction","detail":"{read_only:false; response_revision:7790; number_of_response:1; }","duration":"411.042974ms","start":"2026-08-14T09:10:21.58399Z","end":"2026-08-14T09:10:21.995033Z","steps":["trace[650274251] 'process raft request' (duration: 225.792817ms)","trace[650274251] 'compare' (duration: 184.549472ms)"],"step_count":2} {"level":"warn","ts":"2026-08-14T09:10:21.995191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.973322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/horizon-int\" ","response":"range_response_count:1 size:891"} {"level":"warn","ts":"2026-08-14T09:10:21.99525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:10:21.583972Z","time spent":"411.169456ms","remote":"127.0.0.1:41446","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-14T09:10:21.995277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.609468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-14T09:10:21.995276Z","caller":"traceutil/trace.go:171","msg":"trace[1450187223] range","detail":"{range_begin:/registry/services/endpoints/openstack/horizon-int; range_end:; response_count:1; response_revision:7790; }","duration":"411.093385ms","start":"2026-08-14T09:10:21.584162Z","end":"2026-08-14T09:10:21.995256Z","steps":["trace[1450187223] 'agreement among raft nodes before linearized reading' (duration: 410.868371ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:10:21.995413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:10:21.584144Z","time spent":"411.258948ms","remote":"127.0.0.1:41336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":914,"request content":"key:\"/registry/services/endpoints/openstack/horizon-int\" "} {"level":"info","ts":"2026-08-14T09:10:21.995399Z","caller":"traceutil/trace.go:171","msg":"trace[818499058] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7790; }","duration":"393.757822ms","start":"2026-08-14T09:10:21.601616Z","end":"2026-08-14T09:10:21.995374Z","steps":["trace[818499058] 'agreement among raft nodes before linearized reading' (duration: 393.577718ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:10:21.995503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.813706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/keystone-api\" ","response":"range_response_count:1 size:675"} {"level":"info","ts":"2026-08-14T09:10:21.99561Z","caller":"traceutil/trace.go:171","msg":"trace[2006060534] range","detail":"{range_begin:/registry/services/endpoints/openstack/keystone-api; range_end:; response_count:1; response_revision:7790; }","duration":"332.949908ms","start":"2026-08-14T09:10:21.662643Z","end":"2026-08-14T09:10:21.995593Z","steps":["trace[2006060534] 'agreement among raft nodes before linearized reading' (duration: 332.668172ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:10:21.995509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:10:21.601563Z","time spent":"393.928684ms","remote":"127.0.0.1:41136","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-14T09:10:21.995658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-14T09:10:21.662623Z","time spent":"333.022349ms","remote":"127.0.0.1:41336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":698,"request content":"key:\"/registry/services/endpoints/openstack/keystone-api\" "} {"level":"info","ts":"2026-08-14T09:10:22.425771Z","caller":"traceutil/trace.go:171","msg":"trace[1771363378] transaction","detail":"{read_only:false; response_revision:7792; number_of_response:1; }","duration":"107.10466ms","start":"2026-08-14T09:10:22.318633Z","end":"2026-08-14T09:10:22.425737Z","steps":["trace[1771363378] 'process raft request' (duration: 106.916346ms)"],"step_count":1} {"level":"warn","ts":"2026-08-14T09:10:35.580187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.306933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:713"} {"level":"info","ts":"2026-08-14T09:10:35.580273Z","caller":"traceutil/trace.go:171","msg":"trace[516796805] range","detail":"{range_begin:/registry/serviceaccounts/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:7859; }","duration":"110.438434ms","start":"2026-08-14T09:10:35.469815Z","end":"2026-08-14T09:10:35.580253Z","steps":["trace[516796805] 'range keys from in-memory index tree' (duration: 109.875084ms)"],"step_count":1}