{"level":"warn","ts":"2026-07-13T19:55:57.8942Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-13T19:55:57.894304Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57: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-07-13T19:55:57.894379Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-13T19:55:57.894392Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-07-13T19:55:57.894411Z","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-07-13T19:55:57.895325Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]} {"level":"info","ts":"2026-07-13T19:55:57.895434Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57: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-07-13T19:55:57.899027Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.16468ms"} {"level":"info","ts":"2026-07-13T19:55:57.904965Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"} {"level":"info","ts":"2026-07-13T19:55:57.905042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"} {"level":"info","ts":"2026-07-13T19:55:57.90507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"} {"level":"info","ts":"2026-07-13T19:55:57.905091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-13T19:55:57.905108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"} {"level":"info","ts":"2026-07-13T19:55:57.905175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"warn","ts":"2026-07-13T19:55:57.924072Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-13T19:55:57.92535Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-13T19:55:57.92631Z","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-07-13T19:55:57.928292Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-13T19:55:57.92896Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-13T19:55:57.929185Z","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-07-13T19:55:57.930255Z","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-07-13T19:55:57.930292Z","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-07-13T19:55:57.932915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"info","ts":"2026-07-13T19:55:57.933434Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-07-13T19:55:57.93573Z","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-07-13T19:55:57.93606Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-13T19:55:57.936099Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-13T19:55:57.936258Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-07-13T19:55:57.936283Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-07-13T19:55:58.006173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"} {"level":"info","ts":"2026-07-13T19:55:58.006295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-13T19:55:58.006347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"} {"level":"info","ts":"2026-07-13T19:55:58.006382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"} {"level":"info","ts":"2026-07-13T19:55:58.006409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-07-13T19:55:58.006437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"} {"level":"info","ts":"2026-07-13T19:55:58.00647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-07-13T19:55:58.007843Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-13T19:55:58.008848Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-13T19:55:58.008848Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"} {"level":"info","ts":"2026-07-13T19:55:58.009057Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-13T19:55:58.009334Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-13T19:55:58.009512Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"} {"level":"info","ts":"2026-07-13T19:55:58.009564Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-13T19:55:58.009757Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-13T19:55:58.00984Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-13T19:55:58.012247Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-13T19:55:58.012716Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"} {"level":"warn","ts":"2026-07-13T19:56:00.262953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.854101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-13T19:56:00.26313Z","caller":"traceutil/trace.go:171","msg":"trace[1851155708] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:69; }","duration":"320.086556ms","start":"2026-07-13T19:55:59.943017Z","end":"2026-07-13T19:56:00.263103Z","steps":["trace[1851155708] 'range keys from in-memory index tree' (duration: 319.75799ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T19:56:00.263201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T19:55:59.942988Z","time spent":"320.201967ms","remote":"127.0.0.1:47992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-07-13T19:56:00.416586Z","caller":"traceutil/trace.go:171","msg":"trace[1082479636] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"147.202283ms","start":"2026-07-13T19:56:00.269359Z","end":"2026-07-13T19:56:00.416561Z","steps":["trace[1082479636] 'process raft request' (duration: 147.070431ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T19:56:38.641431Z","caller":"traceutil/trace.go:171","msg":"trace[1742860714] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"185.043749ms","start":"2026-07-13T19:56:38.456362Z","end":"2026-07-13T19:56:38.641406Z","steps":["trace[1742860714] 'process raft request' (duration: 184.502603ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T19:56:39.759615Z","caller":"traceutil/trace.go:171","msg":"trace[465252167] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"588.067162ms","start":"2026-07-13T19:56:39.171518Z","end":"2026-07-13T19:56:39.759585Z","steps":["trace[465252167] 'process raft request' (duration: 587.448576ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T19:56:39.760162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T19:56:39.171487Z","time spent":"588.209163ms","remote":"127.0.0.1:47716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-13T19:56:54.207985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.032257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-13T19:56:54.208079Z","caller":"traceutil/trace.go:171","msg":"trace[1052067774] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:744; }","duration":"323.155108ms","start":"2026-07-13T19:56:53.884904Z","end":"2026-07-13T19:56:54.208059Z","steps":["trace[1052067774] 'range keys from in-memory index tree' (duration: 322.900546ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T19:56:54.208129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T19:56:53.884827Z","time spent":"323.288479ms","remote":"127.0.0.1:47628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-13T19:56:54.208288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.514683ms","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-07-13T19:56:54.208367Z","caller":"traceutil/trace.go:171","msg":"trace[1550756753] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:744; }","duration":"275.637025ms","start":"2026-07-13T19:56:53.93271Z","end":"2026-07-13T19:56:54.208347Z","steps":["trace[1550756753] 'range keys from in-memory index tree' (duration: 275.313682ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T19:56:54.208426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.900175ms","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-07-13T19:56:54.208509Z","caller":"traceutil/trace.go:171","msg":"trace[1660832389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:744; }","duration":"145.034816ms","start":"2026-07-13T19:56:54.063454Z","end":"2026-07-13T19:56:54.208489Z","steps":["trace[1660832389] 'range keys from in-memory index tree' (duration: 144.351431ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T19:58:09.771461Z","caller":"traceutil/trace.go:171","msg":"trace[2100753553] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"208.39367ms","start":"2026-07-13T19:58:09.563043Z","end":"2026-07-13T19:58:09.771437Z","steps":["trace[2100753553] 'process raft request' (duration: 208.202896ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T19:58:09.780899Z","caller":"traceutil/trace.go:171","msg":"trace[183936011] linearizableReadLoop","detail":"{readStateIndex:1891; appliedIndex:1889; }","duration":"140.054377ms","start":"2026-07-13T19:58:09.640814Z","end":"2026-07-13T19:58:09.780869Z","steps":["trace[183936011] 'read index received' (duration: 130.522442ms)","trace[183936011] 'applied index is now lower than readState.Index' (duration: 9.530485ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T19:58:09.781033Z","caller":"traceutil/trace.go:171","msg":"trace[1430959508] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"161.225863ms","start":"2026-07-13T19:58:09.619719Z","end":"2026-07-13T19:58:09.780945Z","steps":["trace[1430959508] 'process raft request' (duration: 160.983498ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T19:58:09.78112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.287632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bb91aca2-175d-45e8-bdfa-89c116de7365\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-07-13T19:58:09.78117Z","caller":"traceutil/trace.go:171","msg":"trace[1126076468] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bb91aca2-175d-45e8-bdfa-89c116de7365; range_end:; response_count:1; response_revision:1820; }","duration":"140.398455ms","start":"2026-07-13T19:58:09.640757Z","end":"2026-07-13T19:58:09.781156Z","steps":["trace[1126076468] 'agreement among raft nodes before linearized reading' (duration: 140.217321ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T19:58:09.94233Z","caller":"traceutil/trace.go:171","msg":"trace[256377019] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"152.530106ms","start":"2026-07-13T19:58:09.789774Z","end":"2026-07-13T19:58:09.942304Z","steps":["trace[256377019] 'process raft request' (duration: 152.391113ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T19:58:10.246052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.374578ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-13T19:58:10.246328Z","caller":"traceutil/trace.go:171","msg":"trace[557722233] transaction","detail":"{read_only:false; response_revision:1822; number_of_response:1; }","duration":"234.025004ms","start":"2026-07-13T19:58:10.012276Z","end":"2026-07-13T19:58:10.246301Z","steps":["trace[557722233] 'process raft request' (duration: 132.175556ms)","trace[557722233] 'compare' (duration: 101.239435ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T19:58:44.575245Z","caller":"traceutil/trace.go:171","msg":"trace[1969770371] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"135.409241ms","start":"2026-07-13T19:58:44.439812Z","end":"2026-07-13T19:58:44.575221Z","steps":["trace[1969770371] 'process raft request' (duration: 133.61079ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T19:58:44.944542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.797845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-13T19:58:44.944631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.109373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-13T19:58:44.944699Z","caller":"traceutil/trace.go:171","msg":"trace[1294558183] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2060; }","duration":"121.201394ms","start":"2026-07-13T19:58:44.82348Z","end":"2026-07-13T19:58:44.944682Z","steps":["trace[1294558183] 'range keys from in-memory index tree' (duration: 120.977481ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T19:58:44.944696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.069597ms","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-07-13T19:58:44.944783Z","caller":"traceutil/trace.go:171","msg":"trace[1854666199] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2060; }","duration":"167.22058ms","start":"2026-07-13T19:58:44.777543Z","end":"2026-07-13T19:58:44.944764Z","steps":["trace[1854666199] 'range keys from in-memory index tree' (duration: 166.848863ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T19:58:44.944997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.647961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-13T19:58:44.945044Z","caller":"traceutil/trace.go:171","msg":"trace[1940481957] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:2060; }","duration":"206.728292ms","start":"2026-07-13T19:58:44.738304Z","end":"2026-07-13T19:58:44.945032Z","steps":["trace[1940481957] 'count revisions from in-memory index tree' (duration: 206.57957ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T19:58:44.944714Z","caller":"traceutil/trace.go:171","msg":"trace[1779965223] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2060; }","duration":"122.001298ms","start":"2026-07-13T19:58:44.822668Z","end":"2026-07-13T19:58:44.94467Z","steps":["trace[1779965223] 'range keys from in-memory index tree' (duration: 121.559131ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T19:58:45.144869Z","caller":"traceutil/trace.go:171","msg":"trace[1847520328] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"194.51415ms","start":"2026-07-13T19:58:44.950329Z","end":"2026-07-13T19:58:45.144843Z","steps":["trace[1847520328] 'process raft request' (duration: 194.347857ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T19:58:45.145137Z","caller":"traceutil/trace.go:171","msg":"trace[1091085077] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"194.849336ms","start":"2026-07-13T19:58:44.950275Z","end":"2026-07-13T19:58:45.145125Z","steps":["trace[1091085077] 'process raft request' (duration: 194.52912ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T19:58:45.145208Z","caller":"traceutil/trace.go:171","msg":"trace[1328266089] linearizableReadLoop","detail":"{readStateIndex:2144; appliedIndex:2141; }","duration":"112.735129ms","start":"2026-07-13T19:58:45.032451Z","end":"2026-07-13T19:58:45.145186Z","steps":["trace[1328266089] 'read index received' (duration: 112.20683ms)","trace[1328266089] 'applied index is now lower than readState.Index' (duration: 527.449µs)"],"step_count":2} {"level":"info","ts":"2026-07-13T19:58:45.145268Z","caller":"traceutil/trace.go:171","msg":"trace[648632184] transaction","detail":"{read_only:false; response_revision:2065; number_of_response:1; }","duration":"194.686423ms","start":"2026-07-13T19:58:44.950571Z","end":"2026-07-13T19:58:45.145257Z","steps":["trace[648632184] 'process raft request' (duration: 194.462729ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T19:58:45.145359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.883801ms","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-07-13T19:58:45.145406Z","caller":"traceutil/trace.go:171","msg":"trace[343367064] 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:2065; }","duration":"113.004253ms","start":"2026-07-13T19:58:45.03239Z","end":"2026-07-13T19:58:45.145394Z","steps":["trace[343367064] 'agreement among raft nodes before linearized reading' (duration: 112.884101ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T19:59:44.625503Z","caller":"traceutil/trace.go:171","msg":"trace[385957981] transaction","detail":"{read_only:false; response_revision:2489; number_of_response:1; }","duration":"199.733367ms","start":"2026-07-13T19:59:44.425742Z","end":"2026-07-13T19:59:44.625475Z","steps":["trace[385957981] 'process raft request' (duration: 148.783016ms)","trace[385957981] 'compare' (duration: 50.816399ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T20:00:17.639547Z","caller":"traceutil/trace.go:171","msg":"trace[983048442] transaction","detail":"{read_only:false; response_revision:2671; number_of_response:1; }","duration":"261.114883ms","start":"2026-07-13T20:00:17.378413Z","end":"2026-07-13T20:00:17.639528Z","steps":["trace[983048442] 'process raft request' (duration: 260.966001ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:00:17.794587Z","caller":"traceutil/trace.go:171","msg":"trace[1664840870] linearizableReadLoop","detail":"{readStateIndex:2773; appliedIndex:2772; }","duration":"145.118194ms","start":"2026-07-13T20:00:17.649455Z","end":"2026-07-13T20:00:17.794574Z","steps":["trace[1664840870] 'read index received' (duration: 144.81169ms)","trace[1664840870] 'applied index is now lower than readState.Index' (duration: 305.814µs)"],"step_count":2} {"level":"info","ts":"2026-07-13T20:00:17.794728Z","caller":"traceutil/trace.go:171","msg":"trace[1764639238] transaction","detail":"{read_only:false; response_revision:2672; number_of_response:1; }","duration":"151.639647ms","start":"2026-07-13T20:00:17.643081Z","end":"2026-07-13T20:00:17.794721Z","steps":["trace[1764639238] 'process raft request' (duration: 151.0442ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:17.795065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.60534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-13T20:00:17.795148Z","caller":"traceutil/trace.go:171","msg":"trace[1303519341] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2672; }","duration":"145.741602ms","start":"2026-07-13T20:00:17.64939Z","end":"2026-07-13T20:00:17.795132Z","steps":["trace[1303519341] 'agreement among raft nodes before linearized reading' (duration: 145.451778ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:00:17.795539Z","caller":"traceutil/trace.go:171","msg":"trace[1068720986] transaction","detail":"{read_only:false; response_revision:2673; number_of_response:1; }","duration":"138.989205ms","start":"2026-07-13T20:00:17.656533Z","end":"2026-07-13T20:00:17.795522Z","steps":["trace[1068720986] 'process raft request' (duration: 138.833843ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:17.795573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.419523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-13T20:00:17.795665Z","caller":"traceutil/trace.go:171","msg":"trace[1116425682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2673; }","duration":"140.545294ms","start":"2026-07-13T20:00:17.655106Z","end":"2026-07-13T20:00:17.795651Z","steps":["trace[1116425682] 'agreement among raft nodes before linearized reading' (duration: 140.342772ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:18.877629Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104394736756596,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-13T20:00:18.901139Z","caller":"traceutil/trace.go:171","msg":"trace[1952069210] transaction","detail":"{read_only:false; response_revision:2676; number_of_response:1; }","duration":"528.621467ms","start":"2026-07-13T20:00:18.372493Z","end":"2026-07-13T20:00:18.901115Z","steps":["trace[1952069210] 'process raft request' (duration: 528.440204ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:18.901318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:18.372468Z","time spent":"528.746999ms","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T20:00:19.066972Z","caller":"traceutil/trace.go:171","msg":"trace[1167881894] transaction","detail":"{read_only:false; response_revision:2677; number_of_response:1; }","duration":"258.907618ms","start":"2026-07-13T20:00:18.808038Z","end":"2026-07-13T20:00:19.066946Z","steps":["trace[1167881894] 'process raft request' (duration: 240.429072ms)","trace[1167881894] 'compare' (duration: 18.335675ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T20:00:19.067142Z","caller":"traceutil/trace.go:171","msg":"trace[697919774] linearizableReadLoop","detail":"{readStateIndex:2778; appliedIndex:2776; }","duration":"691.93983ms","start":"2026-07-13T20:00:18.375177Z","end":"2026-07-13T20:00:19.067117Z","steps":["trace[697919774] 'read index received' (duration: 525.75852ms)","trace[697919774] 'applied index is now lower than readState.Index' (duration: 166.18009ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T20:00:19.067376Z","caller":"traceutil/trace.go:171","msg":"trace[1922479580] transaction","detail":"{read_only:false; response_revision:2678; number_of_response:1; }","duration":"179.157746ms","start":"2026-07-13T20:00:18.888201Z","end":"2026-07-13T20:00:19.067359Z","steps":["trace[1922479580] 'process raft request' (duration: 178.70865ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:19.067449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.74581ms","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-07-13T20:00:19.067494Z","caller":"traceutil/trace.go:171","msg":"trace[1642717766] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2678; }","duration":"295.838681ms","start":"2026-07-13T20:00:18.771644Z","end":"2026-07-13T20:00:19.067482Z","steps":["trace[1642717766] 'agreement among raft nodes before linearized reading' (duration: 295.677789ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:19.067503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.310854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18c1f1cdbdeef709\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-07-13T20:00:19.067575Z","caller":"traceutil/trace.go:171","msg":"trace[2007587220] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18c1f1cdbdeef709; range_end:; response_count:1; response_revision:2678; }","duration":"692.425085ms","start":"2026-07-13T20:00:18.375131Z","end":"2026-07-13T20:00:19.067557Z","steps":["trace[2007587220] 'agreement among raft nodes before linearized reading' (duration: 692.193482ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:19.067624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:18.37512Z","time spent":"692.496237ms","remote":"127.0.0.1:47700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":804,"request content":"key:\"/registry/events/auth-system/keycloak-0.18c1f1cdbdeef709\" "} {"level":"warn","ts":"2026-07-13T20:00:20.144023Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104394736756601,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-13T20:00:20.644261Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104394736756601,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-13T20:00:20.821163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.57168176s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-13T20:00:20.821342Z","caller":"traceutil/trace.go:171","msg":"trace[473694703] transaction","detail":"{read_only:false; response_revision:2679; number_of_response:1; }","duration":"1.752002898s","start":"2026-07-13T20:00:19.069279Z","end":"2026-07-13T20:00:20.821282Z","steps":["trace[473694703] 'process raft request' (duration: 180.090295ms)","trace[473694703] 'compare' (duration: 1.571120093s)"],"step_count":2} {"level":"warn","ts":"2026-07-13T20:00:20.821418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:19.069256Z","time spent":"1.752130819s","remote":"127.0.0.1:47700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-13T20:00:21.144411Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104394736756601,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-13T20:00:21.644612Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104394736756601,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-13T20:00:21.884251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000159013s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-13T20:00:21.884324Z","caller":"traceutil/trace.go:171","msg":"trace[2068862336] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000266616s","start":"2026-07-13T20:00:19.884042Z","end":"2026-07-13T20:00:21.884309Z","steps":["trace[2068862336] 'agreement among raft nodes before linearized reading' (duration: 2.000174034s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:21.884365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:19.884032Z","time spent":"2.000325976s","remote":"127.0.0.1:47628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-13T20:00:22.145573Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104394736756601,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-13T20:00:22.646582Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104394736756601,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-13T20:00:23.147298Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104394736756601,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-13T20:00:23.618648Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.369225833s","expected-duration":"1s"} {"level":"info","ts":"2026-07-13T20:00:23.625982Z","caller":"traceutil/trace.go:171","msg":"trace[1391398885] transaction","detail":"{read_only:false; response_revision:2680; number_of_response:1; }","duration":"4.553326719s","start":"2026-07-13T20:00:19.072631Z","end":"2026-07-13T20:00:23.625958Z","steps":["trace[1391398885] 'process raft request' (duration: 4.546402491s)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:00:23.626033Z","caller":"traceutil/trace.go:171","msg":"trace[728322158] transaction","detail":"{read_only:false; response_revision:2681; number_of_response:1; }","duration":"4.376104701s","start":"2026-07-13T20:00:19.249923Z","end":"2026-07-13T20:00:23.626028Z","steps":["trace[728322158] 'process raft request' (duration: 4.375892368s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.62626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:19.249897Z","time spent":"4.376282313s","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-13T20:00:23.626301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:19.072611Z","time spent":"4.553638163s","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T20:00:23.626003Z","caller":"traceutil/trace.go:171","msg":"trace[1634348150] transaction","detail":"{read_only:false; response_revision:2682; number_of_response:1; }","duration":"4.35576848s","start":"2026-07-13T20:00:19.270221Z","end":"2026-07-13T20:00:23.625989Z","steps":["trace[1634348150] 'process raft request' (duration: 4.355680029s)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:00:23.626386Z","caller":"traceutil/trace.go:171","msg":"trace[250333240] linearizableReadLoop","detail":"{readStateIndex:2787; appliedIndex:2780; }","duration":"3.982981499s","start":"2026-07-13T20:00:19.643386Z","end":"2026-07-13T20:00:23.626368Z","steps":["trace[250333240] 'read index received' (duration: 3.975491484s)","trace[250333240] 'applied index is now lower than readState.Index' (duration: 7.489325ms)"],"step_count":2} {"level":"warn","ts":"2026-07-13T20:00:23.626424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:19.270208Z","time spent":"4.356188115s","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T20:00:23.626503Z","caller":"traceutil/trace.go:171","msg":"trace[981933137] transaction","detail":"{read_only:false; response_revision:2683; number_of_response:1; }","duration":"3.699103296s","start":"2026-07-13T20:00:19.927391Z","end":"2026-07-13T20:00:23.626494Z","steps":["trace[981933137] 'process raft request' (duration: 3.698543099s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.626583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:19.927375Z","time spent":"3.699153286s","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T20:00:23.626859Z","caller":"traceutil/trace.go:171","msg":"trace[1825015016] transaction","detail":"{read_only:false; response_revision:2684; number_of_response:1; }","duration":"2.719940241s","start":"2026-07-13T20:00:20.906911Z","end":"2026-07-13T20:00:23.626851Z","steps":["trace[1825015016] 'process raft request' (duration: 2.719363064s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.626911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:20.906888Z","time spent":"2.719995902s","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T20:00:23.62699Z","caller":"traceutil/trace.go:171","msg":"trace[1463169066] transaction","detail":"{read_only:false; response_revision:2685; number_of_response:1; }","duration":"2.554775762s","start":"2026-07-13T20:00:21.072209Z","end":"2026-07-13T20:00:23.626984Z","steps":["trace[1463169066] 'process raft request' (duration: 2.554115854s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.627042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:21.072174Z","time spent":"2.554850342s","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T20:00:23.627119Z","caller":"traceutil/trace.go:171","msg":"trace[730821272] transaction","detail":"{read_only:false; response_revision:2686; number_of_response:1; }","duration":"2.553708569s","start":"2026-07-13T20:00:21.073404Z","end":"2026-07-13T20:00:23.627113Z","steps":["trace[730821272] 'process raft request' (duration: 2.552939009s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.627152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:21.073387Z","time spent":"2.553748659s","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-13T20:00:23.627282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.983904441s","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-07-13T20:00:23.627307Z","caller":"traceutil/trace.go:171","msg":"trace[1271872964] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2686; }","duration":"3.983964331s","start":"2026-07-13T20:00:19.643337Z","end":"2026-07-13T20:00:23.627301Z","steps":["trace[1271872964] 'agreement among raft nodes before linearized reading' (duration: 3.98388036s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.627324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:19.643306Z","time spent":"3.984014592s","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-13T20:00:23.627617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.829856569s","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-07-13T20:00:23.627644Z","caller":"traceutil/trace.go:171","msg":"trace[2143366869] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2686; }","duration":"3.82992173s","start":"2026-07-13T20:00:19.797716Z","end":"2026-07-13T20:00:23.627638Z","steps":["trace[2143366869] 'agreement among raft nodes before linearized reading' (duration: 3.829848039s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.627663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:19.797696Z","time spent":"3.829963261s","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-13T20:00:23.62797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.269131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18c1f1cdbdeef709\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-07-13T20:00:23.627997Z","caller":"traceutil/trace.go:171","msg":"trace[842644160] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18c1f1cdbdeef709; range_end:; response_count:1; response_revision:2686; }","duration":"253.341162ms","start":"2026-07-13T20:00:23.374649Z","end":"2026-07-13T20:00:23.62799Z","steps":["trace[842644160] 'agreement among raft nodes before linearized reading' (duration: 253.267391ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.62817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.823927843s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-13T20:00:23.628197Z","caller":"traceutil/trace.go:171","msg":"trace[1390149094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2686; }","duration":"3.823971773s","start":"2026-07-13T20:00:19.804219Z","end":"2026-07-13T20:00:23.62819Z","steps":["trace[1390149094] 'agreement among raft nodes before linearized reading' (duration: 3.823904972s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.628214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:19.804212Z","time spent":"3.823998274s","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-13T20:00:23.628308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.797691ms","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":"warn","ts":"2026-07-13T20:00:23.628413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.824373149s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-13T20:00:23.628436Z","caller":"traceutil/trace.go:171","msg":"trace[2096213791] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2686; }","duration":"3.824413459s","start":"2026-07-13T20:00:19.804016Z","end":"2026-07-13T20:00:23.62843Z","steps":["trace[2096213791] 'agreement among raft nodes before linearized reading' (duration: 3.824349509s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.628453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:19.803998Z","time spent":"3.82445084s","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-13T20:00:23.628923Z","caller":"traceutil/trace.go:171","msg":"trace[1402186349] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2686; }","duration":"254.873932ms","start":"2026-07-13T20:00:23.373452Z","end":"2026-07-13T20:00:23.628326Z","steps":["trace[1402186349] 'agreement among raft nodes before linearized reading' (duration: 254.833622ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.629032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.884944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-13T20:00:23.629054Z","caller":"traceutil/trace.go:171","msg":"trace[1805821582] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:2686; }","duration":"688.948945ms","start":"2026-07-13T20:00:22.9401Z","end":"2026-07-13T20:00:23.629049Z","steps":["trace[1805821582] 'agreement among raft nodes before linearized reading' (duration: 688.910105ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.629072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:22.940084Z","time spent":"688.983596ms","remote":"127.0.0.1:47764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":30,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-07-13T20:00:23.629246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.25606662s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-07-13T20:00:23.629269Z","caller":"traceutil/trace.go:171","msg":"trace[580769490] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2686; }","duration":"1.256132531s","start":"2026-07-13T20:00:22.373131Z","end":"2026-07-13T20:00:23.629264Z","steps":["trace[580769490] 'agreement among raft nodes before linearized reading' (duration: 1.25602003s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.629286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:22.37311Z","time spent":"1.256171901s","remote":"127.0.0.1:47784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-07-13T20:00:23.629446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.55165649s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-07-13T20:00:23.629469Z","caller":"traceutil/trace.go:171","msg":"trace[1744442893] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2686; }","duration":"3.551724581s","start":"2026-07-13T20:00:20.077739Z","end":"2026-07-13T20:00:23.629463Z","steps":["trace[1744442893] 'agreement among raft nodes before linearized reading' (duration: 3.55165938s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.629485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:20.077713Z","time spent":"3.551768341s","remote":"127.0.0.1:47792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-07-13T20:00:23.629753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.525908003s","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-07-13T20:00:23.629792Z","caller":"traceutil/trace.go:171","msg":"trace[1526463935] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2686; }","duration":"2.525988855s","start":"2026-07-13T20:00:21.103793Z","end":"2026-07-13T20:00:23.629782Z","steps":["trace[1526463935] 'agreement among raft nodes before linearized reading' (duration: 2.525582859s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.629816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:21.103772Z","time spent":"2.526039035s","remote":"127.0.0.1:47764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1876,"request content":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-07-13T20:00:23.630148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.32031647s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-13T20:00:23.63018Z","caller":"traceutil/trace.go:171","msg":"trace[335530218] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:2686; }","duration":"2.320409502s","start":"2026-07-13T20:00:21.309761Z","end":"2026-07-13T20:00:23.630171Z","steps":["trace[335530218] 'agreement among raft nodes before linearized reading' (duration: 2.32030069s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.630197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:21.309754Z","time spent":"2.320438672s","remote":"127.0.0.1:48130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":36,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-07-13T20:00:23.630273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.337060224s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-13T20:00:23.630301Z","caller":"traceutil/trace.go:171","msg":"trace[1743899225] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:2686; }","duration":"2.337109074s","start":"2026-07-13T20:00:21.293186Z","end":"2026-07-13T20:00:23.630295Z","steps":["trace[1743899225] 'agreement among raft nodes before linearized reading' (duration: 2.337024103s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.630305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.745302405s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-13T20:00:23.630321Z","caller":"traceutil/trace.go:171","msg":"trace[1354753187] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2686; }","duration":"1.745341685s","start":"2026-07-13T20:00:21.884974Z","end":"2026-07-13T20:00:23.630315Z","steps":["trace[1354753187] 'agreement among raft nodes before linearized reading' (duration: 1.745314015s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.63032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:21.293178Z","time spent":"2.337137614s","remote":"127.0.0.1:47652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.57\" "} {"level":"warn","ts":"2026-07-13T20:00:23.630358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.178812385s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-13T20:00:23.630374Z","caller":"traceutil/trace.go:171","msg":"trace[1057136656] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:2686; }","duration":"2.178828235s","start":"2026-07-13T20:00:21.451542Z","end":"2026-07-13T20:00:23.63037Z","steps":["trace[1057136656] 'agreement among raft nodes before linearized reading' (duration: 2.178801085s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.630393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:21.451485Z","time spent":"2.178904256s","remote":"127.0.0.1:47912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-13T20:00:23.630334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:21.884959Z","time spent":"1.745372356s","remote":"127.0.0.1:47622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-13T20:00:23.630585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.434485377s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-13T20:00:23.63062Z","caller":"traceutil/trace.go:171","msg":"trace[674307076] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2686; }","duration":"2.434557488s","start":"2026-07-13T20:00:21.196053Z","end":"2026-07-13T20:00:23.63061Z","steps":["trace[674307076] 'agreement among raft nodes before linearized reading' (duration: 2.434504138s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:23.630654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:21.196034Z","time spent":"2.434612669s","remote":"127.0.0.1:51538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-13T20:00:25.104874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:24.532269Z","time spent":"572.59794ms","remote":"127.0.0.1:38844","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-13T20:00:25.105386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.704341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-13T20:00:25.105561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.023790701s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-07-13T20:00:25.106641Z","caller":"traceutil/trace.go:171","msg":"trace[1792756636] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2693; }","duration":"1.024909415s","start":"2026-07-13T20:00:24.081699Z","end":"2026-07-13T20:00:25.106608Z","steps":["trace[1792756636] 'range keys from in-memory index tree' (duration: 1.023568118s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:00:25.106711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:00:24.081674Z","time spent":"1.025022216s","remote":"127.0.0.1:47792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-07-13T20:00:25.105465Z","caller":"traceutil/trace.go:171","msg":"trace[855722961] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2693; }","duration":"220.825612ms","start":"2026-07-13T20:00:24.884621Z","end":"2026-07-13T20:00:25.105447Z","steps":["trace[855722961] 'range keys from in-memory index tree' (duration: 220.640931ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:03:53.21633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.820294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206966"} {"level":"info","ts":"2026-07-13T20:03:53.216413Z","caller":"traceutil/trace.go:171","msg":"trace[1464119169] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4422; }","duration":"218.972157ms","start":"2026-07-13T20:03:52.997424Z","end":"2026-07-13T20:03:53.216397Z","steps":["trace[1464119169] 'range keys from in-memory index tree' (duration: 217.991977ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:03:53.217208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.258796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b28346fd-c48b-411a-b51d-b82a8248ec75\" ","response":"range_response_count:1 size:3773"} {"level":"info","ts":"2026-07-13T20:03:53.217254Z","caller":"traceutil/trace.go:171","msg":"trace[1837679238] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b28346fd-c48b-411a-b51d-b82a8248ec75; range_end:; response_count:1; response_revision:4422; }","duration":"159.342267ms","start":"2026-07-13T20:03:53.0579Z","end":"2026-07-13T20:03:53.217242Z","steps":["trace[1837679238] 'range keys from in-memory index tree' (duration: 159.104942ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:02.683793Z","caller":"traceutil/trace.go:171","msg":"trace[1185549011] transaction","detail":"{read_only:false; response_revision:4607; number_of_response:1; }","duration":"224.73781ms","start":"2026-07-13T20:04:02.45903Z","end":"2026-07-13T20:04:02.683768Z","steps":["trace[1185549011] 'process raft request' (duration: 224.580837ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:02.684683Z","caller":"traceutil/trace.go:171","msg":"trace[831617455] transaction","detail":"{read_only:false; response_revision:4608; number_of_response:1; }","duration":"204.963894ms","start":"2026-07-13T20:04:02.479692Z","end":"2026-07-13T20:04:02.684656Z","steps":["trace[831617455] 'process raft request' (duration: 204.74843ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:02.684969Z","caller":"traceutil/trace.go:171","msg":"trace[1471434764] transaction","detail":"{read_only:false; response_revision:4609; number_of_response:1; }","duration":"201.451475ms","start":"2026-07-13T20:04:02.483496Z","end":"2026-07-13T20:04:02.684948Z","steps":["trace[1471434764] 'process raft request' (duration: 201.119799ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:02.685504Z","caller":"traceutil/trace.go:171","msg":"trace[1897946232] linearizableReadLoop","detail":"{readStateIndex:4788; appliedIndex:4783; }","duration":"191.069582ms","start":"2026-07-13T20:04:02.494413Z","end":"2026-07-13T20:04:02.685483Z","steps":["trace[1897946232] 'read index received' (duration: 189.252567ms)","trace[1897946232] 'applied index is now lower than readState.Index' (duration: 1.814015ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T20:04:02.685512Z","caller":"traceutil/trace.go:171","msg":"trace[1955094897] transaction","detail":"{read_only:false; response_revision:4610; number_of_response:1; }","duration":"201.808772ms","start":"2026-07-13T20:04:02.483621Z","end":"2026-07-13T20:04:02.68543Z","steps":["trace[1955094897] 'process raft request' (duration: 201.250402ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:04:02.685617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.184705ms","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-07-13T20:04:02.685655Z","caller":"traceutil/trace.go:171","msg":"trace[1666864085] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4611; }","duration":"191.275047ms","start":"2026-07-13T20:04:02.494371Z","end":"2026-07-13T20:04:02.685646Z","steps":["trace[1666864085] 'agreement among raft nodes before linearized reading' (duration: 191.170845ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:02.686099Z","caller":"traceutil/trace.go:171","msg":"trace[1780242633] transaction","detail":"{read_only:false; response_revision:4611; number_of_response:1; }","duration":"202.301582ms","start":"2026-07-13T20:04:02.483777Z","end":"2026-07-13T20:04:02.686078Z","steps":["trace[1780242633] 'process raft request' (duration: 201.469886ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:05.025787Z","caller":"traceutil/trace.go:171","msg":"trace[412374289] transaction","detail":"{read_only:false; response_revision:4619; number_of_response:1; }","duration":"335.263829ms","start":"2026-07-13T20:04:04.690498Z","end":"2026-07-13T20:04:05.025761Z","steps":["trace[412374289] 'process raft request' (duration: 335.085626ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:04:05.025949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:04:04.69048Z","time spent":"335.385012ms","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T20:04:05.051099Z","caller":"traceutil/trace.go:171","msg":"trace[848919493] transaction","detail":"{read_only:false; response_revision:4620; number_of_response:1; }","duration":"359.246535ms","start":"2026-07-13T20:04:04.691837Z","end":"2026-07-13T20:04:05.051083Z","steps":["trace[848919493] 'process raft request' (duration: 359.127443ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:04:05.051198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:04:04.691816Z","time spent":"359.332647ms","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T20:04:05.051424Z","caller":"traceutil/trace.go:171","msg":"trace[288145724] transaction","detail":"{read_only:false; response_revision:4621; number_of_response:1; }","duration":"355.108595ms","start":"2026-07-13T20:04:04.6963Z","end":"2026-07-13T20:04:05.051408Z","steps":["trace[288145724] 'process raft request' (duration: 354.748208ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:05.051447Z","caller":"traceutil/trace.go:171","msg":"trace[468595795] linearizableReadLoop","detail":"{readStateIndex:4799; appliedIndex:4795; }","duration":"311.991366ms","start":"2026-07-13T20:04:04.739426Z","end":"2026-07-13T20:04:05.051417Z","steps":["trace[468595795] 'read index received' (duration: 286.177185ms)","trace[468595795] 'applied index is now lower than readState.Index' (duration: 25.812451ms)"],"step_count":2} {"level":"warn","ts":"2026-07-13T20:04:05.05152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:04:04.69629Z","time spent":"355.190677ms","remote":"127.0.0.1:47870","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-07-13T20:04:05.051521Z","caller":"traceutil/trace.go:171","msg":"trace[1067116768] transaction","detail":"{read_only:false; response_revision:4622; number_of_response:1; }","duration":"355.165066ms","start":"2026-07-13T20:04:04.696337Z","end":"2026-07-13T20:04:05.051502Z","steps":["trace[1067116768] 'process raft request' (duration: 354.936772ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:04:05.051651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:04:04.696322Z","time spent":"355.245187ms","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-13T20:04:05.051698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.259961ms","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-07-13T20:04:05.051833Z","caller":"traceutil/trace.go:171","msg":"trace[1157682120] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4622; }","duration":"312.436245ms","start":"2026-07-13T20:04:04.739381Z","end":"2026-07-13T20:04:05.051818Z","steps":["trace[1157682120] 'agreement among raft nodes before linearized reading' (duration: 312.18769ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:04:05.051864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.018734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-07-13T20:04:05.051889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:04:04.73936Z","time spent":"312.513816ms","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-13T20:04:05.051971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.7398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3a31ddfc-30a2-4561-b186-4d4d153a7ebe\" ","response":"range_response_count:1 size:3951"} {"level":"info","ts":"2026-07-13T20:04:05.051894Z","caller":"traceutil/trace.go:171","msg":"trace[1276079481] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4622; }","duration":"226.068675ms","start":"2026-07-13T20:04:04.825816Z","end":"2026-07-13T20:04:05.051885Z","steps":["trace[1276079481] 'agreement among raft nodes before linearized reading' (duration: 225.968813ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:04:05.051909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.941925ms","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-07-13T20:04:05.052007Z","caller":"traceutil/trace.go:171","msg":"trace[2068431382] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3a31ddfc-30a2-4561-b186-4d4d153a7ebe; range_end:; response_count:1; response_revision:4622; }","duration":"131.787622ms","start":"2026-07-13T20:04:04.92021Z","end":"2026-07-13T20:04:05.051997Z","steps":["trace[2068431382] 'agreement among raft nodes before linearized reading' (duration: 131.70475ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:05.052024Z","caller":"traceutil/trace.go:171","msg":"trace[2040088148] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4622; }","duration":"258.097008ms","start":"2026-07-13T20:04:04.793913Z","end":"2026-07-13T20:04:05.05201Z","steps":["trace[2040088148] 'agreement among raft nodes before linearized reading' (duration: 257.755681ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:04:05.052148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.818809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-13T20:04:05.05219Z","caller":"traceutil/trace.go:171","msg":"trace[1337640392] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4622; }","duration":"227.88688ms","start":"2026-07-13T20:04:04.824289Z","end":"2026-07-13T20:04:05.052176Z","steps":["trace[1337640392] 'agreement among raft nodes before linearized reading' (duration: 227.773898ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:04:05.052227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.853203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-13T20:04:05.052272Z","caller":"traceutil/trace.go:171","msg":"trace[2025268567] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4622; }","duration":"166.922205ms","start":"2026-07-13T20:04:04.88534Z","end":"2026-07-13T20:04:05.052262Z","steps":["trace[2025268567] 'agreement among raft nodes before linearized reading' (duration: 166.853623ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:04:05.052429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.853479ms","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-07-13T20:04:05.05247Z","caller":"traceutil/trace.go:171","msg":"trace[854689260] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4622; }","duration":"247.93206ms","start":"2026-07-13T20:04:04.804528Z","end":"2026-07-13T20:04:05.05246Z","steps":["trace[854689260] 'agreement among raft nodes before linearized reading' (duration: 247.755316ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:05.17846Z","caller":"traceutil/trace.go:171","msg":"trace[2104629976] transaction","detail":"{read_only:false; response_revision:4623; number_of_response:1; }","duration":"121.243693ms","start":"2026-07-13T20:04:05.057185Z","end":"2026-07-13T20:04:05.178428Z","steps":["trace[2104629976] 'process raft request' (duration: 71.127631ms)","trace[2104629976] 'compare' (duration: 49.940319ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T20:04:05.210645Z","caller":"traceutil/trace.go:171","msg":"trace[376242187] transaction","detail":"{read_only:false; response_revision:4626; number_of_response:1; }","duration":"152.060611ms","start":"2026-07-13T20:04:05.058558Z","end":"2026-07-13T20:04:05.210618Z","steps":["trace[376242187] 'process raft request' (duration: 151.969479ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:05.210656Z","caller":"traceutil/trace.go:171","msg":"trace[1839542549] transaction","detail":"{read_only:false; response_revision:4624; number_of_response:1; }","duration":"153.125692ms","start":"2026-07-13T20:04:05.057495Z","end":"2026-07-13T20:04:05.210621Z","steps":["trace[1839542549] 'process raft request' (duration: 152.838286ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:05.21067Z","caller":"traceutil/trace.go:171","msg":"trace[517884585] transaction","detail":"{read_only:false; response_revision:4625; number_of_response:1; }","duration":"152.98336ms","start":"2026-07-13T20:04:05.057666Z","end":"2026-07-13T20:04:05.210649Z","steps":["trace[517884585] 'process raft request' (duration: 152.812306ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:05.21081Z","caller":"traceutil/trace.go:171","msg":"trace[560389451] transaction","detail":"{read_only:false; response_revision:4627; number_of_response:1; }","duration":"152.232394ms","start":"2026-07-13T20:04:05.058553Z","end":"2026-07-13T20:04:05.210785Z","steps":["trace[560389451] 'process raft request' (duration: 152.0187ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:04:21.215068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.379862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-6lfb8.18c1f204b1f0c09d\" ","response":"range_response_count:1 size:832"} {"level":"info","ts":"2026-07-13T20:04:21.215268Z","caller":"traceutil/trace.go:171","msg":"trace[39545124] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-6lfb8.18c1f204b1f0c09d; range_end:; response_count:1; response_revision:4807; }","duration":"889.526475ms","start":"2026-07-13T20:04:20.32562Z","end":"2026-07-13T20:04:21.215146Z","steps":["trace[39545124] 'range keys from in-memory index tree' (duration: 889.200009ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:04:21.215341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:04:20.325599Z","time spent":"889.728008ms","remote":"127.0.0.1:47700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":855,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-6lfb8.18c1f204b1f0c09d\" "} {"level":"warn","ts":"2026-07-13T20:04:21.215094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.89368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-07-13T20:04:21.215568Z","caller":"traceutil/trace.go:171","msg":"trace[1934148491] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4807; }","duration":"538.38033ms","start":"2026-07-13T20:04:20.677173Z","end":"2026-07-13T20:04:21.215554Z","steps":["trace[1934148491] 'range keys from in-memory index tree' (duration: 537.719537ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:04:21.215613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:04:20.676884Z","time spent":"538.716735ms","remote":"127.0.0.1:56638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3339,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-07-13T20:04:21.216372Z","caller":"traceutil/trace.go:171","msg":"trace[468069981] transaction","detail":"{read_only:false; response_revision:4808; number_of_response:1; }","duration":"320.288647ms","start":"2026-07-13T20:04:20.896066Z","end":"2026-07-13T20:04:21.216355Z","steps":["trace[468069981] 'process raft request' (duration: 311.617534ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:04:21.216491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:04:20.896047Z","time spent":"320.368249ms","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T20:04:21.26581Z","caller":"traceutil/trace.go:171","msg":"trace[1162149649] transaction","detail":"{read_only:false; response_revision:4809; number_of_response:1; }","duration":"191.633788ms","start":"2026-07-13T20:04:21.074148Z","end":"2026-07-13T20:04:21.265782Z","steps":["trace[1162149649] 'process raft request' (duration: 191.391883ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:21.26612Z","caller":"traceutil/trace.go:171","msg":"trace[1171819921] transaction","detail":"{read_only:false; response_revision:4810; number_of_response:1; }","duration":"164.714992ms","start":"2026-07-13T20:04:21.101361Z","end":"2026-07-13T20:04:21.266076Z","steps":["trace[1171819921] 'process raft request' (duration: 164.357615ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:21.26648Z","caller":"traceutil/trace.go:171","msg":"trace[1611560587] transaction","detail":"{read_only:false; response_revision:4811; number_of_response:1; }","duration":"164.341115ms","start":"2026-07-13T20:04:21.102072Z","end":"2026-07-13T20:04:21.266413Z","steps":["trace[1611560587] 'process raft request' (duration: 163.971088ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:21.266853Z","caller":"traceutil/trace.go:171","msg":"trace[306584243] transaction","detail":"{read_only:false; response_revision:4812; number_of_response:1; }","duration":"161.832578ms","start":"2026-07-13T20:04:21.105001Z","end":"2026-07-13T20:04:21.266834Z","steps":["trace[306584243] 'process raft request' (duration: 161.305848ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:21.419796Z","caller":"traceutil/trace.go:171","msg":"trace[726531329] linearizableReadLoop","detail":"{readStateIndex:4998; appliedIndex:4997; }","duration":"131.321874ms","start":"2026-07-13T20:04:21.288442Z","end":"2026-07-13T20:04:21.419763Z","steps":["trace[726531329] 'read index received' (duration: 33.434428ms)","trace[726531329] 'applied index is now lower than readState.Index' (duration: 97.886196ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T20:04:21.419955Z","caller":"traceutil/trace.go:171","msg":"trace[407646856] transaction","detail":"{read_only:false; response_revision:4814; number_of_response:1; }","duration":"132.15735ms","start":"2026-07-13T20:04:21.287777Z","end":"2026-07-13T20:04:21.419935Z","steps":["trace[407646856] 'process raft request' (duration: 34.12089ms)","trace[407646856] 'compare' (duration: 97.715774ms)"],"step_count":2} {"level":"warn","ts":"2026-07-13T20:04:21.420479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.010397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-13T20:04:21.420534Z","caller":"traceutil/trace.go:171","msg":"trace[883501494] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4814; }","duration":"132.12317ms","start":"2026-07-13T20:04:21.288399Z","end":"2026-07-13T20:04:21.420522Z","steps":["trace[883501494] 'agreement among raft nodes before linearized reading' (duration: 131.878675ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:21.426695Z","caller":"traceutil/trace.go:171","msg":"trace[2098918521] transaction","detail":"{read_only:false; response_revision:4815; number_of_response:1; }","duration":"136.727916ms","start":"2026-07-13T20:04:21.289946Z","end":"2026-07-13T20:04:21.426674Z","steps":["trace[2098918521] 'process raft request' (duration: 136.565903ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:04:21.426749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.381838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-13T20:04:21.426798Z","caller":"traceutil/trace.go:171","msg":"trace[2083674712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4816; }","duration":"137.451129ms","start":"2026-07-13T20:04:21.289332Z","end":"2026-07-13T20:04:21.426783Z","steps":["trace[2083674712] 'agreement among raft nodes before linearized reading' (duration: 137.318767ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:04:21.426894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.67383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-07-13T20:04:21.426935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.186505ms","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-07-13T20:04:21.426961Z","caller":"traceutil/trace.go:171","msg":"trace[2005459167] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4816; }","duration":"137.230465ms","start":"2026-07-13T20:04:21.289724Z","end":"2026-07-13T20:04:21.426955Z","steps":["trace[2005459167] 'agreement among raft nodes before linearized reading' (duration: 137.163884ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:21.426975Z","caller":"traceutil/trace.go:171","msg":"trace[1033698015] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:4816; }","duration":"116.824652ms","start":"2026-07-13T20:04:21.310129Z","end":"2026-07-13T20:04:21.426953Z","steps":["trace[1033698015] 'agreement among raft nodes before linearized reading' (duration: 116.591198ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:21.427029Z","caller":"traceutil/trace.go:171","msg":"trace[1145755018] transaction","detail":"{read_only:false; response_revision:4816; number_of_response:1; }","duration":"136.846068ms","start":"2026-07-13T20:04:21.290175Z","end":"2026-07-13T20:04:21.427021Z","steps":["trace[1145755018] 'process raft request' (duration: 136.42726ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:04:26.928133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.185888ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-13T20:04:26.928226Z","caller":"traceutil/trace.go:171","msg":"trace[475714838] linearizableReadLoop","detail":"{readStateIndex:5049; appliedIndex:5048; }","duration":"266.397432ms","start":"2026-07-13T20:04:26.661811Z","end":"2026-07-13T20:04:26.928209Z","steps":["trace[475714838] 'read index received' (duration: 13.077753ms)","trace[475714838] 'applied index is now lower than readState.Index' (duration: 253.318199ms)"],"step_count":2} {"level":"warn","ts":"2026-07-13T20:04:26.928496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.654562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-13T20:04:26.92854Z","caller":"traceutil/trace.go:171","msg":"trace[386560980] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4863; }","duration":"227.763514ms","start":"2026-07-13T20:04:26.700766Z","end":"2026-07-13T20:04:26.92853Z","steps":["trace[386560980] 'agreement among raft nodes before linearized reading' (duration: 227.682623ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:04:26.928488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.649857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-13T20:04:26.928654Z","caller":"traceutil/trace.go:171","msg":"trace[1933354214] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:4863; }","duration":"266.842371ms","start":"2026-07-13T20:04:26.66177Z","end":"2026-07-13T20:04:26.928612Z","steps":["trace[1933354214] 'agreement among raft nodes before linearized reading' (duration: 266.633097ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:27.493129Z","caller":"traceutil/trace.go:171","msg":"trace[1328441040] transaction","detail":"{read_only:false; response_revision:4865; number_of_response:1; }","duration":"204.577556ms","start":"2026-07-13T20:04:27.288525Z","end":"2026-07-13T20:04:27.493103Z","steps":["trace[1328441040] 'process raft request' (duration: 175.911334ms)","trace[1328441040] 'compare' (duration: 28.438778ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T20:04:27.493396Z","caller":"traceutil/trace.go:171","msg":"trace[455355224] transaction","detail":"{read_only:false; response_revision:4866; number_of_response:1; }","duration":"202.553459ms","start":"2026-07-13T20:04:27.290811Z","end":"2026-07-13T20:04:27.493365Z","steps":["trace[455355224] 'process raft request' (duration: 202.208602ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:27.493765Z","caller":"traceutil/trace.go:171","msg":"trace[918683472] transaction","detail":"{read_only:false; response_revision:4867; number_of_response:1; }","duration":"201.666672ms","start":"2026-07-13T20:04:27.292072Z","end":"2026-07-13T20:04:27.493739Z","steps":["trace[918683472] 'process raft request' (duration: 201.206223ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:27.714251Z","caller":"traceutil/trace.go:171","msg":"trace[1316795837] transaction","detail":"{read_only:false; response_revision:4871; number_of_response:1; }","duration":"144.654925ms","start":"2026-07-13T20:04:27.569546Z","end":"2026-07-13T20:04:27.714201Z","steps":["trace[1316795837] 'process raft request' (duration: 52.82019ms)","trace[1316795837] 'compare' (duration: 91.736473ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T20:04:27.734031Z","caller":"traceutil/trace.go:171","msg":"trace[1949497120] transaction","detail":"{read_only:false; response_revision:4872; number_of_response:1; }","duration":"163.31941ms","start":"2026-07-13T20:04:27.570687Z","end":"2026-07-13T20:04:27.734006Z","steps":["trace[1949497120] 'process raft request' (duration: 163.119676ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:27.87292Z","caller":"traceutil/trace.go:171","msg":"trace[1988945380] transaction","detail":"{read_only:false; response_revision:4873; number_of_response:1; }","duration":"125.417527ms","start":"2026-07-13T20:04:27.747474Z","end":"2026-07-13T20:04:27.872892Z","steps":["trace[1988945380] 'process raft request' (duration: 67.486572ms)","trace[1988945380] 'compare' (duration: 57.746062ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T20:04:28.540438Z","caller":"traceutil/trace.go:171","msg":"trace[757688198] transaction","detail":"{read_only:false; response_revision:4876; number_of_response:1; }","duration":"127.060202ms","start":"2026-07-13T20:04:28.413349Z","end":"2026-07-13T20:04:28.540409Z","steps":["trace[757688198] 'process raft request' (duration: 113.930699ms)","trace[757688198] 'compare' (duration: 12.998031ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T20:04:28.59497Z","caller":"traceutil/trace.go:171","msg":"trace[925701517] transaction","detail":"{read_only:false; response_revision:4877; number_of_response:1; }","duration":"181.220695ms","start":"2026-07-13T20:04:28.413713Z","end":"2026-07-13T20:04:28.594933Z","steps":["trace[925701517] 'process raft request' (duration: 180.981701ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:28.594995Z","caller":"traceutil/trace.go:171","msg":"trace[151701811] transaction","detail":"{read_only:false; response_revision:4878; number_of_response:1; }","duration":"180.973561ms","start":"2026-07-13T20:04:28.413997Z","end":"2026-07-13T20:04:28.594971Z","steps":["trace[151701811] 'process raft request' (duration: 180.849439ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:28.595266Z","caller":"traceutil/trace.go:171","msg":"trace[2087663719] transaction","detail":"{read_only:false; response_revision:4880; number_of_response:1; }","duration":"172.386052ms","start":"2026-07-13T20:04:28.422869Z","end":"2026-07-13T20:04:28.595255Z","steps":["trace[2087663719] 'process raft request' (duration: 172.29835ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:28.595283Z","caller":"traceutil/trace.go:171","msg":"trace[1712349871] transaction","detail":"{read_only:false; response_revision:4879; number_of_response:1; }","duration":"179.270709ms","start":"2026-07-13T20:04:28.415983Z","end":"2026-07-13T20:04:28.595254Z","steps":["trace[1712349871] 'process raft request' (duration: 178.904822ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:04:28.769172Z","caller":"traceutil/trace.go:171","msg":"trace[1256887679] transaction","detail":"{read_only:false; response_revision:4881; number_of_response:1; }","duration":"155.783435ms","start":"2026-07-13T20:04:28.613355Z","end":"2026-07-13T20:04:28.769139Z","steps":["trace[1256887679] 'process raft request' (duration: 125.894582ms)","trace[1256887679] 'compare' (duration: 29.670719ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T20:05:58.347727Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2871} {"level":"info","ts":"2026-07-13T20:05:58.439641Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2871,"took":"90.358328ms","hash":58216249,"current-db-size-bytes":55144448,"current-db-size":"55 MB","current-db-size-in-use-bytes":29556736,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-13T20:05:58.439724Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":58216249,"revision":2871,"compact-revision":-1} {"level":"info","ts":"2026-07-13T20:08:12.303863Z","caller":"traceutil/trace.go:171","msg":"trace[1606243877] transaction","detail":"{read_only:false; response_revision:6474; number_of_response:1; }","duration":"142.550841ms","start":"2026-07-13T20:08:12.161284Z","end":"2026-07-13T20:08:12.303835Z","steps":["trace[1606243877] 'process raft request' (duration: 142.391119ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:09:49.289619Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322104394736767379,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-13T20:09:49.751146Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.021163614s","expected-duration":"1s"} {"level":"info","ts":"2026-07-13T20:09:49.751534Z","caller":"traceutil/trace.go:171","msg":"trace[775337908] transaction","detail":"{read_only:false; response_revision:7044; number_of_response:1; }","duration":"1.021608501s","start":"2026-07-13T20:09:48.729898Z","end":"2026-07-13T20:09:49.751507Z","steps":["trace[775337908] 'process raft request' (duration: 1.021466686s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:09:49.751702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:09:48.729879Z","time spent":"1.021721765s","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T20:09:49.755074Z","caller":"traceutil/trace.go:171","msg":"trace[919610038] linearizableReadLoop","detail":"{readStateIndex:7308; appliedIndex:7305; }","duration":"966.230049ms","start":"2026-07-13T20:09:48.788819Z","end":"2026-07-13T20:09:49.755049Z","steps":["trace[919610038] 'read index received' (duration: 962.714248ms)","trace[919610038] 'applied index is now lower than readState.Index' (duration: 3.514921ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T20:09:49.755119Z","caller":"traceutil/trace.go:171","msg":"trace[1533590970] transaction","detail":"{read_only:false; response_revision:7047; number_of_response:1; }","duration":"1.018208423s","start":"2026-07-13T20:09:48.736891Z","end":"2026-07-13T20:09:49.7551Z","steps":["trace[1533590970] 'process raft request' (duration: 1.01812315s)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:09:49.755107Z","caller":"traceutil/trace.go:171","msg":"trace[832030114] transaction","detail":"{read_only:false; response_revision:7046; number_of_response:1; }","duration":"1.021979784s","start":"2026-07-13T20:09:48.733104Z","end":"2026-07-13T20:09:49.755084Z","steps":["trace[832030114] 'process raft request' (duration: 1.02187332s)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:09:49.755171Z","caller":"traceutil/trace.go:171","msg":"trace[2022701020] transaction","detail":"{read_only:false; response_revision:7045; number_of_response:1; }","duration":"1.022089609s","start":"2026-07-13T20:09:48.73304Z","end":"2026-07-13T20:09:49.75513Z","steps":["trace[2022701020] 'process raft request' (duration: 1.021827539s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:09:49.755232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:09:48.736885Z","time spent":"1.018261546s","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-13T20:09:49.755255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:09:48.733092Z","time spent":"1.022066958s","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-13T20:09:49.755317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:09:48.733027Z","time spent":"1.022216543s","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-13T20:09:49.755195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"966.359943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-13T20:09:49.755383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.749034ms","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-07-13T20:09:49.755402Z","caller":"traceutil/trace.go:171","msg":"trace[2029682190] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:7047; }","duration":"966.589992ms","start":"2026-07-13T20:09:48.788787Z","end":"2026-07-13T20:09:49.755377Z","steps":["trace[2029682190] 'agreement among raft nodes before linearized reading' (duration: 966.361753ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:09:49.755421Z","caller":"traceutil/trace.go:171","msg":"trace[1498891064] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:7047; }","duration":"297.786965ms","start":"2026-07-13T20:09:49.457622Z","end":"2026-07-13T20:09:49.755409Z","steps":["trace[1498891064] 'agreement among raft nodes before linearized reading' (duration: 297.729073ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:09:49.755394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.159317ms","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-07-13T20:09:49.755489Z","caller":"traceutil/trace.go:171","msg":"trace[1742192782] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:7047; }","duration":"432.268511ms","start":"2026-07-13T20:09:49.323202Z","end":"2026-07-13T20:09:49.755471Z","steps":["trace[1742192782] 'agreement among raft nodes before linearized reading' (duration: 432.113976ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:09:49.755518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.107684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-07-13T20:09:49.755521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.75279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-07-13T20:09:49.755534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:09:49.323184Z","time spent":"432.336284ms","remote":"127.0.0.1:48046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-07-13T20:09:49.755545Z","caller":"traceutil/trace.go:171","msg":"trace[2137367644] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7047; }","duration":"373.146415ms","start":"2026-07-13T20:09:49.382389Z","end":"2026-07-13T20:09:49.755535Z","steps":["trace[2137367644] 'agreement among raft nodes before linearized reading' (duration: 373.049681ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:09:49.755549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.727761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-13T20:09:49.755567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:09:49.382383Z","time spent":"373.181576ms","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-13T20:09:49.755561Z","caller":"traceutil/trace.go:171","msg":"trace[136256428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7047; }","duration":"432.816702ms","start":"2026-07-13T20:09:49.322731Z","end":"2026-07-13T20:09:49.755548Z","steps":["trace[136256428] 'agreement among raft nodes before linearized reading' (duration: 432.698738ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:09:49.755578Z","caller":"traceutil/trace.go:171","msg":"trace[66592390] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7047; }","duration":"375.766402ms","start":"2026-07-13T20:09:49.379803Z","end":"2026-07-13T20:09:49.755569Z","steps":["trace[66592390] 'agreement among raft nodes before linearized reading' (duration: 375.663458ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:09:49.755594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:09:49.322716Z","time spent":"432.871144ms","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-13T20:09:49.755603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:09:49.379795Z","time spent":"375.803064ms","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-13T20:09:49.755447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:09:48.788771Z","time spent":"966.666155ms","remote":"127.0.0.1:48054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-07-13T20:09:49.755394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.780859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-13T20:09:49.755908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.596156ms","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-07-13T20:09:49.755898Z","caller":"traceutil/trace.go:171","msg":"trace[1184798102] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:7047; }","duration":"826.355ms","start":"2026-07-13T20:09:48.929532Z","end":"2026-07-13T20:09:49.755887Z","steps":["trace[1184798102] 'agreement among raft nodes before linearized reading' (duration: 825.738327ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T20:09:49.755926Z","caller":"traceutil/trace.go:171","msg":"trace[835106896] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7047; }","duration":"452.623268ms","start":"2026-07-13T20:09:49.303298Z","end":"2026-07-13T20:09:49.755921Z","steps":["trace[835106896] 'agreement among raft nodes before linearized reading' (duration: 452.576956ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:09:49.755941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:09:49.303293Z","time spent":"452.644689ms","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-13T20:09:49.75594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:09:48.92951Z","time spent":"826.418062ms","remote":"127.0.0.1:47950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":96,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-07-13T20:09:49.756067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.105053ms","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-07-13T20:09:49.756106Z","caller":"traceutil/trace.go:171","msg":"trace[89938163] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7047; }","duration":"454.173385ms","start":"2026-07-13T20:09:49.301922Z","end":"2026-07-13T20:09:49.756095Z","steps":["trace[89938163] 'agreement among raft nodes before linearized reading' (duration: 454.056941ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:09:49.75614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:09:49.301907Z","time spent":"454.225977ms","remote":"127.0.0.1:47870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-13T20:09:49.75623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.167321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-07-13T20:09:49.756247Z","caller":"traceutil/trace.go:171","msg":"trace[1307987780] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:7047; }","duration":"642.621768ms","start":"2026-07-13T20:09:49.113619Z","end":"2026-07-13T20:09:49.756241Z","steps":["trace[1307987780] 'agreement among raft nodes before linearized reading' (duration: 642.14485ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T20:09:49.756259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T20:09:49.113601Z","time spent":"642.655298ms","remote":"127.0.0.1:47792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2011,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"info","ts":"2026-07-13T20:10:58.355611Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5594} {"level":"info","ts":"2026-07-13T20:10:58.455547Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5594,"took":"98.76274ms","hash":690024448,"current-db-size-bytes":55144448,"current-db-size":"55 MB","current-db-size-in-use-bytes":18415616,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-13T20:10:58.455592Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":690024448,"revision":5594,"compact-revision":2871}