{"level":"warn","ts":"2026-08-24T19:34:05.609059Z","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-24T19:34:05.609175Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.61:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.61:2380","--initial-cluster=instance=https://199.19.213.61:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.61:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.61: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-24T19:34:05.610733Z","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-24T19:34:05.61104Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.61:2380"]} {"level":"info","ts":"2026-08-24T19:34:05.611088Z","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-24T19:34:05.611849Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.61:2379"]} {"level":"info","ts":"2026-08-24T19:34:05.611925Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.61:2380"],"listen-peer-urls":["https://199.19.213.61:2380"],"advertise-client-urls":["https://199.19.213.61:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.61:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.61: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-24T19:34:05.617292Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.957268ms"} {"level":"info","ts":"2026-08-24T19:34:05.623424Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d1484a2210d3c2b8","cluster-id":"27fc2dec3fac595c"} {"level":"info","ts":"2026-08-24T19:34:05.623511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 switched to configuration voters=()"} {"level":"info","ts":"2026-08-24T19:34:05.623547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 became follower at term 0"} {"level":"info","ts":"2026-08-24T19:34:05.623558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d1484a2210d3c2b8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-24T19:34:05.623571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 became follower at term 1"} {"level":"info","ts":"2026-08-24T19:34:05.623605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 switched to configuration voters=(15080384862421762744)"} {"level":"warn","ts":"2026-08-24T19:34:05.632509Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-24T19:34:05.63404Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-24T19:34:05.635081Z","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-24T19:34:05.637153Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d1484a2210d3c2b8","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-24T19:34:05.637317Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d1484a2210d3c2b8","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-24T19:34:05.63747Z","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-24T19:34:05.637531Z","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-24T19:34:05.637542Z","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-24T19:34:05.639083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 switched to configuration voters=(15080384862421762744)"} {"level":"info","ts":"2026-08-24T19:34:05.639551Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"27fc2dec3fac595c","local-member-id":"d1484a2210d3c2b8","added-peer-id":"d1484a2210d3c2b8","added-peer-peer-urls":["https://199.19.213.61:2380"]} {"level":"info","ts":"2026-08-24T19:34:05.64101Z","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-24T19:34:05.64111Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.61:2380"} {"level":"info","ts":"2026-08-24T19:34:05.641158Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.61:2380"} {"level":"info","ts":"2026-08-24T19:34:05.641286Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d1484a2210d3c2b8","initial-advertise-peer-urls":["https://199.19.213.61:2380"],"listen-peer-urls":["https://199.19.213.61:2380"],"advertise-client-urls":["https://199.19.213.61:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.61:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-24T19:34:05.641333Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-24T19:34:05.824792Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 is starting a new election at term 1"} {"level":"info","ts":"2026-08-24T19:34:05.824904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-24T19:34:05.824938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 received MsgPreVoteResp from d1484a2210d3c2b8 at term 1"} {"level":"info","ts":"2026-08-24T19:34:05.824965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 became candidate at term 2"} {"level":"info","ts":"2026-08-24T19:34:05.824982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 received MsgVoteResp from d1484a2210d3c2b8 at term 2"} {"level":"info","ts":"2026-08-24T19:34:05.825081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1484a2210d3c2b8 became leader at term 2"} {"level":"info","ts":"2026-08-24T19:34:05.825137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d1484a2210d3c2b8 elected leader d1484a2210d3c2b8 at term 2"} {"level":"info","ts":"2026-08-24T19:34:05.826343Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T19:34:05.827193Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d1484a2210d3c2b8","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.61:2379]}","request-path":"/0/members/d1484a2210d3c2b8/attributes","cluster-id":"27fc2dec3fac595c","publish-timeout":"7s"} {"level":"info","ts":"2026-08-24T19:34:05.827416Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T19:34:05.827452Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T19:34:05.827898Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"27fc2dec3fac595c","local-member-id":"d1484a2210d3c2b8","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T19:34:05.828042Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T19:34:05.82801Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-24T19:34:05.828088Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T19:34:05.82814Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-24T19:34:05.831143Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-24T19:34:05.831752Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.61:2379"} {"level":"warn","ts":"2026-08-24T19:34:42.313343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.565942ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T19:34:42.313694Z","caller":"traceutil/trace.go:171","msg":"trace[611570145] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"210.092323ms","start":"2026-08-24T19:34:42.103588Z","end":"2026-08-24T19:34:42.31368Z","steps":["trace[611570145] 'process raft request' (duration: 209.899687ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:34:42.313666Z","caller":"traceutil/trace.go:171","msg":"trace[1901390768] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"214.319625ms","start":"2026-08-24T19:34:42.099314Z","end":"2026-08-24T19:34:42.313633Z","steps":["trace[1901390768] 'process raft request' (duration: 214.121309ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:34:42.313666Z","caller":"traceutil/trace.go:171","msg":"trace[924350007] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"214.915045ms","start":"2026-08-24T19:34:42.098722Z","end":"2026-08-24T19:34:42.313637Z","steps":["trace[924350007] 'process raft request' (duration: 109.63381ms)","trace[924350007] 'compare' (duration: 104.477779ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:34:42.352697Z","caller":"traceutil/trace.go:171","msg":"trace[1080828858] linearizableReadLoop","detail":"{readStateIndex:505; appliedIndex:504; }","duration":"106.732129ms","start":"2026-08-24T19:34:42.245947Z","end":"2026-08-24T19:34:42.352679Z","steps":["trace[1080828858] 'read index received' (duration: 106.417649ms)","trace[1080828858] 'applied index is now lower than readState.Index' (duration: 313.45µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:34:42.352777Z","caller":"traceutil/trace.go:171","msg":"trace[1623538436] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"223.44182ms","start":"2026-08-24T19:34:42.129328Z","end":"2026-08-24T19:34:42.352769Z","steps":["trace[1623538436] 'process raft request' (duration: 223.160452ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:42.352943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.981437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-08-24T19:34:42.353092Z","caller":"traceutil/trace.go:171","msg":"trace[1292270573] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:486; }","duration":"107.169553ms","start":"2026-08-24T19:34:42.245901Z","end":"2026-08-24T19:34:42.353071Z","steps":["trace[1292270573] 'agreement among raft nodes before linearized reading' (duration: 107.001367ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:42.353076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.479712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-08-24T19:34:42.353206Z","caller":"traceutil/trace.go:171","msg":"trace[782131715] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:486; }","duration":"106.641996ms","start":"2026-08-24T19:34:42.246536Z","end":"2026-08-24T19:34:42.353178Z","steps":["trace[782131715] 'agreement among raft nodes before linearized reading' (duration: 106.438459ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:34:44.017936Z","caller":"traceutil/trace.go:171","msg":"trace[1411922439] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:519; }","duration":"100.635228ms","start":"2026-08-24T19:34:43.91728Z","end":"2026-08-24T19:34:44.017915Z","steps":["trace[1411922439] 'read index received' (duration: 35.46412ms)","trace[1411922439] 'applied index is now lower than readState.Index' (duration: 65.169908ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T19:34:44.018162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.862094ms","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-24T19:34:44.018958Z","caller":"traceutil/trace.go:171","msg":"trace[865325484] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:513; }","duration":"101.678449ms","start":"2026-08-24T19:34:43.917255Z","end":"2026-08-24T19:34:44.018934Z","steps":["trace[865325484] 'agreement among raft nodes before linearized reading' (duration: 100.832103ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:34:44.018365Z","caller":"traceutil/trace.go:171","msg":"trace[109513050] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"118.125119ms","start":"2026-08-24T19:34:43.900176Z","end":"2026-08-24T19:34:44.018301Z","steps":["trace[109513050] 'process raft request' (duration: 117.464709ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:34:44.018435Z","caller":"traceutil/trace.go:171","msg":"trace[2015280000] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"106.955293ms","start":"2026-08-24T19:34:43.911459Z","end":"2026-08-24T19:34:44.018414Z","steps":["trace[2015280000] 'process raft request' (duration: 106.334875ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:34:44.018478Z","caller":"traceutil/trace.go:171","msg":"trace[62405738] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"110.480342ms","start":"2026-08-24T19:34:43.907989Z","end":"2026-08-24T19:34:44.018469Z","steps":["trace[62405738] 'process raft request' (duration: 109.702659ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:34:44.018504Z","caller":"traceutil/trace.go:171","msg":"trace[1654734883] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"107.18342ms","start":"2026-08-24T19:34:43.911313Z","end":"2026-08-24T19:34:44.018497Z","steps":["trace[1654734883] 'process raft request' (duration: 106.438917ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:34:44.018542Z","caller":"traceutil/trace.go:171","msg":"trace[427922005] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"105.195039ms","start":"2026-08-24T19:34:43.913337Z","end":"2026-08-24T19:34:44.018532Z","steps":["trace[427922005] 'process raft request' (duration: 104.486877ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:34:44.018576Z","caller":"traceutil/trace.go:171","msg":"trace[1152180899] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"121.130833ms","start":"2026-08-24T19:34:43.897438Z","end":"2026-08-24T19:34:44.018569Z","steps":["trace[1152180899] 'process raft request' (duration: 120.134402ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:34:44.018602Z","caller":"traceutil/trace.go:171","msg":"trace[229580407] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"126.86646ms","start":"2026-08-24T19:34:43.891729Z","end":"2026-08-24T19:34:44.018596Z","steps":["trace[229580407] 'process raft request' (duration: 125.756516ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:34:44.018627Z","caller":"traceutil/trace.go:171","msg":"trace[646766330] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"121.267757ms","start":"2026-08-24T19:34:43.897353Z","end":"2026-08-24T19:34:44.018621Z","steps":["trace[646766330] 'process raft request' (duration: 120.190664ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:34:44.240274Z","caller":"traceutil/trace.go:171","msg":"trace[1827092421] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"104.301723ms","start":"2026-08-24T19:34:44.135945Z","end":"2026-08-24T19:34:44.240247Z","steps":["trace[1827092421] 'process raft request' (duration: 75.33038ms)","trace[1827092421] 'compare' (duration: 28.749136ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:34:44.240548Z","caller":"traceutil/trace.go:171","msg":"trace[877792767] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"100.328452ms","start":"2026-08-24T19:34:44.140167Z","end":"2026-08-24T19:34:44.240495Z","steps":["trace[877792767] 'process raft request' (duration: 100.033153ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:34:44.41648Z","caller":"traceutil/trace.go:171","msg":"trace[159406906] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"126.829127ms","start":"2026-08-24T19:34:44.289611Z","end":"2026-08-24T19:34:44.41644Z","steps":["trace[159406906] 'process raft request' (duration: 111.912768ms)","trace[159406906] 'compare' (duration: 14.628531ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:34:45.29833Z","caller":"traceutil/trace.go:171","msg":"trace[756947297] linearizableReadLoop","detail":"{readStateIndex:586; appliedIndex:585; }","duration":"248.198722ms","start":"2026-08-24T19:34:45.050114Z","end":"2026-08-24T19:34:45.298313Z","steps":["trace[756947297] 'read index received' (duration: 244.789827ms)","trace[756947297] 'applied index is now lower than readState.Index' (duration: 3.408265ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:34:45.298413Z","caller":"traceutil/trace.go:171","msg":"trace[219302321] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"257.477926ms","start":"2026-08-24T19:34:45.040913Z","end":"2026-08-24T19:34:45.298391Z","steps":["trace[219302321] 'process raft request' (duration: 253.930907ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:45.298447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.316505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:34:45.298471Z","caller":"traceutil/trace.go:171","msg":"trace[779249159] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:564; }","duration":"248.370677ms","start":"2026-08-24T19:34:45.050093Z","end":"2026-08-24T19:34:45.298464Z","steps":["trace[779249159] 'agreement among raft nodes before linearized reading' (duration: 248.302866ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:45.30213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.984588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:34:45.302206Z","caller":"traceutil/trace.go:171","msg":"trace[462559738] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:565; }","duration":"252.097912ms","start":"2026-08-24T19:34:45.050092Z","end":"2026-08-24T19:34:45.30219Z","steps":["trace[462559738] 'agreement among raft nodes before linearized reading' (duration: 251.966538ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:34:45.302384Z","caller":"traceutil/trace.go:171","msg":"trace[829267673] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"181.750217ms","start":"2026-08-24T19:34:45.120623Z","end":"2026-08-24T19:34:45.302373Z","steps":["trace[829267673] 'process raft request' (duration: 180.326632ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:45.30309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.221341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:34:45.303133Z","caller":"traceutil/trace.go:171","msg":"trace[1970782599] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:565; }","duration":"101.275193ms","start":"2026-08-24T19:34:45.201846Z","end":"2026-08-24T19:34:45.303121Z","steps":["trace[1970782599] 'agreement among raft nodes before linearized reading' (duration: 101.21934ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:45.303271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.911311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:34:45.303316Z","caller":"traceutil/trace.go:171","msg":"trace[1889447270] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:565; }","duration":"101.980803ms","start":"2026-08-24T19:34:45.201327Z","end":"2026-08-24T19:34:45.303308Z","steps":["trace[1889447270] 'agreement among raft nodes before linearized reading' (duration: 101.919752ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:45.303459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.203171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:34:45.303499Z","caller":"traceutil/trace.go:171","msg":"trace[27220586] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:565; }","duration":"102.251121ms","start":"2026-08-24T19:34:45.201234Z","end":"2026-08-24T19:34:45.303485Z","steps":["trace[27220586] 'agreement among raft nodes before linearized reading' (duration: 102.180089ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:45.303649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.284656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:34:45.303683Z","caller":"traceutil/trace.go:171","msg":"trace[1354484949] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:565; }","duration":"123.321267ms","start":"2026-08-24T19:34:45.180353Z","end":"2026-08-24T19:34:45.303675Z","steps":["trace[1354484949] 'agreement among raft nodes before linearized reading' (duration: 123.269665ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:45.303849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.957367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:34:45.303912Z","caller":"traceutil/trace.go:171","msg":"trace[1221970154] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:565; }","duration":"124.055119ms","start":"2026-08-24T19:34:45.179847Z","end":"2026-08-24T19:34:45.303902Z","steps":["trace[1221970154] 'agreement among raft nodes before linearized reading' (duration: 123.973806ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:45.304048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.450631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:34:45.304082Z","caller":"traceutil/trace.go:171","msg":"trace[580623239] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:565; }","duration":"124.501623ms","start":"2026-08-24T19:34:45.179572Z","end":"2026-08-24T19:34:45.304073Z","steps":["trace[580623239] 'agreement among raft nodes before linearized reading' (duration: 124.451052ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:45.30419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.449624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:34:45.304223Z","caller":"traceutil/trace.go:171","msg":"trace[1510559742] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:565; }","duration":"144.483976ms","start":"2026-08-24T19:34:45.159731Z","end":"2026-08-24T19:34:45.304215Z","steps":["trace[1510559742] 'agreement among raft nodes before linearized reading' (duration: 144.438924ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:45.304352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.002271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:34:45.304384Z","caller":"traceutil/trace.go:171","msg":"trace[1459434625] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:565; }","duration":"145.045552ms","start":"2026-08-24T19:34:45.159331Z","end":"2026-08-24T19:34:45.304377Z","steps":["trace[1459434625] 'agreement among raft nodes before linearized reading' (duration: 145.001181ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:45.304588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.394552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:34:45.304638Z","caller":"traceutil/trace.go:171","msg":"trace[1290122902] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:565; }","duration":"145.477806ms","start":"2026-08-24T19:34:45.159148Z","end":"2026-08-24T19:34:45.304626Z","steps":["trace[1290122902] 'agreement among raft nodes before linearized reading' (duration: 145.400433ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:45.304773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.306156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:34:45.304808Z","caller":"traceutil/trace.go:171","msg":"trace[966983252] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:565; }","duration":"184.366726ms","start":"2026-08-24T19:34:45.120434Z","end":"2026-08-24T19:34:45.304801Z","steps":["trace[966983252] 'agreement among raft nodes before linearized reading' (duration: 184.317185ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:45.304913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.520831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:34:45.304945Z","caller":"traceutil/trace.go:171","msg":"trace[964892725] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:565; }","duration":"184.554321ms","start":"2026-08-24T19:34:45.120383Z","end":"2026-08-24T19:34:45.304937Z","steps":["trace[964892725] 'agreement among raft nodes before linearized reading' (duration: 184.51051ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:45.305062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.116801ms","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-24T19:34:45.305127Z","caller":"traceutil/trace.go:171","msg":"trace[1222256247] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:565; }","duration":"234.232484ms","start":"2026-08-24T19:34:45.070884Z","end":"2026-08-24T19:34:45.305116Z","steps":["trace[1222256247] 'agreement among raft nodes before linearized reading' (duration: 234.152701ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:45.305248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.297856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:34:45.305293Z","caller":"traceutil/trace.go:171","msg":"trace[1883298414] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:565; }","duration":"234.369879ms","start":"2026-08-24T19:34:45.070911Z","end":"2026-08-24T19:34:45.305281Z","steps":["trace[1883298414] 'agreement among raft nodes before linearized reading' (duration: 234.298586ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:45.305427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.649486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:34:45.30546Z","caller":"traceutil/trace.go:171","msg":"trace[1018286713] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:565; }","duration":"234.78066ms","start":"2026-08-24T19:34:45.07067Z","end":"2026-08-24T19:34:45.305451Z","steps":["trace[1018286713] 'agreement among raft nodes before linearized reading' (duration: 234.732799ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:45.30557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.423473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:34:45.305602Z","caller":"traceutil/trace.go:171","msg":"trace[741059299] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:565; }","duration":"255.461655ms","start":"2026-08-24T19:34:45.050132Z","end":"2026-08-24T19:34:45.305594Z","steps":["trace[741059299] 'agreement among raft nodes before linearized reading' (duration: 255.416913ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:34:51.323045Z","caller":"traceutil/trace.go:171","msg":"trace[266758813] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"236.712761ms","start":"2026-08-24T19:34:51.086296Z","end":"2026-08-24T19:34:51.323009Z","steps":["trace[266758813] 'process raft request' (duration: 233.383912ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:51.571104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.521493ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T19:34:51.571308Z","caller":"traceutil/trace.go:171","msg":"trace[989440300] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"436.442298ms","start":"2026-08-24T19:34:51.134786Z","end":"2026-08-24T19:34:51.571228Z","steps":["trace[989440300] 'process raft request' (duration: 334.727009ms)","trace[989440300] 'compare' (duration: 101.223744ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T19:34:51.571652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T19:34:51.134753Z","time spent":"436.761688ms","remote":"127.0.0.1:49734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036193,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T19:34:52.252449Z","caller":"traceutil/trace.go:171","msg":"trace[717811005] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"148.26667ms","start":"2026-08-24T19:34:52.104156Z","end":"2026-08-24T19:34:52.252423Z","steps":["trace[717811005] 'read index received' (duration: 146.23157ms)","trace[717811005] 'applied index is now lower than readState.Index' (duration: 2.0342ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:34:52.252524Z","caller":"traceutil/trace.go:171","msg":"trace[1985665669] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"186.059912ms","start":"2026-08-24T19:34:52.066427Z","end":"2026-08-24T19:34:52.252487Z","steps":["trace[1985665669] 'process raft request' (duration: 184.233859ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:34:52.252633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.456327ms","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-24T19:34:52.252668Z","caller":"traceutil/trace.go:171","msg":"trace[63070029] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:601; }","duration":"148.534678ms","start":"2026-08-24T19:34:52.104122Z","end":"2026-08-24T19:34:52.252657Z","steps":["trace[63070029] 'agreement among raft nodes before linearized reading' (duration: 148.396804ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:34:53.313312Z","caller":"traceutil/trace.go:171","msg":"trace[344146420] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"100.358845ms","start":"2026-08-24T19:34:53.212926Z","end":"2026-08-24T19:34:53.313285Z","steps":["trace[344146420] 'process raft request' (duration: 98.985735ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:35:08.313587Z","caller":"traceutil/trace.go:171","msg":"trace[914797382] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"133.480295ms","start":"2026-08-24T19:35:08.180088Z","end":"2026-08-24T19:35:08.313568Z","steps":["trace[914797382] 'process raft request' (duration: 133.366182ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:35:46.885678Z","caller":"traceutil/trace.go:171","msg":"trace[9162095] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"251.97662ms","start":"2026-08-24T19:35:46.633663Z","end":"2026-08-24T19:35:46.885639Z","steps":["trace[9162095] 'process raft request' (duration: 251.848977ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:36:03.623721Z","caller":"traceutil/trace.go:171","msg":"trace[1950555952] linearizableReadLoop","detail":"{readStateIndex:1387; appliedIndex:1385; }","duration":"122.209784ms","start":"2026-08-24T19:36:03.501463Z","end":"2026-08-24T19:36:03.623672Z","steps":["trace[1950555952] 'read index received' (duration: 25.687685ms)","trace[1950555952] 'applied index is now lower than readState.Index' (duration: 96.520779ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:36:03.623871Z","caller":"traceutil/trace.go:171","msg":"trace[2082087854] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"129.892415ms","start":"2026-08-24T19:36:03.493926Z","end":"2026-08-24T19:36:03.623818Z","steps":["trace[2082087854] 'process raft request' (duration: 129.62824ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:36:03.623956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.466619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:36:03.624201Z","caller":"traceutil/trace.go:171","msg":"trace[353674540] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1341; }","duration":"122.773396ms","start":"2026-08-24T19:36:03.501408Z","end":"2026-08-24T19:36:03.624182Z","steps":["trace[353674540] 'agreement among raft nodes before linearized reading' (duration: 122.474259ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:36:09.3812Z","caller":"traceutil/trace.go:171","msg":"trace[357742243] linearizableReadLoop","detail":"{readStateIndex:1503; appliedIndex:1502; }","duration":"132.386561ms","start":"2026-08-24T19:36:09.248784Z","end":"2026-08-24T19:36:09.38117Z","steps":["trace[357742243] 'read index received' (duration: 55.655608ms)","trace[357742243] 'applied index is now lower than readState.Index' (duration: 76.729713ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:36:09.3813Z","caller":"traceutil/trace.go:171","msg":"trace[1453027921] transaction","detail":"{read_only:false; response_revision:1454; number_of_response:1; }","duration":"133.424803ms","start":"2026-08-24T19:36:09.247831Z","end":"2026-08-24T19:36:09.381255Z","steps":["trace[1453027921] 'process raft request' (duration: 56.722292ms)","trace[1453027921] 'compare' (duration: 76.340884ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T19:36:09.381585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.770279ms","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-24T19:36:09.381678Z","caller":"traceutil/trace.go:171","msg":"trace[1662922721] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1454; }","duration":"132.916372ms","start":"2026-08-24T19:36:09.24874Z","end":"2026-08-24T19:36:09.381656Z","steps":["trace[1662922721] 'agreement among raft nodes before linearized reading' (duration: 132.584414ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:36:10.731954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.49338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:36:10.732065Z","caller":"traceutil/trace.go:171","msg":"trace[29417965] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1462; }","duration":"193.683082ms","start":"2026-08-24T19:36:10.538354Z","end":"2026-08-24T19:36:10.732037Z","steps":["trace[29417965] 'count revisions from in-memory index tree' (duration: 193.320355ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:36:35.812922Z","caller":"traceutil/trace.go:171","msg":"trace[1309937898] linearizableReadLoop","detail":"{readStateIndex:1904; appliedIndex:1902; }","duration":"118.166534ms","start":"2026-08-24T19:36:35.694678Z","end":"2026-08-24T19:36:35.812845Z","steps":["trace[1309937898] 'read index received' (duration: 29.231435ms)","trace[1309937898] 'applied index is now lower than readState.Index' (duration: 88.934019ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:36:35.813127Z","caller":"traceutil/trace.go:171","msg":"trace[467801877] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"124.109118ms","start":"2026-08-24T19:36:35.688956Z","end":"2026-08-24T19:36:35.813065Z","steps":["trace[467801877] 'process raft request' (duration: 123.765111ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:36:35.813216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.520112ms","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-24T19:36:35.813262Z","caller":"traceutil/trace.go:171","msg":"trace[1510178467] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1828; }","duration":"118.603792ms","start":"2026-08-24T19:36:35.694648Z","end":"2026-08-24T19:36:35.813251Z","steps":["trace[1510178467] 'agreement among raft nodes before linearized reading' (duration: 118.353987ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:36:35.886958Z","caller":"traceutil/trace.go:171","msg":"trace[211955102] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"129.002051ms","start":"2026-08-24T19:36:35.757929Z","end":"2026-08-24T19:36:35.886931Z","steps":["trace[211955102] 'process raft request' (duration: 128.935971ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:36:35.887003Z","caller":"traceutil/trace.go:171","msg":"trace[2089221998] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"154.507927ms","start":"2026-08-24T19:36:35.73246Z","end":"2026-08-24T19:36:35.886968Z","steps":["trace[2089221998] 'process raft request' (duration: 154.22014ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:36:35.930219Z","caller":"traceutil/trace.go:171","msg":"trace[805082138] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"112.335681ms","start":"2026-08-24T19:36:35.817864Z","end":"2026-08-24T19:36:35.9302Z","steps":["trace[805082138] 'process raft request' (duration: 112.186828ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:36:35.930556Z","caller":"traceutil/trace.go:171","msg":"trace[860764633] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"112.561425ms","start":"2026-08-24T19:36:35.817951Z","end":"2026-08-24T19:36:35.930513Z","steps":["trace[860764633] 'process raft request' (duration: 112.202038ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:36:35.930679Z","caller":"traceutil/trace.go:171","msg":"trace[1480116104] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"108.119122ms","start":"2026-08-24T19:36:35.822548Z","end":"2026-08-24T19:36:35.930667Z","steps":["trace[1480116104] 'process raft request' (duration: 107.916238ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:36:35.930863Z","caller":"traceutil/trace.go:171","msg":"trace[2092712234] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"112.210968ms","start":"2026-08-24T19:36:35.818558Z","end":"2026-08-24T19:36:35.930769Z","steps":["trace[2092712234] 'process raft request' (duration: 111.79076ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:36:38.599428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.489104ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T19:36:38.599563Z","caller":"traceutil/trace.go:171","msg":"trace[1942870256] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"659.393136ms","start":"2026-08-24T19:36:37.940132Z","end":"2026-08-24T19:36:38.599525Z","steps":["trace[1942870256] 'process raft request' (duration: 283.721018ms)","trace[1942870256] 'compare' (duration: 375.340091ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T19:36:38.599677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T19:36:37.940114Z","time spent":"659.500888ms","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T19:36:38.599711Z","caller":"traceutil/trace.go:171","msg":"trace[344431285] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"301.440356ms","start":"2026-08-24T19:36:38.298264Z","end":"2026-08-24T19:36:38.599704Z","steps":["trace[344431285] 'process raft request' (duration: 301.253442ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:36:38.599759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T19:36:38.298241Z","time spent":"301.492747ms","remote":"127.0.0.1:49902","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-24T19:36:38.599682Z","caller":"traceutil/trace.go:171","msg":"trace[1743513135] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"283.607524ms","start":"2026-08-24T19:36:38.31606Z","end":"2026-08-24T19:36:38.599667Z","steps":["trace[1743513135] 'process raft request' (duration: 283.542502ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:36:38.599749Z","caller":"traceutil/trace.go:171","msg":"trace[765032078] linearizableReadLoop","detail":"{readStateIndex:1971; appliedIndex:1970; }","duration":"557.096274ms","start":"2026-08-24T19:36:38.04261Z","end":"2026-08-24T19:36:38.599707Z","steps":["trace[765032078] 'read index received' (duration: 181.121999ms)","trace[765032078] 'applied index is now lower than readState.Index' (duration: 375.970595ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:36:38.600066Z","caller":"traceutil/trace.go:171","msg":"trace[70657736] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"271.840066ms","start":"2026-08-24T19:36:38.328211Z","end":"2026-08-24T19:36:38.600051Z","steps":["trace[70657736] 'process raft request' (duration: 271.427758ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:36:38.600139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.532023ms","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-24T19:36:38.600171Z","caller":"traceutil/trace.go:171","msg":"trace[1684274526] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1898; }","duration":"557.591944ms","start":"2026-08-24T19:36:38.042571Z","end":"2026-08-24T19:36:38.600163Z","steps":["trace[1684274526] 'agreement among raft nodes before linearized reading' (duration: 557.453921ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:36:38.600195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T19:36:38.042555Z","time spent":"557.635275ms","remote":"127.0.0.1:49902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-24T19:36:38.600308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.904032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-30043293-aebe-496f-8264-f2f218e364ce\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-08-24T19:36:38.600342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.624528ms","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-24T19:36:38.600373Z","caller":"traceutil/trace.go:171","msg":"trace[919924249] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1898; }","duration":"266.682749ms","start":"2026-08-24T19:36:38.333682Z","end":"2026-08-24T19:36:38.600364Z","steps":["trace[919924249] 'agreement among raft nodes before linearized reading' (duration: 266.525806ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:36:38.600374Z","caller":"traceutil/trace.go:171","msg":"trace[2138381789] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-30043293-aebe-496f-8264-f2f218e364ce; range_end:; response_count:1; response_revision:1898; }","duration":"407.024696ms","start":"2026-08-24T19:36:38.193329Z","end":"2026-08-24T19:36:38.600353Z","steps":["trace[2138381789] 'agreement among raft nodes before linearized reading' (duration: 406.746ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:36:38.600424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T19:36:38.193309Z","time spent":"407.103967ms","remote":"127.0.0.1:49834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-30043293-aebe-496f-8264-f2f218e364ce\" "} {"level":"warn","ts":"2026-08-24T19:36:38.600327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.853945ms","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-24T19:36:38.600516Z","caller":"traceutil/trace.go:171","msg":"trace[148588235] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1898; }","duration":"279.061748ms","start":"2026-08-24T19:36:38.321443Z","end":"2026-08-24T19:36:38.600505Z","steps":["trace[148588235] 'agreement among raft nodes before linearized reading' (duration: 278.767362ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:36:38.722722Z","caller":"traceutil/trace.go:171","msg":"trace[875560609] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"116.444837ms","start":"2026-08-24T19:36:38.606235Z","end":"2026-08-24T19:36:38.72268Z","steps":["trace[875560609] 'process raft request' (duration: 97.103462ms)","trace[875560609] 'compare' (duration: 19.182791ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:36:39.020202Z","caller":"traceutil/trace.go:171","msg":"trace[685571863] transaction","detail":"{read_only:false; response_revision:1902; number_of_response:1; }","duration":"169.476355ms","start":"2026-08-24T19:36:38.850704Z","end":"2026-08-24T19:36:39.02018Z","steps":["trace[685571863] 'process raft request' (duration: 169.349582ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:37:03.152008Z","caller":"traceutil/trace.go:171","msg":"trace[626883778] transaction","detail":"{read_only:false; response_revision:2058; number_of_response:1; }","duration":"118.642896ms","start":"2026-08-24T19:37:03.033339Z","end":"2026-08-24T19:37:03.151982Z","steps":["trace[626883778] 'process raft request' (duration: 114.378319ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:37:10.590894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.617934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:37:10.590998Z","caller":"traceutil/trace.go:171","msg":"trace[37820407] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2109; }","duration":"147.769746ms","start":"2026-08-24T19:37:10.443203Z","end":"2026-08-24T19:37:10.590972Z","steps":["trace[37820407] 'count revisions from in-memory index tree' (duration: 147.510301ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:37:15.226455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.263865ms","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-24T19:37:15.226532Z","caller":"traceutil/trace.go:171","msg":"trace[806695099] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2136; }","duration":"191.392057ms","start":"2026-08-24T19:37:15.035123Z","end":"2026-08-24T19:37:15.226515Z","steps":["trace[806695099] 'range keys from in-memory index tree' (duration: 191.091782ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:37:27.09653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.699838ms","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-24T19:37:27.096619Z","caller":"traceutil/trace.go:171","msg":"trace[930340413] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2201; }","duration":"116.81543ms","start":"2026-08-24T19:37:26.979781Z","end":"2026-08-24T19:37:27.096596Z","steps":["trace[930340413] 'range keys from in-memory index tree' (duration: 116.564345ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:37:27.09659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.195306ms","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-24T19:37:27.09679Z","caller":"traceutil/trace.go:171","msg":"trace[1737711646] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2201; }","duration":"127.42909ms","start":"2026-08-24T19:37:26.969281Z","end":"2026-08-24T19:37:27.09671Z","steps":["trace[1737711646] 'range keys from in-memory index tree' (duration: 126.961652ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:37:27.09696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.756278ms","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-24T19:37:27.097155Z","caller":"traceutil/trace.go:171","msg":"trace[506773257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2201; }","duration":"135.352979ms","start":"2026-08-24T19:37:26.961783Z","end":"2026-08-24T19:37:27.097135Z","steps":["trace[506773257] 'range keys from in-memory index tree' (duration: 134.617624ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:37:31.448857Z","caller":"traceutil/trace.go:171","msg":"trace[8591781] linearizableReadLoop","detail":"{readStateIndex:2317; appliedIndex:2316; }","duration":"155.872297ms","start":"2026-08-24T19:37:31.292961Z","end":"2026-08-24T19:37:31.448833Z","steps":["trace[8591781] 'read index received' (duration: 155.692703ms)","trace[8591781] 'applied index is now lower than readState.Index' (duration: 178.644µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:37:31.448952Z","caller":"traceutil/trace.go:171","msg":"trace[268475159] transaction","detail":"{read_only:false; response_revision:2229; number_of_response:1; }","duration":"156.859507ms","start":"2026-08-24T19:37:31.292062Z","end":"2026-08-24T19:37:31.448922Z","steps":["trace[268475159] 'process raft request' (duration: 156.626192ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:37:31.449164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.169383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18ced4f2c5bbe967\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-08-24T19:37:31.449222Z","caller":"traceutil/trace.go:171","msg":"trace[898231908] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18ced4f2c5bbe967; range_end:; response_count:1; response_revision:2229; }","duration":"156.274455ms","start":"2026-08-24T19:37:31.292929Z","end":"2026-08-24T19:37:31.449203Z","steps":["trace[898231908] 'agreement among raft nodes before linearized reading' (duration: 156.042581ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:37:31.574706Z","caller":"traceutil/trace.go:171","msg":"trace[450463749] transaction","detail":"{read_only:false; response_revision:2231; number_of_response:1; }","duration":"121.407474ms","start":"2026-08-24T19:37:31.453258Z","end":"2026-08-24T19:37:31.574666Z","steps":["trace[450463749] 'process raft request' (duration: 92.569122ms)","trace[450463749] 'compare' (duration: 28.531856ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:37:37.456529Z","caller":"traceutil/trace.go:171","msg":"trace[812337547] transaction","detail":"{read_only:false; response_revision:2260; number_of_response:1; }","duration":"260.283423ms","start":"2026-08-24T19:37:37.196221Z","end":"2026-08-24T19:37:37.456504Z","steps":["trace[812337547] 'process raft request' (duration: 260.171171ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:37:37.473324Z","caller":"traceutil/trace.go:171","msg":"trace[976935491] linearizableReadLoop","detail":"{readStateIndex:2350; appliedIndex:2348; }","duration":"272.015745ms","start":"2026-08-24T19:37:37.201287Z","end":"2026-08-24T19:37:37.473303Z","steps":["trace[976935491] 'read index received' (duration: 255.01325ms)","trace[976935491] 'applied index is now lower than readState.Index' (duration: 17.001825ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:37:37.473402Z","caller":"traceutil/trace.go:171","msg":"trace[441213449] transaction","detail":"{read_only:false; response_revision:2261; number_of_response:1; }","duration":"275.698139ms","start":"2026-08-24T19:37:37.197674Z","end":"2026-08-24T19:37:37.473372Z","steps":["trace[441213449] 'process raft request' (duration: 275.504225ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:37:37.473481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.16085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:37:37.473516Z","caller":"traceutil/trace.go:171","msg":"trace[1192262208] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2261; }","duration":"272.269951ms","start":"2026-08-24T19:37:37.201236Z","end":"2026-08-24T19:37:37.473506Z","steps":["trace[1192262208] 'agreement among raft nodes before linearized reading' (duration: 272.172989ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:37:37.496616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.90718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:37:37.496704Z","caller":"traceutil/trace.go:171","msg":"trace[747320854] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:2262; }","duration":"103.040483ms","start":"2026-08-24T19:37:37.393643Z","end":"2026-08-24T19:37:37.496683Z","steps":["trace[747320854] 'agreement among raft nodes before linearized reading' (duration: 102.89199ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:37:37.910045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.679278ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T19:37:37.910213Z","caller":"traceutil/trace.go:171","msg":"trace[1250654044] transaction","detail":"{read_only:false; response_revision:2264; number_of_response:1; }","duration":"229.59453ms","start":"2026-08-24T19:37:37.680597Z","end":"2026-08-24T19:37:37.910192Z","steps":["trace[1250654044] 'process raft request' (duration: 63.680377ms)","trace[1250654044] 'compare' (duration: 165.486604ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T19:37:38.291037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.198788ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T19:37:38.291512Z","caller":"traceutil/trace.go:171","msg":"trace[1239101980] linearizableReadLoop","detail":"{readStateIndex:2354; appliedIndex:2353; }","duration":"125.307321ms","start":"2026-08-24T19:37:38.166185Z","end":"2026-08-24T19:37:38.291493Z","steps":["trace[1239101980] 'read index received' (duration: 51.881µs)","trace[1239101980] 'applied index is now lower than readState.Index' (duration: 125.25345ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:37:38.291542Z","caller":"traceutil/trace.go:171","msg":"trace[598904217] transaction","detail":"{read_only:false; response_revision:2265; number_of_response:1; }","duration":"375.185048ms","start":"2026-08-24T19:37:37.91633Z","end":"2026-08-24T19:37:38.291515Z","steps":["trace[598904217] 'process raft request' (duration: 211.430209ms)","trace[598904217] 'compare' (duration: 163.070696ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T19:37:38.291892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.258021ms","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-24T19:37:38.291989Z","caller":"traceutil/trace.go:171","msg":"trace[475552016] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2265; }","duration":"116.363994ms","start":"2026-08-24T19:37:38.175603Z","end":"2026-08-24T19:37:38.291967Z","steps":["trace[475552016] 'agreement among raft nodes before linearized reading' (duration: 116.132929ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:37:38.292161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T19:37:37.916313Z","time spent":"375.566015ms","remote":"127.0.0.1:49902","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-24T19:37:38.291726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.509635ms","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-24T19:37:38.292519Z","caller":"traceutil/trace.go:171","msg":"trace[168167575] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2265; }","duration":"126.338251ms","start":"2026-08-24T19:37:38.166135Z","end":"2026-08-24T19:37:38.292473Z","steps":["trace[168167575] 'agreement among raft nodes before linearized reading' (duration: 125.475564ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:37:38.82927Z","caller":"traceutil/trace.go:171","msg":"trace[787334466] transaction","detail":"{read_only:false; response_revision:2267; number_of_response:1; }","duration":"139.047921ms","start":"2026-08-24T19:37:38.690187Z","end":"2026-08-24T19:37:38.829235Z","steps":["trace[787334466] 'process raft request' (duration: 114.875545ms)","trace[787334466] 'compare' (duration: 23.713897ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:38:01.273297Z","caller":"traceutil/trace.go:171","msg":"trace[583246946] transaction","detail":"{read_only:false; response_revision:2385; number_of_response:1; }","duration":"210.120285ms","start":"2026-08-24T19:38:01.063137Z","end":"2026-08-24T19:38:01.273258Z","steps":["trace[583246946] 'process raft request' (duration: 145.20858ms)","trace[583246946] 'compare' (duration: 64.694841ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:38:29.792935Z","caller":"traceutil/trace.go:171","msg":"trace[1166611056] transaction","detail":"{read_only:false; response_revision:2648; number_of_response:1; }","duration":"117.455177ms","start":"2026-08-24T19:38:29.675454Z","end":"2026-08-24T19:38:29.792909Z","steps":["trace[1166611056] 'process raft request' (duration: 117.084789ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:38:30.436559Z","caller":"traceutil/trace.go:171","msg":"trace[561268242] transaction","detail":"{read_only:false; response_revision:2652; number_of_response:1; }","duration":"242.966666ms","start":"2026-08-24T19:38:30.193567Z","end":"2026-08-24T19:38:30.436534Z","steps":["trace[561268242] 'process raft request' (duration: 242.830443ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:38:50.77365Z","caller":"traceutil/trace.go:171","msg":"trace[1031146872] transaction","detail":"{read_only:false; response_revision:2769; number_of_response:1; }","duration":"145.764949ms","start":"2026-08-24T19:38:50.627856Z","end":"2026-08-24T19:38:50.773621Z","steps":["trace[1031146872] 'process raft request' (duration: 76.388407ms)","trace[1031146872] 'compare' (duration: 69.061296ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:39:03.403322Z","caller":"traceutil/trace.go:171","msg":"trace[835337354] transaction","detail":"{read_only:false; response_revision:2832; number_of_response:1; }","duration":"179.554658ms","start":"2026-08-24T19:39:03.223728Z","end":"2026-08-24T19:39:03.403283Z","steps":["trace[835337354] 'process raft request' (duration: 179.319348ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:39:03.853817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.291267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T19:39:03.853886Z","caller":"traceutil/trace.go:171","msg":"trace[1271905779] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:2835; }","duration":"104.37209ms","start":"2026-08-24T19:39:03.749496Z","end":"2026-08-24T19:39:03.853868Z","steps":["trace[1271905779] 'count revisions from in-memory index tree' (duration: 104.199912ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:42:54.448962Z","caller":"traceutil/trace.go:171","msg":"trace[994961575] transaction","detail":"{read_only:false; response_revision:4718; number_of_response:1; }","duration":"178.109126ms","start":"2026-08-24T19:42:54.27083Z","end":"2026-08-24T19:42:54.448939Z","steps":["trace[994961575] 'process raft request' (duration: 163.368452ms)","trace[994961575] 'compare' (duration: 14.467327ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:42:54.467543Z","caller":"traceutil/trace.go:171","msg":"trace[462763619] linearizableReadLoop","detail":"{readStateIndex:4900; appliedIndex:4898; }","duration":"103.228694ms","start":"2026-08-24T19:42:54.364297Z","end":"2026-08-24T19:42:54.467525Z","steps":["trace[462763619] 'read index received' (duration: 69.845938ms)","trace[462763619] 'applied index is now lower than readState.Index' (duration: 33.381916ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T19:42:54.46783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.519241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-11d6eea4-7720-412a-a118-f880da894b19\" ","response":"range_response_count:1 size:4049"} {"level":"info","ts":"2026-08-24T19:42:54.467906Z","caller":"traceutil/trace.go:171","msg":"trace[317026884] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-11d6eea4-7720-412a-a118-f880da894b19; range_end:; response_count:1; response_revision:4719; }","duration":"103.639193ms","start":"2026-08-24T19:42:54.364246Z","end":"2026-08-24T19:42:54.467885Z","steps":["trace[317026884] 'agreement among raft nodes before linearized reading' (duration: 103.383147ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:42:59.915453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.657635ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T19:42:59.915529Z","caller":"traceutil/trace.go:171","msg":"trace[1455710796] linearizableReadLoop","detail":"{readStateIndex:5036; appliedIndex:5035; }","duration":"122.961997ms","start":"2026-08-24T19:42:59.792557Z","end":"2026-08-24T19:42:59.915519Z","steps":["trace[1455710796] 'read index received' (duration: 3.109727ms)","trace[1455710796] 'applied index is now lower than readState.Index' (duration: 119.85154ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:42:59.915803Z","caller":"traceutil/trace.go:171","msg":"trace[55392085] transaction","detail":"{read_only:false; response_revision:4850; number_of_response:1; }","duration":"147.662465ms","start":"2026-08-24T19:42:59.768125Z","end":"2026-08-24T19:42:59.915787Z","steps":["trace[55392085] 'process raft request' (duration: 27.60391ms)","trace[55392085] 'compare' (duration: 119.571693ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T19:42:59.915971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.390008ms","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-24T19:42:59.91606Z","caller":"traceutil/trace.go:171","msg":"trace[1586770179] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4850; }","duration":"123.51478ms","start":"2026-08-24T19:42:59.792522Z","end":"2026-08-24T19:42:59.916036Z","steps":["trace[1586770179] 'agreement among raft nodes before linearized reading' (duration: 123.277195ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:43:00.14149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.207001ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-24T19:43:00.141591Z","caller":"traceutil/trace.go:171","msg":"trace[1113571851] linearizableReadLoop","detail":"{readStateIndex:5038; appliedIndex:5036; }","duration":"183.212707ms","start":"2026-08-24T19:42:59.958363Z","end":"2026-08-24T19:43:00.141575Z","steps":["trace[1113571851] 'read index received' (duration: 8.989201ms)","trace[1113571851] 'applied index is now lower than readState.Index' (duration: 174.222256ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:43:00.14181Z","caller":"traceutil/trace.go:171","msg":"trace[559495308] transaction","detail":"{read_only:false; response_revision:4852; number_of_response:1; }","duration":"220.457354ms","start":"2026-08-24T19:42:59.921305Z","end":"2026-08-24T19:43:00.141762Z","steps":["trace[559495308] 'process raft request' (duration: 113.896753ms)","trace[559495308] 'compare' (duration: 106.091469ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T19:43:00.141943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.575145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-08-24T19:43:00.142191Z","caller":"traceutil/trace.go:171","msg":"trace[1228693642] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4852; }","duration":"183.70801ms","start":"2026-08-24T19:42:59.958317Z","end":"2026-08-24T19:43:00.142025Z","steps":["trace[1228693642] 'agreement among raft nodes before linearized reading' (duration: 183.462444ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:43:00.158047Z","caller":"traceutil/trace.go:171","msg":"trace[1860233142] transaction","detail":"{read_only:false; response_revision:4853; number_of_response:1; }","duration":"107.866473ms","start":"2026-08-24T19:43:00.050163Z","end":"2026-08-24T19:43:00.15803Z","steps":["trace[1860233142] 'process raft request' (duration: 107.7404ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:43:00.158233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.252976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1ae66ba8-652c-44eb-ae4a-76283b288391\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-08-24T19:43:00.158313Z","caller":"traceutil/trace.go:171","msg":"trace[1331908204] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1ae66ba8-652c-44eb-ae4a-76283b288391; range_end:; response_count:1; response_revision:4853; }","duration":"139.344207ms","start":"2026-08-24T19:43:00.018954Z","end":"2026-08-24T19:43:00.158298Z","steps":["trace[1331908204] 'agreement among raft nodes before linearized reading' (duration: 139.110442ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:43:00.158418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.396676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-24T19:43:00.158512Z","caller":"traceutil/trace.go:171","msg":"trace[1398787243] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4853; }","duration":"121.643731ms","start":"2026-08-24T19:43:00.036841Z","end":"2026-08-24T19:43:00.158485Z","steps":["trace[1398787243] 'agreement among raft nodes before linearized reading' (duration: 121.20095ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:43:00.726771Z","caller":"traceutil/trace.go:171","msg":"trace[1148578235] linearizableReadLoop","detail":"{readStateIndex:5043; appliedIndex:5042; }","duration":"264.241298ms","start":"2026-08-24T19:43:00.462505Z","end":"2026-08-24T19:43:00.726746Z","steps":["trace[1148578235] 'read index received' (duration: 264.069024ms)","trace[1148578235] 'applied index is now lower than readState.Index' (duration: 171.134µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:43:00.726874Z","caller":"traceutil/trace.go:171","msg":"trace[291921390] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"264.973827ms","start":"2026-08-24T19:43:00.461866Z","end":"2026-08-24T19:43:00.72684Z","steps":["trace[291921390] 'process raft request' (duration: 264.70662ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:43:00.726999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.468784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7f649c45d-hptl7.18ced54182229e70\" ","response":"range_response_count:1 size:891"} {"level":"info","ts":"2026-08-24T19:43:00.727044Z","caller":"traceutil/trace.go:171","msg":"trace[2083199119] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-7f649c45d-hptl7.18ced54182229e70; range_end:; response_count:1; response_revision:4857; }","duration":"264.531755ms","start":"2026-08-24T19:43:00.462501Z","end":"2026-08-24T19:43:00.727033Z","steps":["trace[2083199119] 'agreement among raft nodes before linearized reading' (duration: 264.369811ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:43:00.757Z","caller":"traceutil/trace.go:171","msg":"trace[2039654453] transaction","detail":"{read_only:false; response_revision:4858; number_of_response:1; }","duration":"291.436987ms","start":"2026-08-24T19:43:00.465542Z","end":"2026-08-24T19:43:00.756979Z","steps":["trace[2039654453] 'process raft request' (duration: 291.251893ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:43:00.757372Z","caller":"traceutil/trace.go:171","msg":"trace[682036158] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"222.663386ms","start":"2026-08-24T19:43:00.534699Z","end":"2026-08-24T19:43:00.757363Z","steps":["trace[682036158] 'process raft request' (duration: 222.250156ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:43:00.75757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.156917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T19:43:00.757627Z","caller":"traceutil/trace.go:171","msg":"trace[480958116] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4859; }","duration":"140.290909ms","start":"2026-08-24T19:43:00.617326Z","end":"2026-08-24T19:43:00.757617Z","steps":["trace[480958116] 'agreement among raft nodes before linearized reading' (duration: 140.170956ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:43:00.757734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.282843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T19:43:00.757831Z","caller":"traceutil/trace.go:171","msg":"trace[201919704] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4859; }","duration":"254.417107ms","start":"2026-08-24T19:43:00.503377Z","end":"2026-08-24T19:43:00.757794Z","steps":["trace[201919704] 'agreement among raft nodes before linearized reading' (duration: 254.255592ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:43:00.758049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.312044ms","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-24T19:43:00.758188Z","caller":"traceutil/trace.go:171","msg":"trace[1566847948] 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:4859; }","duration":"293.524168ms","start":"2026-08-24T19:43:00.46464Z","end":"2026-08-24T19:43:00.758164Z","steps":["trace[1566847948] 'agreement among raft nodes before linearized reading' (duration: 293.19614ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:43:13.795753Z","caller":"traceutil/trace.go:171","msg":"trace[758261091] linearizableReadLoop","detail":"{readStateIndex:5222; appliedIndex:5221; }","duration":"150.377343ms","start":"2026-08-24T19:43:13.645353Z","end":"2026-08-24T19:43:13.79573Z","steps":["trace[758261091] 'read index received' (duration: 150.186398ms)","trace[758261091] 'applied index is now lower than readState.Index' (duration: 190.015µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:43:13.795862Z","caller":"traceutil/trace.go:171","msg":"trace[464272305] transaction","detail":"{read_only:false; response_revision:5030; number_of_response:1; }","duration":"187.057705ms","start":"2026-08-24T19:43:13.608761Z","end":"2026-08-24T19:43:13.795819Z","steps":["trace[464272305] 'process raft request' (duration: 186.834069ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:43:13.79598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.615269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-08-24T19:43:13.796021Z","caller":"traceutil/trace.go:171","msg":"trace[1359713923] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5030; }","duration":"150.710832ms","start":"2026-08-24T19:43:13.645296Z","end":"2026-08-24T19:43:13.796006Z","steps":["trace[1359713923] 'agreement among raft nodes before linearized reading' (duration: 150.554658ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:43:14.166554Z","caller":"traceutil/trace.go:171","msg":"trace[212084647] linearizableReadLoop","detail":"{readStateIndex:5223; appliedIndex:5222; }","duration":"365.309392ms","start":"2026-08-24T19:43:13.80122Z","end":"2026-08-24T19:43:14.166529Z","steps":["trace[212084647] 'read index received' (duration: 331.328697ms)","trace[212084647] 'applied index is now lower than readState.Index' (duration: 33.979625ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:43:14.166678Z","caller":"traceutil/trace.go:171","msg":"trace[587808955] transaction","detail":"{read_only:false; response_revision:5031; number_of_response:1; }","duration":"365.680701ms","start":"2026-08-24T19:43:13.800984Z","end":"2026-08-24T19:43:14.166664Z","steps":["trace[587808955] 'process raft request' (duration: 331.588484ms)","trace[587808955] 'compare' (duration: 33.561014ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T19:43:14.166784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T19:43:13.800973Z","time spent":"365.741772ms","remote":"127.0.0.1:49912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1504,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T19:43:14.166928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.691621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13286"} {"level":"info","ts":"2026-08-24T19:43:14.167005Z","caller":"traceutil/trace.go:171","msg":"trace[1532327231] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5031; }","duration":"365.805834ms","start":"2026-08-24T19:43:13.801184Z","end":"2026-08-24T19:43:14.16699Z","steps":["trace[1532327231] 'agreement among raft nodes before linearized reading' (duration: 365.61239ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:43:14.16705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T19:43:13.801161Z","time spent":"365.880716ms","remote":"127.0.0.1:49834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":13309,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"info","ts":"2026-08-24T19:43:14.2169Z","caller":"traceutil/trace.go:171","msg":"trace[1836673418] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"414.926606ms","start":"2026-08-24T19:43:13.801955Z","end":"2026-08-24T19:43:14.216882Z","steps":["trace[1836673418] 'process raft request' (duration: 414.788982ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:43:14.21703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T19:43:13.801947Z","time spent":"415.015068ms","remote":"127.0.0.1:49912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1427,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T19:43:14.217255Z","caller":"traceutil/trace.go:171","msg":"trace[736181630] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"415.173383ms","start":"2026-08-24T19:43:13.802063Z","end":"2026-08-24T19:43:14.217237Z","steps":["trace[736181630] 'process raft request' (duration: 414.776093ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:43:14.217373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T19:43:13.802052Z","time spent":"415.254855ms","remote":"127.0.0.1:49802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":949,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T19:43:14.217514Z","caller":"traceutil/trace.go:171","msg":"trace[1045684510] transaction","detail":"{read_only:false; response_revision:5035; number_of_response:1; }","duration":"252.227494ms","start":"2026-08-24T19:43:13.965279Z","end":"2026-08-24T19:43:14.217506Z","steps":["trace[1045684510] 'process raft request' (duration: 251.923727ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:43:14.217538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.263071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-08-24T19:43:14.217586Z","caller":"traceutil/trace.go:171","msg":"trace[1846591931] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5035; }","duration":"414.327432ms","start":"2026-08-24T19:43:13.803247Z","end":"2026-08-24T19:43:14.217575Z","steps":["trace[1846591931] 'agreement among raft nodes before linearized reading' (duration: 414.190049ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:43:14.217617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T19:43:13.80324Z","time spent":"414.370682ms","remote":"127.0.0.1:49796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-08-24T19:43:14.217614Z","caller":"traceutil/trace.go:171","msg":"trace[195015539] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"414.043505ms","start":"2026-08-24T19:43:13.803538Z","end":"2026-08-24T19:43:14.217582Z","steps":["trace[195015539] 'process raft request' (duration: 413.533382ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:43:14.217849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T19:43:13.803512Z","time spent":"414.189139ms","remote":"127.0.0.1:49802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":891,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T19:43:14.372673Z","caller":"traceutil/trace.go:171","msg":"trace[837453732] linearizableReadLoop","detail":"{readStateIndex:5228; appliedIndex:5227; }","duration":"155.35639ms","start":"2026-08-24T19:43:14.217293Z","end":"2026-08-24T19:43:14.37265Z","steps":["trace[837453732] 'read index received' (duration: 97.009863ms)","trace[837453732] 'applied index is now lower than readState.Index' (duration: 58.345637ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:43:14.372802Z","caller":"traceutil/trace.go:171","msg":"trace[1446392997] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"194.05323ms","start":"2026-08-24T19:43:14.178736Z","end":"2026-08-24T19:43:14.372789Z","steps":["trace[1446392997] 'process raft request' (duration: 135.5631ms)","trace[1446392997] 'compare' (duration: 58.163142ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T19:43:14.438801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.969202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-1ae66ba8-652c-44eb-ae4a-76283b288391\" ","response":"range_response_count:1 size:1322"} {"level":"warn","ts":"2026-08-24T19:43:14.438849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.131189ms","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-24T19:43:14.43889Z","caller":"traceutil/trace.go:171","msg":"trace[2045449629] range","detail":"{range_begin:/registry/persistentvolumes/pvc-1ae66ba8-652c-44eb-ae4a-76283b288391; range_end:; response_count:1; response_revision:5036; }","duration":"216.088786ms","start":"2026-08-24T19:43:14.222778Z","end":"2026-08-24T19:43:14.438867Z","steps":["trace[2045449629] 'agreement among raft nodes before linearized reading' (duration: 215.86526ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:43:14.438909Z","caller":"traceutil/trace.go:171","msg":"trace[1325940305] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5036; }","duration":"240.217261ms","start":"2026-08-24T19:43:14.198671Z","end":"2026-08-24T19:43:14.438888Z","steps":["trace[1325940305] 'agreement among raft nodes before linearized reading' (duration: 174.172718ms)","trace[1325940305] 'range keys from in-memory index tree' (duration: 65.8825ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T19:43:14.439138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.306489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-24T19:43:14.439758Z","caller":"traceutil/trace.go:171","msg":"trace[1557058181] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5036; }","duration":"204.945436ms","start":"2026-08-24T19:43:14.234781Z","end":"2026-08-24T19:43:14.439727Z","steps":["trace[1557058181] 'agreement among raft nodes before linearized reading' (duration: 204.002122ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:43:14.515181Z","caller":"traceutil/trace.go:171","msg":"trace[764609902] transaction","detail":"{read_only:false; response_revision:5039; number_of_response:1; }","duration":"133.981142ms","start":"2026-08-24T19:43:14.381177Z","end":"2026-08-24T19:43:14.515158Z","steps":["trace[764609902] 'process raft request' (duration: 133.911351ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:43:14.515191Z","caller":"traceutil/trace.go:171","msg":"trace[632298343] transaction","detail":"{read_only:false; response_revision:5038; number_of_response:1; }","duration":"134.873553ms","start":"2026-08-24T19:43:14.380287Z","end":"2026-08-24T19:43:14.51516Z","steps":["trace[632298343] 'process raft request' (duration: 134.70339ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:43:14.515643Z","caller":"traceutil/trace.go:171","msg":"trace[479538106] transaction","detail":"{read_only:false; response_revision:5040; number_of_response:1; }","duration":"134.350141ms","start":"2026-08-24T19:43:14.381279Z","end":"2026-08-24T19:43:14.515629Z","steps":["trace[479538106] 'process raft request' (duration: 133.836859ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:43:14.516004Z","caller":"traceutil/trace.go:171","msg":"trace[1254425732] transaction","detail":"{read_only:false; response_revision:5041; number_of_response:1; }","duration":"124.984024ms","start":"2026-08-24T19:43:14.391008Z","end":"2026-08-24T19:43:14.515992Z","steps":["trace[1254425732] 'process raft request' (duration: 124.376709ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:43:14.768814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.340823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-08-24T19:43:14.76892Z","caller":"traceutil/trace.go:171","msg":"trace[140632455] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5044; }","duration":"144.479356ms","start":"2026-08-24T19:43:14.624405Z","end":"2026-08-24T19:43:14.768885Z","steps":["trace[140632455] 'range keys from in-memory index tree' (duration: 144.146819ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:43:14.9505Z","caller":"traceutil/trace.go:171","msg":"trace[1636948858] transaction","detail":"{read_only:false; response_revision:5045; number_of_response:1; }","duration":"111.982028ms","start":"2026-08-24T19:43:14.838501Z","end":"2026-08-24T19:43:14.950483Z","steps":["trace[1636948858] 'process raft request' (duration: 111.860424ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:43:14.958385Z","caller":"traceutil/trace.go:171","msg":"trace[285013824] transaction","detail":"{read_only:false; response_revision:5046; number_of_response:1; }","duration":"118.873456ms","start":"2026-08-24T19:43:14.839499Z","end":"2026-08-24T19:43:14.958372Z","steps":["trace[285013824] 'process raft request' (duration: 118.666181ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:43:15.145078Z","caller":"traceutil/trace.go:171","msg":"trace[1178147600] transaction","detail":"{read_only:false; response_revision:5049; number_of_response:1; }","duration":"134.83684ms","start":"2026-08-24T19:43:15.010211Z","end":"2026-08-24T19:43:15.145048Z","steps":["trace[1178147600] 'process raft request' (duration: 91.955221ms)","trace[1178147600] 'compare' (duration: 42.616553ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:43:15.145204Z","caller":"traceutil/trace.go:171","msg":"trace[2012520285] transaction","detail":"{read_only:false; response_revision:5050; number_of_response:1; }","duration":"131.118479ms","start":"2026-08-24T19:43:15.014058Z","end":"2026-08-24T19:43:15.145176Z","steps":["trace[2012520285] 'process raft request' (duration: 130.903104ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:43:15.145699Z","caller":"traceutil/trace.go:171","msg":"trace[823421354] transaction","detail":"{read_only:false; response_revision:5051; number_of_response:1; }","duration":"129.396518ms","start":"2026-08-24T19:43:15.016284Z","end":"2026-08-24T19:43:15.145681Z","steps":["trace[823421354] 'process raft request' (duration: 128.772292ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:43:15.145825Z","caller":"traceutil/trace.go:171","msg":"trace[744339671] transaction","detail":"{read_only:false; response_revision:5052; number_of_response:1; }","duration":"106.062333ms","start":"2026-08-24T19:43:15.039738Z","end":"2026-08-24T19:43:15.1458Z","steps":["trace[744339671] 'process raft request' (duration: 105.884519ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:44:06.326987Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2851} {"level":"info","ts":"2026-08-24T19:44:06.434561Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2851,"took":"105.765031ms","hash":726392386,"current-db-size-bytes":54538240,"current-db-size":"54 MB","current-db-size-in-use-bytes":29106176,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-24T19:44:06.434659Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":726392386,"revision":2851,"compact-revision":-1} {"level":"info","ts":"2026-08-24T19:46:57.865298Z","caller":"traceutil/trace.go:171","msg":"trace[1814468486] transaction","detail":"{read_only:false; response_revision:6649; number_of_response:1; }","duration":"101.747089ms","start":"2026-08-24T19:46:57.763529Z","end":"2026-08-24T19:46:57.865277Z","steps":["trace[1814468486] 'process raft request' (duration: 101.619207ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:46:57.980561Z","caller":"traceutil/trace.go:171","msg":"trace[324413907] linearizableReadLoop","detail":"{readStateIndex:6896; appliedIndex:6894; }","duration":"151.466332ms","start":"2026-08-24T19:46:57.829073Z","end":"2026-08-24T19:46:57.980539Z","steps":["trace[324413907] 'read index received' (duration: 36.166085ms)","trace[324413907] 'applied index is now lower than readState.Index' (duration: 115.299357ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T19:46:57.98078Z","caller":"traceutil/trace.go:171","msg":"trace[1706922962] transaction","detail":"{read_only:false; response_revision:6650; number_of_response:1; }","duration":"170.096104ms","start":"2026-08-24T19:46:57.810623Z","end":"2026-08-24T19:46:57.980719Z","steps":["trace[1706922962] 'process raft request' (duration: 155.999493ms)","trace[1706922962] 'compare' (duration: 13.813404ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T19:46:57.980885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.182366ms","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-24T19:46:57.980951Z","caller":"traceutil/trace.go:171","msg":"trace[1395123127] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6650; }","duration":"146.285019ms","start":"2026-08-24T19:46:57.83465Z","end":"2026-08-24T19:46:57.980935Z","steps":["trace[1395123127] 'agreement among raft nodes before linearized reading' (duration: 146.083485ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T19:46:57.980949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.845951ms","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-24T19:46:57.98104Z","caller":"traceutil/trace.go:171","msg":"trace[1514061756] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6650; }","duration":"151.977673ms","start":"2026-08-24T19:46:57.829038Z","end":"2026-08-24T19:46:57.981016Z","steps":["trace[1514061756] 'agreement among raft nodes before linearized reading' (duration: 151.681928ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T19:49:06.333917Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5500} {"level":"info","ts":"2026-08-24T19:49:06.404812Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5500,"took":"69.483706ms","hash":443117916,"current-db-size-bytes":54538240,"current-db-size":"54 MB","current-db-size-in-use-bytes":18702336,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-08-24T19:49:06.404871Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":443117916,"revision":5500,"compact-revision":2851}