{"level":"warn","ts":"2026-04-08T06:16:44.657933Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T06:16:44.658029Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205: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.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-04-08T06:16:44.658098Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T06:16:44.658111Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-04-08T06:16:44.658131Z","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-04-08T06:16:44.658738Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-04-08T06:16:44.658806Z","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":16,"max-cpu-available":16,"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.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-04-08T06:16:44.664507Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.498477ms"} {"level":"info","ts":"2026-04-08T06:16:44.672581Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-04-08T06:16:44.672637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T06:16:44.672656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-04-08T06:16:44.672663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T06:16:44.67267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-04-08T06:16:44.672707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-04-08T06:16:44.678077Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T06:16:44.679216Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T06:16:44.680235Z","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-04-08T06:16:44.682208Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T06:16:44.682316Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T06:16:44.682484Z","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-04-08T06:16:44.682599Z","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-04-08T06:16:44.68262Z","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-04-08T06:16:44.683791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-04-08T06:16:44.683996Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-04-08T06:16:44.685671Z","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-04-08T06:16:44.685844Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T06:16:44.685876Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T06:16:44.68633Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-04-08T06:16:44.686341Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-04-08T06:16:45.172939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T06:16:45.173016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T06:16:45.173066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-04-08T06:16:45.173088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-04-08T06:16:45.173105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-04-08T06:16:45.17312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-04-08T06:16:45.173138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-04-08T06:16:45.174144Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T06:16:45.174169Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:16:45.174201Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T06:16:45.17422Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T06:16:45.174407Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T06:16:45.174443Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T06:16:45.175088Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:16:45.175168Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:16:45.175197Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T06:16:45.176363Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T06:16:45.177854Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-04-08T06:17:14.144758Z","caller":"traceutil/trace.go:171","msg":"trace[861287848] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"231.424361ms","start":"2026-04-08T06:17:13.913264Z","end":"2026-04-08T06:17:14.144688Z","steps":["trace[861287848] 'process raft request' (duration: 231.211226ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:17:14.153123Z","caller":"traceutil/trace.go:171","msg":"trace[464665887] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"236.310414ms","start":"2026-04-08T06:17:13.916788Z","end":"2026-04-08T06:17:14.153099Z","steps":["trace[464665887] 'process raft request' (duration: 236.101879ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:17:14.15327Z","caller":"traceutil/trace.go:171","msg":"trace[1248818470] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"229.715812ms","start":"2026-04-08T06:17:13.92351Z","end":"2026-04-08T06:17:14.153226Z","steps":["trace[1248818470] 'process raft request' (duration: 229.406485ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:17:14.153228Z","caller":"traceutil/trace.go:171","msg":"trace[2038770235] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"224.130283ms","start":"2026-04-08T06:17:13.929057Z","end":"2026-04-08T06:17:14.153187Z","steps":["trace[2038770235] 'process raft request' (duration: 223.984199ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:17:14.153334Z","caller":"traceutil/trace.go:171","msg":"trace[878683437] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"228.157146ms","start":"2026-04-08T06:17:13.925114Z","end":"2026-04-08T06:17:14.153271Z","steps":["trace[878683437] 'process raft request' (duration: 227.865559ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:17:14.153407Z","caller":"traceutil/trace.go:171","msg":"trace[1346776390] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"220.730724ms","start":"2026-04-08T06:17:13.932615Z","end":"2026-04-08T06:17:14.153346Z","steps":["trace[1346776390] 'process raft request' (duration: 220.487559ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:17:14.153436Z","caller":"traceutil/trace.go:171","msg":"trace[1083361367] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"224.230375ms","start":"2026-04-08T06:17:13.929139Z","end":"2026-04-08T06:17:14.15337Z","steps":["trace[1083361367] 'process raft request' (duration: 223.932478ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:17:14.153393Z","caller":"traceutil/trace.go:171","msg":"trace[1426620810] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"236.706442ms","start":"2026-04-08T06:17:13.916679Z","end":"2026-04-08T06:17:14.153385Z","steps":["trace[1426620810] 'process raft request' (duration: 236.134329ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:17:14.153509Z","caller":"traceutil/trace.go:171","msg":"trace[607969514] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"211.455ms","start":"2026-04-08T06:17:13.942044Z","end":"2026-04-08T06:17:14.153499Z","steps":["trace[607969514] 'process raft request' (duration: 211.122972ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:17:14.153532Z","caller":"traceutil/trace.go:171","msg":"trace[840092097] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"199.548135ms","start":"2026-04-08T06:17:13.953968Z","end":"2026-04-08T06:17:14.153516Z","steps":["trace[840092097] 'process raft request' (duration: 199.281959ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:17:14.15357Z","caller":"traceutil/trace.go:171","msg":"trace[1915430489] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"213.210021ms","start":"2026-04-08T06:17:13.940324Z","end":"2026-04-08T06:17:14.153534Z","steps":["trace[1915430489] 'process raft request' (duration: 212.807801ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:17:20.023076Z","caller":"traceutil/trace.go:171","msg":"trace[643678045] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"159.716342ms","start":"2026-04-08T06:17:19.863334Z","end":"2026-04-08T06:17:20.023051Z","steps":["trace[643678045] 'process raft request' (duration: 159.061537ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:17:20.233324Z","caller":"traceutil/trace.go:171","msg":"trace[1904878512] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"198.87235ms","start":"2026-04-08T06:17:20.034427Z","end":"2026-04-08T06:17:20.233299Z","steps":["trace[1904878512] 'process raft request' (duration: 198.664555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:17:20.41792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.396782ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:17:20.418108Z","caller":"traceutil/trace.go:171","msg":"trace[1985771716] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"343.117473ms","start":"2026-04-08T06:17:20.074966Z","end":"2026-04-08T06:17:20.418083Z","steps":["trace[1985771716] 'process raft request' (duration: 164.944893ms)","trace[1985771716] 'compare' (duration: 177.30389ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:17:20.418188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:17:20.074938Z","time spent":"343.215076ms","remote":"127.0.0.1:54202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T06:17:21.082749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.760364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:17:21.082855Z","caller":"traceutil/trace.go:171","msg":"trace[178490215] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"562.924768ms","start":"2026-04-08T06:17:20.519911Z","end":"2026-04-08T06:17:21.082835Z","steps":["trace[178490215] 'range keys from in-memory index tree' (duration: 562.640942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:17:21.082901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:17:20.519888Z","time spent":"563.003691ms","remote":"127.0.0.1:54890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-08T06:17:21.083098Z","caller":"traceutil/trace.go:171","msg":"trace[871139760] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"330.109552ms","start":"2026-04-08T06:17:20.752973Z","end":"2026-04-08T06:17:21.083083Z","steps":["trace[871139760] 'read index received' (duration: 321.314158ms)","trace[871139760] 'applied index is now lower than readState.Index' (duration: 8.793864ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:17:21.083277Z","caller":"traceutil/trace.go:171","msg":"trace[29817444] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"423.122719ms","start":"2026-04-08T06:17:20.659898Z","end":"2026-04-08T06:17:21.083021Z","steps":["trace[29817444] 'process raft request' (duration: 414.207032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:17:21.083342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.325318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-08T06:17:21.083458Z","caller":"traceutil/trace.go:171","msg":"trace[1982665689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"330.516932ms","start":"2026-04-08T06:17:20.752917Z","end":"2026-04-08T06:17:21.083434Z","steps":["trace[1982665689] 'agreement among raft nodes before linearized reading' (duration: 330.248256ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:17:21.083538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:17:20.752886Z","time spent":"330.639054ms","remote":"127.0.0.1:53994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-08T06:17:21.083798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:17:20.65987Z","time spent":"423.490297ms","remote":"127.0.0.1:55078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4543,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T06:17:21.084064Z","caller":"traceutil/trace.go:171","msg":"trace[1501779320] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"245.840319ms","start":"2026-04-08T06:17:20.838181Z","end":"2026-04-08T06:17:21.084021Z","steps":["trace[1501779320] 'process raft request' (duration: 245.661785ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:17:21.084121Z","caller":"traceutil/trace.go:171","msg":"trace[2118492226] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"252.495673ms","start":"2026-04-08T06:17:20.831613Z","end":"2026-04-08T06:17:21.084108Z","steps":["trace[2118492226] 'process raft request' (duration: 251.561961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:17:21.084408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.192074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-08T06:17:21.084071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.664242ms","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-04-08T06:17:21.084471Z","caller":"traceutil/trace.go:171","msg":"trace[31920605] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:622; }","duration":"245.257636ms","start":"2026-04-08T06:17:20.839198Z","end":"2026-04-08T06:17:21.084455Z","steps":["trace[31920605] 'agreement among raft nodes before linearized reading' (duration: 245.02851ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:17:21.084567Z","caller":"traceutil/trace.go:171","msg":"trace[2136326567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:622; }","duration":"330.121122ms","start":"2026-04-08T06:17:20.754347Z","end":"2026-04-08T06:17:21.084468Z","steps":["trace[2136326567] 'agreement among raft nodes before linearized reading' (duration: 329.58287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:17:21.084674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:17:20.754326Z","time spent":"330.329857ms","remote":"127.0.0.1:53994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-08T06:17:46.409266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.401156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T06:17:46.409373Z","caller":"traceutil/trace.go:171","msg":"trace[1477368174] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:810; }","duration":"332.613571ms","start":"2026-04-08T06:17:46.076741Z","end":"2026-04-08T06:17:46.409354Z","steps":["trace[1477368174] 'count revisions from in-memory index tree' (duration: 332.221092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:17:46.409422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:17:46.076709Z","time spent":"332.700833ms","remote":"127.0.0.1:54992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":9,"response size":29,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-04-08T06:17:46.409638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.908777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-s7mwr\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-08T06:17:46.409779Z","caller":"traceutil/trace.go:171","msg":"trace[1577659479] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-s7mwr; range_end:; response_count:1; response_revision:810; }","duration":"270.120452ms","start":"2026-04-08T06:17:46.139624Z","end":"2026-04-08T06:17:46.409745Z","steps":["trace[1577659479] 'range keys from in-memory index tree' (duration: 269.679622ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:07.90852Z","caller":"traceutil/trace.go:171","msg":"trace[2099467381] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"116.443588ms","start":"2026-04-08T06:18:07.792053Z","end":"2026-04-08T06:18:07.908497Z","steps":["trace[2099467381] 'process raft request' (duration: 116.181042ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:18:35.592458Z","caller":"traceutil/trace.go:171","msg":"trace[453653615] transaction","detail":"{read_only:false; response_revision:1458; number_of_response:1; }","duration":"102.147108ms","start":"2026-04-08T06:18:35.490268Z","end":"2026-04-08T06:18:35.592416Z","steps":["trace[453653615] 'process raft request' (duration: 102.006745ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:19:00.350808Z","caller":"traceutil/trace.go:171","msg":"trace[441438180] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"340.662037ms","start":"2026-04-08T06:19:00.010107Z","end":"2026-04-08T06:19:00.350769Z","steps":["trace[441438180] 'process raft request' (duration: 340.418832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:00.351002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:19:00.010087Z","time spent":"340.813561ms","remote":"127.0.0.1:53994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T06:19:17.168023Z","caller":"traceutil/trace.go:171","msg":"trace[427435975] transaction","detail":"{read_only:false; response_revision:2013; number_of_response:1; }","duration":"128.693663ms","start":"2026-04-08T06:19:17.03931Z","end":"2026-04-08T06:19:17.168004Z","steps":["trace[427435975] 'process raft request' (duration: 128.579221ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:19:49.954126Z","caller":"traceutil/trace.go:171","msg":"trace[436041179] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"185.501729ms","start":"2026-04-08T06:19:49.768576Z","end":"2026-04-08T06:19:49.954078Z","steps":["trace[436041179] 'process raft request' (duration: 133.098172ms)","trace[436041179] 'compare' (duration: 52.274074ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:19:55.84637Z","caller":"traceutil/trace.go:171","msg":"trace[1624114982] transaction","detail":"{read_only:false; response_revision:2226; number_of_response:1; }","duration":"104.491977ms","start":"2026-04-08T06:19:55.741844Z","end":"2026-04-08T06:19:55.846336Z","steps":["trace[1624114982] 'process raft request' (duration: 104.288663ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:56.577083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.079005ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:19:56.57734Z","caller":"traceutil/trace.go:171","msg":"trace[1133358553] linearizableReadLoop","detail":"{readStateIndex:2319; appliedIndex:2317; }","duration":"399.592783ms","start":"2026-04-08T06:19:56.177727Z","end":"2026-04-08T06:19:56.577319Z","steps":["trace[1133358553] 'read index received' (duration: 73.16451ms)","trace[1133358553] 'applied index is now lower than readState.Index' (duration: 326.426833ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:19:56.577373Z","caller":"traceutil/trace.go:171","msg":"trace[1849763071] transaction","detail":"{read_only:false; response_revision:2229; number_of_response:1; }","duration":"506.61933ms","start":"2026-04-08T06:19:56.070729Z","end":"2026-04-08T06:19:56.577348Z","steps":["trace[1849763071] 'process raft request' (duration: 180.159366ms)","trace[1849763071] 'compare' (duration: 325.967582ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:19:56.577387Z","caller":"traceutil/trace.go:171","msg":"trace[1193964150] transaction","detail":"{read_only:false; response_revision:2230; number_of_response:1; }","duration":"460.225872ms","start":"2026-04-08T06:19:56.117133Z","end":"2026-04-08T06:19:56.577359Z","steps":["trace[1193964150] 'process raft request' (duration: 460.113689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:56.577533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:19:56.117121Z","time spent":"460.337564ms","remote":"127.0.0.1:53994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T06:19:56.577547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:19:56.070711Z","time spent":"506.748122ms","remote":"127.0.0.1:53994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T06:19:56.577689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.949562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-08T06:19:56.577724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.3471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-08T06:19:56.577722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.520216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T06:19:56.577808Z","caller":"traceutil/trace.go:171","msg":"trace[1180975013] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2230; }","duration":"366.484484ms","start":"2026-04-08T06:19:56.2113Z","end":"2026-04-08T06:19:56.577785Z","steps":["trace[1180975013] 'agreement among raft nodes before linearized reading' (duration: 366.227268ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:19:56.577817Z","caller":"traceutil/trace.go:171","msg":"trace[2032135080] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:2230; }","duration":"292.911325ms","start":"2026-04-08T06:19:56.284885Z","end":"2026-04-08T06:19:56.577796Z","steps":["trace[2032135080] 'agreement among raft nodes before linearized reading' (duration: 292.68275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:56.577861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:19:56.211278Z","time spent":"366.574396ms","remote":"127.0.0.1:53994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-08T06:19:56.577748Z","caller":"traceutil/trace.go:171","msg":"trace[104210905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2230; }","duration":"400.024843ms","start":"2026-04-08T06:19:56.177706Z","end":"2026-04-08T06:19:56.577731Z","steps":["trace[104210905] 'agreement among raft nodes before linearized reading' (duration: 399.802178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:19:56.578044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:19:56.177621Z","time spent":"400.331351ms","remote":"127.0.0.1:53994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-08T06:21:13.833791Z","caller":"traceutil/trace.go:171","msg":"trace[928371141] transaction","detail":"{read_only:false; response_revision:2842; number_of_response:1; }","duration":"139.013064ms","start":"2026-04-08T06:21:13.694697Z","end":"2026-04-08T06:21:13.83371Z","steps":["trace[928371141] 'process raft request' (duration: 138.669646ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:23:39.838887Z","caller":"traceutil/trace.go:171","msg":"trace[125969200] linearizableReadLoop","detail":"{readStateIndex:3965; appliedIndex:3964; }","duration":"112.434693ms","start":"2026-04-08T06:23:39.72643Z","end":"2026-04-08T06:23:39.838865Z","steps":["trace[125969200] 'read index received' (duration: 110.212281ms)","trace[125969200] 'applied index is now lower than readState.Index' (duration: 2.221602ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:23:39.839018Z","caller":"traceutil/trace.go:171","msg":"trace[37746021] transaction","detail":"{read_only:false; response_revision:3816; number_of_response:1; }","duration":"198.075032ms","start":"2026-04-08T06:23:39.640915Z","end":"2026-04-08T06:23:39.83899Z","steps":["trace[37746021] 'process raft request' (duration: 195.636945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:23:39.839092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.722111ms","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-04-08T06:23:39.839788Z","caller":"traceutil/trace.go:171","msg":"trace[1312012922] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3816; }","duration":"200.433507ms","start":"2026-04-08T06:23:39.639329Z","end":"2026-04-08T06:23:39.839763Z","steps":["trace[1312012922] 'agreement among raft nodes before linearized reading' (duration: 199.633858ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:23:39.839207Z","caller":"traceutil/trace.go:171","msg":"trace[1751690602] transaction","detail":"{read_only:false; response_revision:3817; number_of_response:1; }","duration":"108.713826ms","start":"2026-04-08T06:23:39.730468Z","end":"2026-04-08T06:23:39.839181Z","steps":["trace[1751690602] 'process raft request' (duration: 108.565303ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:24:12.883493Z","caller":"traceutil/trace.go:171","msg":"trace[435447892] transaction","detail":"{read_only:false; response_revision:4061; number_of_response:1; }","duration":"114.014704ms","start":"2026-04-08T06:24:12.769445Z","end":"2026-04-08T06:24:12.88346Z","steps":["trace[435447892] 'process raft request' (duration: 113.699797ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:24:58.422804Z","caller":"traceutil/trace.go:171","msg":"trace[579366446] linearizableReadLoop","detail":"{readStateIndex:4981; appliedIndex:4980; }","duration":"101.517075ms","start":"2026-04-08T06:24:58.321266Z","end":"2026-04-08T06:24:58.422783Z","steps":["trace[579366446] 'read index received' (duration: 101.30977ms)","trace[579366446] 'applied index is now lower than readState.Index' (duration: 206.465µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:24:58.422874Z","caller":"traceutil/trace.go:171","msg":"trace[1326229557] transaction","detail":"{read_only:false; response_revision:4794; number_of_response:1; }","duration":"117.722234ms","start":"2026-04-08T06:24:58.305116Z","end":"2026-04-08T06:24:58.422838Z","steps":["trace[1326229557] 'process raft request' (duration: 117.381976ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:24:58.423085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.768381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-04-08T06:24:58.423126Z","caller":"traceutil/trace.go:171","msg":"trace[634653079] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4794; }","duration":"101.888704ms","start":"2026-04-08T06:24:58.321229Z","end":"2026-04-08T06:24:58.423118Z","steps":["trace[634653079] 'agreement among raft nodes before linearized reading' (duration: 101.644108ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:25:01.993332Z","caller":"traceutil/trace.go:171","msg":"trace[978563018] transaction","detail":"{read_only:false; response_revision:4966; number_of_response:1; }","duration":"254.510816ms","start":"2026-04-08T06:25:01.738794Z","end":"2026-04-08T06:25:01.993304Z","steps":["trace[978563018] 'process raft request' (duration: 254.350022ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:25:02.159381Z","caller":"traceutil/trace.go:171","msg":"trace[878473283] linearizableReadLoop","detail":"{readStateIndex:5159; appliedIndex:5158; }","duration":"136.158876ms","start":"2026-04-08T06:25:02.023201Z","end":"2026-04-08T06:25:02.15936Z","steps":["trace[878473283] 'read index received' (duration: 111.505159ms)","trace[878473283] 'applied index is now lower than readState.Index' (duration: 24.652897ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:25:02.159472Z","caller":"traceutil/trace.go:171","msg":"trace[1124427251] transaction","detail":"{read_only:false; response_revision:4967; number_of_response:1; }","duration":"220.760406ms","start":"2026-04-08T06:25:01.938674Z","end":"2026-04-08T06:25:02.159435Z","steps":["trace[1124427251] 'process raft request' (duration: 196.017387ms)","trace[1124427251] 'compare' (duration: 24.551274ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:25:02.160405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.1948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:24 size:719500"} {"level":"info","ts":"2026-04-08T06:25:02.160494Z","caller":"traceutil/trace.go:171","msg":"trace[590315951] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:24; response_revision:4967; }","duration":"137.331363ms","start":"2026-04-08T06:25:02.023146Z","end":"2026-04-08T06:25:02.160478Z","steps":["trace[590315951] 'agreement among raft nodes before linearized reading' (duration: 136.3186ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:25:04.53027Z","caller":"traceutil/trace.go:171","msg":"trace[719532306] linearizableReadLoop","detail":"{readStateIndex:5200; appliedIndex:5199; }","duration":"214.236803ms","start":"2026-04-08T06:25:04.316017Z","end":"2026-04-08T06:25:04.530253Z","steps":["trace[719532306] 'read index received' (duration: 126.613353ms)","trace[719532306] 'applied index is now lower than readState.Index' (duration: 87.62293ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:25:04.530378Z","caller":"traceutil/trace.go:171","msg":"trace[1814203473] transaction","detail":"{read_only:false; response_revision:5006; number_of_response:1; }","duration":"216.184438ms","start":"2026-04-08T06:25:04.314177Z","end":"2026-04-08T06:25:04.530361Z","steps":["trace[1814203473] 'process raft request' (duration: 128.427085ms)","trace[1814203473] 'compare' (duration: 87.553648ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:25:04.53046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.429488ms","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-04-08T06:25:04.530496Z","caller":"traceutil/trace.go:171","msg":"trace[817981372] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5006; }","duration":"214.491299ms","start":"2026-04-08T06:25:04.315997Z","end":"2026-04-08T06:25:04.530488Z","steps":["trace[817981372] 'agreement among raft nodes before linearized reading' (duration: 214.360396ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:25:04.53046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.007268ms","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-04-08T06:25:04.530584Z","caller":"traceutil/trace.go:171","msg":"trace[164279120] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5006; }","duration":"214.140021ms","start":"2026-04-08T06:25:04.316421Z","end":"2026-04-08T06:25:04.530561Z","steps":["trace[164279120] 'agreement among raft nodes before linearized reading' (duration: 213.979917ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:25:21.026197Z","caller":"traceutil/trace.go:171","msg":"trace[1348025272] transaction","detail":"{read_only:false; response_revision:5359; number_of_response:1; }","duration":"104.037764ms","start":"2026-04-08T06:25:20.922134Z","end":"2026-04-08T06:25:21.026172Z","steps":["trace[1348025272] 'process raft request' (duration: 28.19271ms)","trace[1348025272] 'compare' (duration: 75.587848ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:25:21.315489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.081589ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T06:25:21.315617Z","caller":"traceutil/trace.go:171","msg":"trace[1934567584] linearizableReadLoop","detail":"{readStateIndex:5564; appliedIndex:5563; }","duration":"201.603557ms","start":"2026-04-08T06:25:21.113997Z","end":"2026-04-08T06:25:21.3156Z","steps":["trace[1934567584] 'read index received' (duration: 49.315334ms)","trace[1934567584] 'applied index is now lower than readState.Index' (duration: 152.286773ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:25:21.315781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.790202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-04-08T06:25:21.315807Z","caller":"traceutil/trace.go:171","msg":"trace[200666326] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5360; }","duration":"201.857384ms","start":"2026-04-08T06:25:21.113941Z","end":"2026-04-08T06:25:21.315799Z","steps":["trace[200666326] 'agreement among raft nodes before linearized reading' (duration: 201.70386ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:25:21.315934Z","caller":"traceutil/trace.go:171","msg":"trace[508677600] transaction","detail":"{read_only:false; response_revision:5360; number_of_response:1; }","duration":"237.389795ms","start":"2026-04-08T06:25:21.078447Z","end":"2026-04-08T06:25:21.315837Z","steps":["trace[508677600] 'process raft request' (duration: 84.866296ms)","trace[508677600] 'compare' (duration: 151.865023ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:25:21.616252Z","caller":"traceutil/trace.go:171","msg":"trace[1184093067] linearizableReadLoop","detail":"{readStateIndex:5566; appliedIndex:5565; }","duration":"228.115808ms","start":"2026-04-08T06:25:21.388114Z","end":"2026-04-08T06:25:21.61623Z","steps":["trace[1184093067] 'read index received' (duration: 227.966205ms)","trace[1184093067] 'applied index is now lower than readState.Index' (duration: 148.713µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:25:21.616358Z","caller":"traceutil/trace.go:171","msg":"trace[205586883] transaction","detail":"{read_only:false; response_revision:5362; number_of_response:1; }","duration":"280.175546ms","start":"2026-04-08T06:25:21.33615Z","end":"2026-04-08T06:25:21.616326Z","steps":["trace[205586883] 'process raft request' (duration: 279.948591ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:25:21.616481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.347543ms","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-04-08T06:25:21.616521Z","caller":"traceutil/trace.go:171","msg":"trace[2278766] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5362; }","duration":"228.440046ms","start":"2026-04-08T06:25:21.38807Z","end":"2026-04-08T06:25:21.61651Z","steps":["trace[2278766] 'agreement among raft nodes before linearized reading' (duration: 228.283922ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:25:21.616674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.045466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fe8319c0-86b4-43c0-a365-237a1b607ccd\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-08T06:25:21.616759Z","caller":"traceutil/trace.go:171","msg":"trace[130739129] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fe8319c0-86b4-43c0-a365-237a1b607ccd; range_end:; response_count:1; response_revision:5362; }","duration":"225.19013ms","start":"2026-04-08T06:25:21.391549Z","end":"2026-04-08T06:25:21.61674Z","steps":["trace[130739129] 'agreement among raft nodes before linearized reading' (duration: 224.881803ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:25:21.728379Z","caller":"traceutil/trace.go:171","msg":"trace[226883320] transaction","detail":"{read_only:false; response_revision:5363; number_of_response:1; }","duration":"102.273114ms","start":"2026-04-08T06:25:21.626081Z","end":"2026-04-08T06:25:21.728354Z","steps":["trace[226883320] 'process raft request' (duration: 101.332342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:25:23.617273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.197224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T06:25:23.617355Z","caller":"traceutil/trace.go:171","msg":"trace[702383293] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5384; }","duration":"144.331177ms","start":"2026-04-08T06:25:23.473007Z","end":"2026-04-08T06:25:23.617338Z","steps":["trace[702383293] 'count revisions from in-memory index tree' (duration: 144.075271ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:25:34.977022Z","caller":"traceutil/trace.go:171","msg":"trace[1616523579] transaction","detail":"{read_only:false; response_revision:5542; number_of_response:1; }","duration":"110.724081ms","start":"2026-04-08T06:25:34.866274Z","end":"2026-04-08T06:25:34.976998Z","steps":["trace[1616523579] 'process raft request' (duration: 110.558677ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:26:45.203733Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3018} {"level":"info","ts":"2026-04-08T06:26:45.288662Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3018,"took":"83.231593ms","hash":2271270846,"current-db-size-bytes":57835520,"current-db-size":"58 MB","current-db-size-in-use-bytes":31891456,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-08T06:26:45.288774Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2271270846,"revision":3018,"compact-revision":-1} {"level":"info","ts":"2026-04-08T06:31:30.596044Z","caller":"traceutil/trace.go:171","msg":"trace[649379053] linearizableReadLoop","detail":"{readStateIndex:8508; appliedIndex:8507; }","duration":"455.478953ms","start":"2026-04-08T06:31:30.140541Z","end":"2026-04-08T06:31:30.59602Z","steps":["trace[649379053] 'read index received' (duration: 455.190626ms)","trace[649379053] 'applied index is now lower than readState.Index' (duration: 287.357µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:31:30.59611Z","caller":"traceutil/trace.go:171","msg":"trace[1188437840] transaction","detail":"{read_only:false; response_revision:8215; number_of_response:1; }","duration":"476.465953ms","start":"2026-04-08T06:31:30.119614Z","end":"2026-04-08T06:31:30.59608Z","steps":["trace[1188437840] 'process raft request' (duration: 476.208427ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:31:30.596258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:31:30.119578Z","time spent":"476.606096ms","remote":"127.0.0.1:53994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T06:31:30.596259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.133572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-08T06:31:30.596263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.720448ms","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-04-08T06:31:30.596311Z","caller":"traceutil/trace.go:171","msg":"trace[553051996] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8215; }","duration":"279.242204ms","start":"2026-04-08T06:31:30.317057Z","end":"2026-04-08T06:31:30.5963Z","steps":["trace[553051996] 'agreement among raft nodes before linearized reading' (duration: 279.097901ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:31:30.596322Z","caller":"traceutil/trace.go:171","msg":"trace[563396212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8215; }","duration":"455.815921ms","start":"2026-04-08T06:31:30.140493Z","end":"2026-04-08T06:31:30.596309Z","steps":["trace[563396212] 'agreement among raft nodes before linearized reading' (duration: 455.628536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:31:30.596366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:31:30.14048Z","time spent":"455.877782ms","remote":"127.0.0.1:53994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-08T06:31:30.596448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.945612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-08T06:31:30.596457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.276829ms","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-04-08T06:31:30.596504Z","caller":"traceutil/trace.go:171","msg":"trace[54312896] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8215; }","duration":"188.023423ms","start":"2026-04-08T06:31:30.408467Z","end":"2026-04-08T06:31:30.59649Z","steps":["trace[54312896] 'agreement among raft nodes before linearized reading' (duration: 187.750106ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:31:30.59655Z","caller":"traceutil/trace.go:171","msg":"trace[338782913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8215; }","duration":"212.420183ms","start":"2026-04-08T06:31:30.384109Z","end":"2026-04-08T06:31:30.596529Z","steps":["trace[338782913] 'agreement among raft nodes before linearized reading' (duration: 212.154947ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:31:30.787666Z","caller":"traceutil/trace.go:171","msg":"trace[1658645744] transaction","detail":"{read_only:false; response_revision:8216; number_of_response:1; }","duration":"187.186804ms","start":"2026-04-08T06:31:30.600449Z","end":"2026-04-08T06:31:30.787636Z","steps":["trace[1658645744] 'process raft request' (duration: 180.850146ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:31:30.79938Z","caller":"traceutil/trace.go:171","msg":"trace[1530189952] transaction","detail":"{read_only:false; response_revision:8217; number_of_response:1; }","duration":"198.883567ms","start":"2026-04-08T06:31:30.600478Z","end":"2026-04-08T06:31:30.799362Z","steps":["trace[1530189952] 'process raft request' (duration: 198.762804ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:31:30.799687Z","caller":"traceutil/trace.go:171","msg":"trace[972189291] transaction","detail":"{read_only:false; response_revision:8218; number_of_response:1; }","duration":"199.194144ms","start":"2026-04-08T06:31:30.600469Z","end":"2026-04-08T06:31:30.799663Z","steps":["trace[972189291] 'process raft request' (duration: 198.866956ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:31:30.800028Z","caller":"traceutil/trace.go:171","msg":"trace[1918530892] transaction","detail":"{read_only:false; response_revision:8219; number_of_response:1; }","duration":"198.657631ms","start":"2026-04-08T06:31:30.601361Z","end":"2026-04-08T06:31:30.800018Z","steps":["trace[1918530892] 'process raft request' (duration: 198.203331ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:31:30.80007Z","caller":"traceutil/trace.go:171","msg":"trace[330201228] transaction","detail":"{read_only:false; response_revision:8220; number_of_response:1; }","duration":"187.624984ms","start":"2026-04-08T06:31:30.612434Z","end":"2026-04-08T06:31:30.800059Z","steps":["trace[330201228] 'process raft request' (duration: 187.312417ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:31:30.800079Z","caller":"traceutil/trace.go:171","msg":"trace[670533183] transaction","detail":"{read_only:false; response_revision:8221; number_of_response:1; }","duration":"156.358043ms","start":"2026-04-08T06:31:30.64371Z","end":"2026-04-08T06:31:30.800068Z","steps":["trace[670533183] 'process raft request' (duration: 156.159099ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:31:41.619067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.344246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T06:31:41.619169Z","caller":"traceutil/trace.go:171","msg":"trace[1193547464] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:8278; }","duration":"163.50694ms","start":"2026-04-08T06:31:41.455643Z","end":"2026-04-08T06:31:41.61915Z","steps":["trace[1193547464] 'count revisions from in-memory index tree' (duration: 163.250384ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:31:43.403548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.031241ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-08T06:31:45.210178Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6131} {"level":"info","ts":"2026-04-08T06:31:45.341071Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6131,"took":"128.40952ms","hash":866784406,"current-db-size-bytes":57835520,"current-db-size":"58 MB","current-db-size-in-use-bytes":23228416,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-08T06:31:45.341142Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":866784406,"revision":6131,"compact-revision":3018} {"level":"info","ts":"2026-04-08T06:32:07.749484Z","caller":"traceutil/trace.go:171","msg":"trace[1275862259] transaction","detail":"{read_only:false; response_revision:8471; number_of_response:1; }","duration":"114.26406ms","start":"2026-04-08T06:32:07.635192Z","end":"2026-04-08T06:32:07.749456Z","steps":["trace[1275862259] 'process raft request' (duration: 113.755188ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:32:10.956523Z","caller":"traceutil/trace.go:171","msg":"trace[1681102191] linearizableReadLoop","detail":"{readStateIndex:8792; appliedIndex:8791; }","duration":"124.580971ms","start":"2026-04-08T06:32:10.831917Z","end":"2026-04-08T06:32:10.956498Z","steps":["trace[1681102191] 'read index received' (duration: 124.420617ms)","trace[1681102191] 'applied index is now lower than readState.Index' (duration: 159.304µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:32:10.95674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.799386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19382"} {"level":"info","ts":"2026-04-08T06:32:10.956779Z","caller":"traceutil/trace.go:171","msg":"trace[374713434] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:8488; }","duration":"124.895768ms","start":"2026-04-08T06:32:10.831873Z","end":"2026-04-08T06:32:10.956769Z","steps":["trace[374713434] 'agreement among raft nodes before linearized reading' (duration: 124.725044ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:32:10.957013Z","caller":"traceutil/trace.go:171","msg":"trace[1701319807] transaction","detail":"{read_only:false; response_revision:8488; number_of_response:1; }","duration":"182.128606ms","start":"2026-04-08T06:32:10.774871Z","end":"2026-04-08T06:32:10.957Z","steps":["trace[1701319807] 'process raft request' (duration: 181.46963ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:32:11.204147Z","caller":"traceutil/trace.go:171","msg":"trace[1354921530] transaction","detail":"{read_only:false; response_revision:8489; number_of_response:1; }","duration":"192.164629ms","start":"2026-04-08T06:32:11.011947Z","end":"2026-04-08T06:32:11.204112Z","steps":["trace[1354921530] 'process raft request' (duration: 175.619033ms)","trace[1354921530] 'compare' (duration: 16.073605ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:32:11.204732Z","caller":"traceutil/trace.go:171","msg":"trace[837268810] transaction","detail":"{read_only:false; response_revision:8490; number_of_response:1; }","duration":"185.344291ms","start":"2026-04-08T06:32:11.019373Z","end":"2026-04-08T06:32:11.204717Z","steps":["trace[837268810] 'process raft request' (duration: 184.718166ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:32:11.204737Z","caller":"traceutil/trace.go:171","msg":"trace[847976873] linearizableReadLoop","detail":"{readStateIndex:8794; appliedIndex:8792; }","duration":"182.907544ms","start":"2026-04-08T06:32:11.021809Z","end":"2026-04-08T06:32:11.204717Z","steps":["trace[847976873] 'read index received' (duration: 165.761983ms)","trace[847976873] 'applied index is now lower than readState.Index' (duration: 17.144921ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:32:11.204948Z","caller":"traceutil/trace.go:171","msg":"trace[115971455] transaction","detail":"{read_only:false; response_revision:8491; number_of_response:1; }","duration":"151.91627ms","start":"2026-04-08T06:32:11.053023Z","end":"2026-04-08T06:32:11.204939Z","steps":["trace[115971455] 'process raft request' (duration: 151.595602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:32:11.205121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.298413ms","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-04-08T06:32:11.205151Z","caller":"traceutil/trace.go:171","msg":"trace[542184968] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8491; }","duration":"183.362154ms","start":"2026-04-08T06:32:11.021781Z","end":"2026-04-08T06:32:11.205143Z","steps":["trace[542184968] 'agreement among raft nodes before linearized reading' (duration: 183.257592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:32:11.205239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.132538ms","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-04-08T06:32:11.205261Z","caller":"traceutil/trace.go:171","msg":"trace[1062731845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8491; }","duration":"156.194289ms","start":"2026-04-08T06:32:11.049062Z","end":"2026-04-08T06:32:11.205256Z","steps":["trace[1062731845] 'agreement among raft nodes before linearized reading' (duration: 156.139138ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:32:24.633698Z","caller":"traceutil/trace.go:171","msg":"trace[491489831] transaction","detail":"{read_only:false; response_revision:8606; number_of_response:1; }","duration":"102.386022ms","start":"2026-04-08T06:32:24.531253Z","end":"2026-04-08T06:32:24.633639Z","steps":["trace[491489831] 'process raft request' (duration: 101.779428ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:32:25.470033Z","caller":"traceutil/trace.go:171","msg":"trace[431631422] linearizableReadLoop","detail":"{readStateIndex:8922; appliedIndex:8919; }","duration":"192.062517ms","start":"2026-04-08T06:32:25.277941Z","end":"2026-04-08T06:32:25.470004Z","steps":["trace[431631422] 'read index received' (duration: 26.56184ms)","trace[431631422] 'applied index is now lower than readState.Index' (duration: 165.499347ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:32:25.470093Z","caller":"traceutil/trace.go:171","msg":"trace[1428315326] transaction","detail":"{read_only:false; response_revision:8611; number_of_response:1; }","duration":"200.385812ms","start":"2026-04-08T06:32:25.26966Z","end":"2026-04-08T06:32:25.470046Z","steps":["trace[1428315326] 'process raft request' (duration: 100.936118ms)","trace[1428315326] 'compare' (duration: 98.955282ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:32:25.470173Z","caller":"traceutil/trace.go:171","msg":"trace[1236169590] transaction","detail":"{read_only:false; response_revision:8612; number_of_response:1; }","duration":"199.207275ms","start":"2026-04-08T06:32:25.27091Z","end":"2026-04-08T06:32:25.470118Z","steps":["trace[1236169590] 'process raft request' (duration: 199.0171ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:32:25.47033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.360355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-08T06:32:25.470369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.308923ms","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-04-08T06:32:25.470415Z","caller":"traceutil/trace.go:171","msg":"trace[1844599810] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8612; }","duration":"192.500308ms","start":"2026-04-08T06:32:25.277891Z","end":"2026-04-08T06:32:25.470392Z","steps":["trace[1844599810] 'agreement among raft nodes before linearized reading' (duration: 192.268433ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:32:25.470412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.707566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-08T06:32:25.470513Z","caller":"traceutil/trace.go:171","msg":"trace[1130721248] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8612; }","duration":"187.817568ms","start":"2026-04-08T06:32:25.28267Z","end":"2026-04-08T06:32:25.470488Z","steps":["trace[1130721248] 'agreement among raft nodes before linearized reading' (duration: 187.529472ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:32:25.470498Z","caller":"traceutil/trace.go:171","msg":"trace[2033251747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8612; }","duration":"192.534608ms","start":"2026-04-08T06:32:25.277944Z","end":"2026-04-08T06:32:25.470479Z","steps":["trace[2033251747] 'agreement among raft nodes before linearized reading' (duration: 192.243971ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:32:25.47072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.166687ms","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-04-08T06:32:25.470814Z","caller":"traceutil/trace.go:171","msg":"trace[1622061112] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8612; }","duration":"188.302979ms","start":"2026-04-08T06:32:25.282486Z","end":"2026-04-08T06:32:25.470789Z","steps":["trace[1622061112] 'agreement among raft nodes before linearized reading' (duration: 187.733426ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:09.690176Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002471.wal"} {"level":"info","ts":"2026-04-08T06:33:40.043799Z","caller":"traceutil/trace.go:171","msg":"trace[1386164285] linearizableReadLoop","detail":"{readStateIndex:9675; appliedIndex:9674; }","duration":"157.226319ms","start":"2026-04-08T06:33:39.886542Z","end":"2026-04-08T06:33:40.043768Z","steps":["trace[1386164285] 'read index received' (duration: 111.349286ms)","trace[1386164285] 'applied index is now lower than readState.Index' (duration: 45.875513ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:33:40.043948Z","caller":"traceutil/trace.go:171","msg":"trace[1226665187] transaction","detail":"{read_only:false; response_revision:9345; number_of_response:1; }","duration":"157.869724ms","start":"2026-04-08T06:33:39.886066Z","end":"2026-04-08T06:33:40.043936Z","steps":["trace[1226665187] 'process raft request' (duration: 111.825987ms)","trace[1226665187] 'compare' (duration: 45.624287ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T06:33:40.044079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.526186ms","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-04-08T06:33:40.044151Z","caller":"traceutil/trace.go:171","msg":"trace[1696217111] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9345; }","duration":"157.636108ms","start":"2026-04-08T06:33:39.886496Z","end":"2026-04-08T06:33:40.044132Z","steps":["trace[1696217111] 'agreement among raft nodes before linearized reading' (duration: 157.517776ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:33:40.065643Z","caller":"traceutil/trace.go:171","msg":"trace[289433116] transaction","detail":"{read_only:false; response_revision:9346; number_of_response:1; }","duration":"178.374663ms","start":"2026-04-08T06:33:39.887241Z","end":"2026-04-08T06:33:40.065615Z","steps":["trace[289433116] 'process raft request' (duration: 178.273531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:33:40.065676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.993451ms","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-04-08T06:33:40.065733Z","caller":"traceutil/trace.go:171","msg":"trace[750909843] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9346; }","duration":"174.092404ms","start":"2026-04-08T06:33:39.891627Z","end":"2026-04-08T06:33:40.065719Z","steps":["trace[750909843] 'agreement among raft nodes before linearized reading' (duration: 173.972481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:33:40.066042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.104351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-08T06:33:40.066118Z","caller":"traceutil/trace.go:171","msg":"trace[217972729] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9346; }","duration":"170.213113ms","start":"2026-04-08T06:33:39.895887Z","end":"2026-04-08T06:33:40.0661Z","steps":["trace[217972729] 'agreement among raft nodes before linearized reading' (duration: 169.947696ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T06:34:22.40304Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"71d28e9ac1bc4e5d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-08T06:34:22.407845Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-08T06:34:22.407974Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"warn","ts":"2026-04-08T06:34:23.873267Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646842593840978779,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-08T06:34:24.034625Z","caller":"traceutil/trace.go:171","msg":"trace[162547694] transaction","detail":"{read_only:false; response_revision:9663; number_of_response:1; }","duration":"673.960549ms","start":"2026-04-08T06:34:23.360614Z","end":"2026-04-08T06:34:24.034575Z","steps":["trace[162547694] 'process raft request' (duration: 673.791445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:34:24.034772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:34:23.360591Z","time spent":"674.106183ms","remote":"127.0.0.1:53994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T06:34:24.04412Z","caller":"traceutil/trace.go:171","msg":"trace[1184620928] linearizableReadLoop","detail":"{readStateIndex:10005; appliedIndex:10001; }","duration":"671.622085ms","start":"2026-04-08T06:34:23.372482Z","end":"2026-04-08T06:34:24.044104Z","steps":["trace[1184620928] 'read index received' (duration: 661.906637ms)","trace[1184620928] 'applied index is now lower than readState.Index' (duration: 9.714778ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T06:34:24.04421Z","caller":"traceutil/trace.go:171","msg":"trace[788628533] transaction","detail":"{read_only:false; response_revision:9664; number_of_response:1; }","duration":"486.82236ms","start":"2026-04-08T06:34:23.557381Z","end":"2026-04-08T06:34:24.044204Z","steps":["trace[788628533] 'process raft request' (duration: 486.460272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:34:24.044299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:34:23.557358Z","time spent":"486.869842ms","remote":"127.0.0.1:53994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T06:34:24.044419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.914321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T06:34:24.044493Z","caller":"traceutil/trace.go:171","msg":"trace[721124383] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:9666; }","duration":"672.042615ms","start":"2026-04-08T06:34:23.372433Z","end":"2026-04-08T06:34:24.044476Z","steps":["trace[721124383] 'agreement among raft nodes before linearized reading' (duration: 671.86082ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:34:24.044503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.635589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T06:34:24.04454Z","caller":"traceutil/trace.go:171","msg":"trace[470261336] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9666; }","duration":"522.715381ms","start":"2026-04-08T06:34:23.521814Z","end":"2026-04-08T06:34:24.044529Z","steps":["trace[470261336] 'agreement among raft nodes before linearized reading' (duration: 522.652149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:34:24.044578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:34:23.521791Z","time spent":"522.780852ms","remote":"127.0.0.1:54902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-08T06:34:24.044583Z","caller":"traceutil/trace.go:171","msg":"trace[769355845] transaction","detail":"{read_only:false; response_revision:9665; number_of_response:1; }","duration":"328.708101ms","start":"2026-04-08T06:34:23.715859Z","end":"2026-04-08T06:34:24.044567Z","steps":["trace[769355845] 'process raft request' (duration: 328.143738ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:34:24.044667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:34:23.715835Z","time spent":"328.788553ms","remote":"127.0.0.1:53994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T06:34:24.045165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.977668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T06:34:24.045203Z","caller":"traceutil/trace.go:171","msg":"trace[577086246] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:9666; }","duration":"394.047389ms","start":"2026-04-08T06:34:23.651146Z","end":"2026-04-08T06:34:24.045193Z","steps":["trace[577086246] 'agreement among raft nodes before linearized reading' (duration: 393.981718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T06:34:24.045234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:34:23.651129Z","time spent":"394.096201ms","remote":"127.0.0.1:54202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":3,"response size":29,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-04-08T06:34:24.044534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T06:34:23.372417Z","time spent":"672.105246ms","remote":"127.0.0.1:54192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":4,"response size":29,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-04-08T06:36:45.21923Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8303} {"level":"info","ts":"2026-04-08T06:36:45.300925Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8303,"took":"79.247984ms","hash":3871215929,"current-db-size-bytes":57835520,"current-db-size":"58 MB","current-db-size-in-use-bytes":24899584,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-08T06:36:45.301073Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3871215929,"revision":8303,"compact-revision":6131} {"level":"info","ts":"2026-04-08T06:41:45.224281Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10696} {"level":"info","ts":"2026-04-08T06:41:45.297284Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10696,"took":"71.087759ms","hash":4236877386,"current-db-size-bytes":57835520,"current-db-size":"58 MB","current-db-size-in-use-bytes":20414464,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-08T06:41:45.297333Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4236877386,"revision":10696,"compact-revision":8303}