{"level":"warn","ts":"2026-07-08T05:02:20.427393Z","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-08T05:02:20.427508Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38: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.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38: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-08T05:02:20.427604Z","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-08T05:02:20.427615Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-07-08T05:02:20.427646Z","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-08T05:02:20.42861Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-07-08T05:02:20.428707Z","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.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38: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-08T05:02:20.434738Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.83838ms"} {"level":"info","ts":"2026-07-08T05:02:20.444416Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-07-08T05:02:20.444556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-07-08T05:02:20.444591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-07-08T05:02:20.444618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-08T05:02:20.444642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-07-08T05:02:20.444699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-07-08T05:02:20.452456Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-08T05:02:20.453708Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-08T05:02:20.454924Z","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-08T05:02:20.457592Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-08T05:02:20.457975Z","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-08T05:02:20.458065Z","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-08T05:02:20.458079Z","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-08T05:02:20.458386Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-08T05:02:20.460946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-07-08T05:02:20.461244Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-07-08T05:02:20.467235Z","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-08T05:02:20.467372Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-07-08T05:02:20.467547Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-07-08T05:02:20.468466Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-08T05:02:20.4685Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-08T05:02:21.145359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-07-08T05:02:21.145444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-08T05:02:21.145471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-07-08T05:02:21.14549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-07-08T05:02:21.145501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-07-08T05:02:21.145517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-07-08T05:02:21.14553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-07-08T05:02:21.146573Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T05:02:21.147629Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-07-08T05:02:21.147679Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T05:02:21.147697Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T05:02:21.148002Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-08T05:02:21.148605Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-08T05:02:21.150826Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-07-08T05:02:21.151065Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-08T05:02:21.158069Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T05:02:21.158125Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T05:02:21.158141Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T05:02:42.851616Z","caller":"traceutil/trace.go:171","msg":"trace[315953983] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"179.451598ms","start":"2026-07-08T05:02:42.672132Z","end":"2026-07-08T05:02:42.851584Z","steps":["trace[315953983] 'process raft request' (duration: 179.145535ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:02:43.649514Z","caller":"traceutil/trace.go:171","msg":"trace[1583480357] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"112.925802ms","start":"2026-07-08T05:02:43.536565Z","end":"2026-07-08T05:02:43.649491Z","steps":["trace[1583480357] 'process raft request' (duration: 112.501078ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:02:46.076987Z","caller":"traceutil/trace.go:171","msg":"trace[1896778027] linearizableReadLoop","detail":"{readStateIndex:449; appliedIndex:448; }","duration":"405.266391ms","start":"2026-07-08T05:02:45.671697Z","end":"2026-07-08T05:02:46.076963Z","steps":["trace[1896778027] 'read index received' (duration: 405.076932ms)","trace[1896778027] 'applied index is now lower than readState.Index' (duration: 188.529µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:02:46.077242Z","caller":"traceutil/trace.go:171","msg":"trace[1021397290] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"418.66213ms","start":"2026-07-08T05:02:45.658503Z","end":"2026-07-08T05:02:46.077165Z","steps":["trace[1021397290] 'process raft request' (duration: 418.335635ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:02:46.077357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.46462ms","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-08T05:02:46.077372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.829392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:02:46.077485Z","caller":"traceutil/trace.go:171","msg":"trace[1289588195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:432; }","duration":"405.814195ms","start":"2026-07-08T05:02:45.671652Z","end":"2026-07-08T05:02:46.077466Z","steps":["trace[1289588195] 'agreement among raft nodes before linearized reading' (duration: 405.46572ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:02:46.077511Z","caller":"traceutil/trace.go:171","msg":"trace[1917930794] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:432; }","duration":"272.074993ms","start":"2026-07-08T05:02:45.805412Z","end":"2026-07-08T05:02:46.077487Z","steps":["trace[1917930794] 'agreement among raft nodes before linearized reading' (duration: 271.807331ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:02:46.077535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:02:45.671635Z","time spent":"405.885779ms","remote":"127.0.0.1:39378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-08T05:02:46.078258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:02:45.658486Z","time spent":"418.949023ms","remote":"127.0.0.1:39378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T05:02:48.261016Z","caller":"traceutil/trace.go:171","msg":"trace[532370737] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"139.648315ms","start":"2026-07-08T05:02:48.121339Z","end":"2026-07-08T05:02:48.260987Z","steps":["trace[532370737] 'process raft request' (duration: 118.067817ms)","trace[532370737] 'compare' (duration: 21.460023ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:02:50.279584Z","caller":"traceutil/trace.go:171","msg":"trace[907579012] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"156.365114ms","start":"2026-07-08T05:02:50.123188Z","end":"2026-07-08T05:02:50.279553Z","steps":["trace[907579012] 'process raft request' (duration: 156.114064ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:02:51.049176Z","caller":"traceutil/trace.go:171","msg":"trace[1577832280] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"134.562788ms","start":"2026-07-08T05:02:50.914582Z","end":"2026-07-08T05:02:51.049145Z","steps":["trace[1577832280] 'process raft request' (duration: 134.38968ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:02:51.537498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.402809ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T05:02:51.537618Z","caller":"traceutil/trace.go:171","msg":"trace[710232266] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"483.710742ms","start":"2026-07-08T05:02:51.053874Z","end":"2026-07-08T05:02:51.537584Z","steps":["trace[710232266] 'process raft request' (duration: 211.014991ms)","trace[710232266] 'compare' (duration: 272.211841ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:02:51.537693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:02:51.053846Z","time spent":"483.819678ms","remote":"127.0.0.1:39378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T05:02:58.479417Z","caller":"traceutil/trace.go:171","msg":"trace[1115536658] linearizableReadLoop","detail":"{readStateIndex:510; appliedIndex:509; }","duration":"112.495252ms","start":"2026-07-08T05:02:58.366905Z","end":"2026-07-08T05:02:58.4794Z","steps":["trace[1115536658] 'read index received' (duration: 112.383107ms)","trace[1115536658] 'applied index is now lower than readState.Index' (duration: 111.345µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:02:58.479468Z","caller":"traceutil/trace.go:171","msg":"trace[824120834] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"122.979623ms","start":"2026-07-08T05:02:58.356469Z","end":"2026-07-08T05:02:58.479449Z","steps":["trace[824120834] 'process raft request' (duration: 122.836428ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:02:58.479614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.69636ms","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-08T05:02:58.479708Z","caller":"traceutil/trace.go:171","msg":"trace[1837515592] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:490; }","duration":"112.842005ms","start":"2026-07-08T05:02:58.366851Z","end":"2026-07-08T05:02:58.479693Z","steps":["trace[1837515592] 'agreement among raft nodes before linearized reading' (duration: 112.683479ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:03:02.767573Z","caller":"traceutil/trace.go:171","msg":"trace[1834849060] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:518; }","duration":"265.90622ms","start":"2026-07-08T05:03:02.501641Z","end":"2026-07-08T05:03:02.767547Z","steps":["trace[1834849060] 'read index received' (duration: 265.771405ms)","trace[1834849060] 'applied index is now lower than readState.Index' (duration: 133.825µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:03:02.767701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.045346ms","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-08T05:03:02.76774Z","caller":"traceutil/trace.go:171","msg":"trace[1365748442] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:498; }","duration":"266.121099ms","start":"2026-07-08T05:03:02.501608Z","end":"2026-07-08T05:03:02.767729Z","steps":["trace[1365748442] 'agreement among raft nodes before linearized reading' (duration: 266.039706ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:03:02.767784Z","caller":"traceutil/trace.go:171","msg":"trace[1726473891] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"270.711892ms","start":"2026-07-08T05:03:02.497033Z","end":"2026-07-08T05:03:02.767745Z","steps":["trace[1726473891] 'process raft request' (duration: 270.390779ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:03:08.897953Z","caller":"traceutil/trace.go:171","msg":"trace[539832994] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"153.090131ms","start":"2026-07-08T05:03:08.744838Z","end":"2026-07-08T05:03:08.897928Z","steps":["trace[539832994] 'process raft request' (duration: 141.345896ms)","trace[539832994] 'compare' (duration: 11.61587ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:03:08.898643Z","caller":"traceutil/trace.go:171","msg":"trace[1904502836] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"152.460209ms","start":"2026-07-08T05:03:08.746166Z","end":"2026-07-08T05:03:08.898626Z","steps":["trace[1904502836] 'process raft request' (duration: 152.302393ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:03:08.898639Z","caller":"traceutil/trace.go:171","msg":"trace[207841987] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:599; }","duration":"112.136513ms","start":"2026-07-08T05:03:08.786485Z","end":"2026-07-08T05:03:08.898621Z","steps":["trace[207841987] 'read index received' (duration: 99.822618ms)","trace[207841987] 'applied index is now lower than readState.Index' (duration: 12.313205ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:03:08.898748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.246538ms","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-08T05:03:08.898778Z","caller":"traceutil/trace.go:171","msg":"trace[1807721303] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:578; }","duration":"112.329381ms","start":"2026-07-08T05:03:08.786441Z","end":"2026-07-08T05:03:08.898771Z","steps":["trace[1807721303] 'agreement among raft nodes before linearized reading' (duration: 112.236007ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:03:08.898734Z","caller":"traceutil/trace.go:171","msg":"trace[907667656] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"153.31942ms","start":"2026-07-08T05:03:08.74539Z","end":"2026-07-08T05:03:08.898709Z","steps":["trace[907667656] 'process raft request' (duration: 152.983198ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:03:08.898845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.3996ms","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-08T05:03:08.898884Z","caller":"traceutil/trace.go:171","msg":"trace[1385032241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:578; }","duration":"102.449301ms","start":"2026-07-08T05:03:08.796422Z","end":"2026-07-08T05:03:08.898871Z","steps":["trace[1385032241] 'agreement among raft nodes before linearized reading' (duration: 102.368428ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:03:09.5297Z","caller":"traceutil/trace.go:171","msg":"trace[726321062] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"442.245941ms","start":"2026-07-08T05:03:09.08742Z","end":"2026-07-08T05:03:09.529666Z","steps":["trace[726321062] 'process raft request' (duration: 435.602309ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:03:09.529884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:09.0874Z","time spent":"442.399047ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59616,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T05:03:09.535573Z","caller":"traceutil/trace.go:171","msg":"trace[444642666] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:622; }","duration":"351.580159ms","start":"2026-07-08T05:03:09.183971Z","end":"2026-07-08T05:03:09.535551Z","steps":["trace[444642666] 'read index received' (duration: 339.003019ms)","trace[444642666] 'applied index is now lower than readState.Index' (duration: 12.57646ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:03:09.535637Z","caller":"traceutil/trace.go:171","msg":"trace[448634607] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"430.523651ms","start":"2026-07-08T05:03:09.10509Z","end":"2026-07-08T05:03:09.535613Z","steps":["trace[448634607] 'process raft request' (duration: 430.235651ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:03:09.535723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:09.105071Z","time spent":"430.611104ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80679,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:03:09.535739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.748485ms","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-08T05:03:09.535768Z","caller":"traceutil/trace.go:171","msg":"trace[1185305422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:599; }","duration":"351.823117ms","start":"2026-07-08T05:03:09.183936Z","end":"2026-07-08T05:03:09.53576Z","steps":["trace[1185305422] 'agreement among raft nodes before linearized reading' (duration: 351.692453ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:03:09.535798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:09.18392Z","time spent":"351.87285ms","remote":"127.0.0.1:39378","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":"info","ts":"2026-07-08T05:03:09.535975Z","caller":"traceutil/trace.go:171","msg":"trace[244481781] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"427.035469ms","start":"2026-07-08T05:03:09.108929Z","end":"2026-07-08T05:03:09.535964Z","steps":["trace[244481781] 'process raft request' (duration: 426.585793ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:03:09.536058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:09.10892Z","time spent":"427.086841ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T05:03:16.075415Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757021611837170047,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T05:03:16.430753Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.043857239s","expected-duration":"1s"} {"level":"info","ts":"2026-07-08T05:03:16.432275Z","caller":"traceutil/trace.go:171","msg":"trace[587927100] linearizableReadLoop","detail":"{readStateIndex:684; appliedIndex:683; }","duration":"857.610126ms","start":"2026-07-08T05:03:15.574628Z","end":"2026-07-08T05:03:16.432238Z","steps":["trace[587927100] 'read index received' (duration: 856.271613ms)","trace[587927100] 'applied index is now lower than readState.Index' (duration: 1.332363ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:03:16.432342Z","caller":"traceutil/trace.go:171","msg":"trace[1693048437] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"1.046299769s","start":"2026-07-08T05:03:15.386005Z","end":"2026-07-08T05:03:16.432305Z","steps":["trace[1693048437] 'process raft request' (duration: 1.04540562s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:03:16.432542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:15.385982Z","time spent":"1.046463134s","remote":"127.0.0.1:39192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:03:16.432587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.217474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T05:03:16.432598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"857.956548ms","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-08T05:03:16.43267Z","caller":"traceutil/trace.go:171","msg":"trace[1477038929] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:657; }","duration":"645.341357ms","start":"2026-07-08T05:03:15.787311Z","end":"2026-07-08T05:03:16.432652Z","steps":["trace[1477038929] 'agreement among raft nodes before linearized reading' (duration: 645.188172ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:03:16.43267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.907019ms","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-08T05:03:16.433173Z","caller":"traceutil/trace.go:171","msg":"trace[1884161770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:657; }","duration":"858.059951ms","start":"2026-07-08T05:03:15.574603Z","end":"2026-07-08T05:03:16.432663Z","steps":["trace[1884161770] 'agreement among raft nodes before linearized reading' (duration: 857.791543ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:03:16.433804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:15.787298Z","time spent":"645.40149ms","remote":"127.0.0.1:39054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-08T05:03:16.433816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:15.574534Z","time spent":"859.26504ms","remote":"127.0.0.1:39378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-08T05:03:16.435198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.114162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zhbxg\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-07-08T05:03:16.435298Z","caller":"traceutil/trace.go:171","msg":"trace[274542569] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zhbxg; range_end:; response_count:1; response_revision:657; }","duration":"236.717297ms","start":"2026-07-08T05:03:16.198541Z","end":"2026-07-08T05:03:16.435258Z","steps":["trace[274542569] 'agreement among raft nodes before linearized reading' (duration: 233.961927ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:03:16.435419Z","caller":"traceutil/trace.go:171","msg":"trace[2081821250] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:657; }","duration":"736.023843ms","start":"2026-07-08T05:03:15.696682Z","end":"2026-07-08T05:03:16.432706Z","steps":["trace[2081821250] 'agreement among raft nodes before linearized reading' (duration: 735.787005ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:03:16.435461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:15.696666Z","time spent":"738.782753ms","remote":"127.0.0.1:39378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T05:03:17.288713Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3757021611837170050,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-08T05:03:17.785568Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.317280113s","expected-duration":"1s"} {"level":"info","ts":"2026-07-08T05:03:17.786221Z","caller":"traceutil/trace.go:171","msg":"trace[1675119711] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"1.343217538s","start":"2026-07-08T05:03:16.442974Z","end":"2026-07-08T05:03:17.786191Z","steps":["trace[1675119711] 'process raft request' (duration: 1.342879677s)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:03:17.786193Z","caller":"traceutil/trace.go:171","msg":"trace[708245172] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"1.334821504s","start":"2026-07-08T05:03:16.451346Z","end":"2026-07-08T05:03:17.786168Z","steps":["trace[708245172] 'process raft request' (duration: 1.334733021s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:03:17.786362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:16.442922Z","time spent":"1.343353662s","remote":"127.0.0.1:39378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:03:17.786426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:16.451335Z","time spent":"1.334981079s","remote":"127.0.0.1:39268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:03:18.78822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000394394s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-08T05:03:18.788417Z","caller":"traceutil/trace.go:171","msg":"trace[1044578418] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00061112s","start":"2026-07-08T05:03:16.78778Z","end":"2026-07-08T05:03:18.788391Z","steps":["trace[1044578418] 'agreement among raft nodes before linearized reading' (duration: 2.000389293s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:03:18.788549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:16.7877Z","time spent":"2.000835608s","remote":"127.0.0.1:39082","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-08T05:03:19.433855Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.648104107s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-08T05:03:19.536072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.914276ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-08T05:03:19.536446Z","caller":"traceutil/trace.go:171","msg":"trace[822863595] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"3.046446724s","start":"2026-07-08T05:03:16.489982Z","end":"2026-07-08T05:03:19.536429Z","steps":["trace[822863595] 'process raft request' (duration: 2.944095895s)","trace[822863595] 'compare' (duration: 101.42896ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:03:19.536492Z","caller":"traceutil/trace.go:171","msg":"trace[1111483783] linearizableReadLoop","detail":"{readStateIndex:689; appliedIndex:685; }","duration":"2.748685748s","start":"2026-07-08T05:03:16.787797Z","end":"2026-07-08T05:03:19.536483Z","steps":["trace[1111483783] 'read index received' (duration: 998.048296ms)","trace[1111483783] 'applied index is now lower than readState.Index' (duration: 1.750635792s)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:03:19.536453Z","caller":"traceutil/trace.go:171","msg":"trace[1804754092] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"2.641691179s","start":"2026-07-08T05:03:16.894739Z","end":"2026-07-08T05:03:19.53643Z","steps":["trace[1804754092] 'process raft request' (duration: 2.641444681s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:03:19.536512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:16.489958Z","time spent":"3.046533127s","remote":"127.0.0.1:39340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-08T05:03:19.536561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:16.894706Z","time spent":"2.641828303s","remote":"127.0.0.1:39378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T05:03:20.387063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"850.767154ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-08T05:03:20.387194Z","caller":"traceutil/trace.go:171","msg":"trace[1826015376] linearizableReadLoop","detail":"{readStateIndex:690; appliedIndex:689; }","duration":"850.64231ms","start":"2026-07-08T05:03:19.536532Z","end":"2026-07-08T05:03:20.387174Z","steps":["trace[1826015376] 'read index received' (duration: 48.212µs)","trace[1826015376] 'applied index is now lower than readState.Index' (duration: 850.591928ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:03:20.387667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.915348677s","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-08T05:03:20.387715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.598753988s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T05:03:20.387684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.439636871s","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-07-08T05:03:20.387731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.43194564s","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-08T05:03:20.387763Z","caller":"traceutil/trace.go:171","msg":"trace[1776727122] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:662; }","duration":"1.598811349s","start":"2026-07-08T05:03:18.788936Z","end":"2026-07-08T05:03:20.387747Z","steps":["trace[1776727122] 'agreement among raft nodes before linearized reading' (duration: 1.598710296s)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:03:20.387758Z","caller":"traceutil/trace.go:171","msg":"trace[2075433429] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:662; }","duration":"1.915487641s","start":"2026-07-08T05:03:18.472242Z","end":"2026-07-08T05:03:20.38773Z","steps":["trace[2075433429] 'agreement among raft nodes before linearized reading' (duration: 1.915223322s)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:03:20.387792Z","caller":"traceutil/trace.go:171","msg":"trace[792846786] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:662; }","duration":"3.432085004s","start":"2026-07-08T05:03:16.955692Z","end":"2026-07-08T05:03:20.387777Z","steps":["trace[792846786] 'agreement among raft nodes before linearized reading' (duration: 3.431894578s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:03:20.387801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:18.788875Z","time spent":"1.598918273s","remote":"127.0.0.1:39054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-08T05:03:20.387807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:18.472193Z","time spent":"1.915605485s","remote":"127.0.0.1:39378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-08T05:03:20.3878Z","caller":"traceutil/trace.go:171","msg":"trace[2078318584] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:662; }","duration":"3.439801006s","start":"2026-07-08T05:03:16.947964Z","end":"2026-07-08T05:03:20.387765Z","steps":["trace[2078318584] 'agreement among raft nodes before linearized reading' (duration: 3.439421584s)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:03:20.387822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:16.955675Z","time spent":"3.432140846s","remote":"127.0.0.1:39378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-08T05:03:20.38786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:16.947943Z","time spent":"3.439905969s","remote":"127.0.0.1:39378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-08T05:03:20.387869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.402564ms","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-07-08T05:03:20.387728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"848.777431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-07-08T05:03:20.387913Z","caller":"traceutil/trace.go:171","msg":"trace[1878042920] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:662; }","duration":"849.019708ms","start":"2026-07-08T05:03:19.538887Z","end":"2026-07-08T05:03:20.387907Z","steps":["trace[1878042920] 'agreement among raft nodes before linearized reading' (duration: 848.76322ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:03:20.387935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:19.538875Z","time spent":"849.053269ms","remote":"127.0.0.1:39282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"info","ts":"2026-07-08T05:03:20.387929Z","caller":"traceutil/trace.go:171","msg":"trace[23413958] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:662; }","duration":"597.507746ms","start":"2026-07-08T05:03:19.790398Z","end":"2026-07-08T05:03:20.387906Z","steps":["trace[23413958] 'agreement among raft nodes before linearized reading' (duration: 597.377432ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:03:20.387976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T05:03:19.79037Z","time spent":"597.594239ms","remote":"127.0.0.1:39378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-08T05:03:21.9411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.890708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:03:21.941442Z","caller":"traceutil/trace.go:171","msg":"trace[1491794886] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:676; }","duration":"153.27904ms","start":"2026-07-08T05:03:21.788142Z","end":"2026-07-08T05:03:21.941421Z","steps":["trace[1491794886] 'range keys from in-memory index tree' (duration: 152.762284ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:03:22.37782Z","caller":"traceutil/trace.go:171","msg":"trace[5541057] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"144.74391ms","start":"2026-07-08T05:03:22.233054Z","end":"2026-07-08T05:03:22.377798Z","steps":["trace[5541057] 'process raft request' (duration: 137.835078ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:03:22.845823Z","caller":"traceutil/trace.go:171","msg":"trace[1279578471] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"167.493371ms","start":"2026-07-08T05:03:22.678288Z","end":"2026-07-08T05:03:22.845781Z","steps":["trace[1279578471] 'process raft request' (duration: 118.231186ms)","trace[1279578471] 'compare' (duration: 48.982876ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:03:33.529274Z","caller":"traceutil/trace.go:171","msg":"trace[2002215575] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"180.555858ms","start":"2026-07-08T05:03:33.348694Z","end":"2026-07-08T05:03:33.52925Z","steps":["trace[2002215575] 'process raft request' (duration: 180.402744ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:03:36.5101Z","caller":"traceutil/trace.go:171","msg":"trace[1535983612] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"190.674612ms","start":"2026-07-08T05:03:36.319405Z","end":"2026-07-08T05:03:36.51008Z","steps":["trace[1535983612] 'process raft request' (duration: 190.183029ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:04:27.171093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.128076ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T05:04:27.171375Z","caller":"traceutil/trace.go:171","msg":"trace[1236303384] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"271.977353ms","start":"2026-07-08T05:04:26.89934Z","end":"2026-07-08T05:04:27.171317Z","steps":["trace[1236303384] 'process raft request' (duration: 120.538731ms)","trace[1236303384] 'compare' (duration: 150.672138ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:04:27.171526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.228641ms","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-08T05:04:27.171585Z","caller":"traceutil/trace.go:171","msg":"trace[557945094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1124; }","duration":"269.314092ms","start":"2026-07-08T05:04:26.902258Z","end":"2026-07-08T05:04:27.171572Z","steps":["trace[557945094] 'agreement among raft nodes before linearized reading' (duration: 269.167329ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:04:27.171234Z","caller":"traceutil/trace.go:171","msg":"trace[192307195] linearizableReadLoop","detail":"{readStateIndex:1169; appliedIndex:1168; }","duration":"268.928545ms","start":"2026-07-08T05:04:26.902288Z","end":"2026-07-08T05:04:27.171217Z","steps":["trace[192307195] 'read index received' (duration: 117.545334ms)","trace[192307195] 'applied index is now lower than readState.Index' (duration: 151.381951ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T05:04:27.172237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.114504ms","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-08T05:04:27.172293Z","caller":"traceutil/trace.go:171","msg":"trace[333701130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1124; }","duration":"226.202286ms","start":"2026-07-08T05:04:26.946073Z","end":"2026-07-08T05:04:27.172275Z","steps":["trace[333701130] 'agreement among raft nodes before linearized reading' (duration: 226.010032ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:04:27.172422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.75528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T05:04:27.172599Z","caller":"traceutil/trace.go:171","msg":"trace[1451657281] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1124; }","duration":"167.054235ms","start":"2026-07-08T05:04:27.005491Z","end":"2026-07-08T05:04:27.172545Z","steps":["trace[1451657281] 'agreement among raft nodes before linearized reading' (duration: 166.704529ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:04:33.875189Z","caller":"traceutil/trace.go:171","msg":"trace[840394955] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"102.870505ms","start":"2026-07-08T05:04:33.772286Z","end":"2026-07-08T05:04:33.875156Z","steps":["trace[840394955] 'process raft request' (duration: 102.631121ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:04:41.465477Z","caller":"traceutil/trace.go:171","msg":"trace[466433492] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"131.522993ms","start":"2026-07-08T05:04:41.333927Z","end":"2026-07-08T05:04:41.46545Z","steps":["trace[466433492] 'process raft request' (duration: 131.39171ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:04:42.122022Z","caller":"traceutil/trace.go:171","msg":"trace[1251253350] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"187.33982ms","start":"2026-07-08T05:04:41.934654Z","end":"2026-07-08T05:04:42.121993Z","steps":["trace[1251253350] 'process raft request' (duration: 187.170947ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:04:44.12758Z","caller":"traceutil/trace.go:171","msg":"trace[74812477] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"107.506936ms","start":"2026-07-08T05:04:44.020043Z","end":"2026-07-08T05:04:44.12755Z","steps":["trace[74812477] 'process raft request' (duration: 42.322931ms)","trace[74812477] 'compare' (duration: 65.045963ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:04:44.445478Z","caller":"traceutil/trace.go:171","msg":"trace[1450625706] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"278.942294ms","start":"2026-07-08T05:04:44.166504Z","end":"2026-07-08T05:04:44.445446Z","steps":["trace[1450625706] 'process raft request' (duration: 207.659704ms)","trace[1450625706] 'compare' (duration: 71.154548ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:04:47.790631Z","caller":"traceutil/trace.go:171","msg":"trace[1239292084] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"131.287245ms","start":"2026-07-08T05:04:47.659324Z","end":"2026-07-08T05:04:47.790611Z","steps":["trace[1239292084] 'process raft request' (duration: 124.137193ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:04:52.680341Z","caller":"traceutil/trace.go:171","msg":"trace[1654236524] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"163.218038ms","start":"2026-07-08T05:04:52.517096Z","end":"2026-07-08T05:04:52.680314Z","steps":["trace[1654236524] 'process raft request' (duration: 163.068156ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:05:09.848884Z","caller":"traceutil/trace.go:171","msg":"trace[1534672815] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"106.820946ms","start":"2026-07-08T05:05:09.742014Z","end":"2026-07-08T05:05:09.848835Z","steps":["trace[1534672815] 'process raft request' (duration: 53.069768ms)","trace[1534672815] 'compare' (duration: 53.508324ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:05:28.589062Z","caller":"traceutil/trace.go:171","msg":"trace[1885193052] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"128.034152ms","start":"2026-07-08T05:05:28.460998Z","end":"2026-07-08T05:05:28.589032Z","steps":["trace[1885193052] 'process raft request' (duration: 127.801299ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T05:05:35.113425Z","caller":"traceutil/trace.go:171","msg":"trace[221036367] linearizableReadLoop","detail":"{readStateIndex:1450; appliedIndex:1449; }","duration":"118.685804ms","start":"2026-07-08T05:05:34.994713Z","end":"2026-07-08T05:05:35.113399Z","steps":["trace[221036367] 'read index received' (duration: 118.533531ms)","trace[221036367] 'applied index is now lower than readState.Index' (duration: 151.323µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T05:05:35.113543Z","caller":"traceutil/trace.go:171","msg":"trace[105292806] transaction","detail":"{read_only:false; response_revision:1389; number_of_response:1; }","duration":"130.086518ms","start":"2026-07-08T05:05:34.983409Z","end":"2026-07-08T05:05:35.113496Z","steps":["trace[105292806] 'process raft request' (duration: 129.834834ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T05:05:35.11364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.903707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-envoy-gateway-role\" ","response":"range_response_count:1 size:1944"} {"level":"info","ts":"2026-07-08T05:05:35.113675Z","caller":"traceutil/trace.go:171","msg":"trace[891824771] range","detail":"{range_begin:/registry/clusterroles/envoy-gateway-gateway-helm-envoy-gateway-role; range_end:; response_count:1; response_revision:1389; }","duration":"118.976097ms","start":"2026-07-08T05:05:34.994688Z","end":"2026-07-08T05:05:35.113664Z","steps":["trace[891824771] 'agreement among raft nodes before linearized reading' (duration: 118.831755ms)"],"step_count":1}