{"level":"warn","ts":"2026-08-20T01:07:53.879112Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-20T01:07:53.879199Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-20T01:07:53.879271Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-20T01:07:53.87929Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-08-20T01:07:53.879313Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-20T01:07:53.880109Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-08-20T01:07:53.880204Z","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.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-20T01:07:53.923356Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"42.915859ms"} {"level":"info","ts":"2026-08-20T01:07:53.943879Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-08-20T01:07:53.943979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-08-20T01:07:53.944034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-08-20T01:07:53.944058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-20T01:07:53.944083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-08-20T01:07:53.944162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-08-20T01:07:53.978084Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-20T01:07:53.986276Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-20T01:07:53.999833Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-20T01:07:54.004146Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-20T01:07:54.005404Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-20T01:07:54.005438Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-20T01:07:54.006048Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-20T01:07:54.007029Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-20T01:07:54.016088Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-20T01:07:54.016344Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-08-20T01:07:54.01641Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-08-20T01:07:54.016403Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-20T01:07:54.01645Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-20T01:07:54.035875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-08-20T01:07:54.036114Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-08-20T01:07:54.045003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-08-20T01:07:54.045076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-20T01:07:54.045114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-08-20T01:07:54.045142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-08-20T01:07:54.045158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-08-20T01:07:54.045179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-08-20T01:07:54.045197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-08-20T01:07:54.057524Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T01:07:54.058939Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-08-20T01:07:54.060161Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-20T01:07:54.060531Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-20T01:07:54.062321Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-20T01:07:54.062345Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-20T01:07:54.065028Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-20T01:07:54.065414Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"info","ts":"2026-08-20T01:07:54.077514Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T01:07:54.077637Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T01:07:54.077668Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T01:07:57.759588Z","caller":"traceutil/trace.go:171","msg":"trace[1476812] transaction","detail":"{read_only:false; response_revision:183; number_of_response:1; }","duration":"109.253401ms","start":"2026-08-20T01:07:57.650305Z","end":"2026-08-20T01:07:57.759559Z","steps":["trace[1476812] 'process raft request' (duration: 67.620303ms)","trace[1476812] 'compare' (duration: 41.485595ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:07:58.095176Z","caller":"traceutil/trace.go:171","msg":"trace[2057924079] transaction","detail":"{read_only:false; response_revision:188; number_of_response:1; }","duration":"127.801977ms","start":"2026-08-20T01:07:57.967348Z","end":"2026-08-20T01:07:58.09515Z","steps":["trace[2057924079] 'process raft request' (duration: 70.569925ms)","trace[2057924079] 'compare' (duration: 57.123159ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:07:58.509283Z","caller":"traceutil/trace.go:171","msg":"trace[1011059996] transaction","detail":"{read_only:false; response_revision:197; number_of_response:1; }","duration":"117.917314ms","start":"2026-08-20T01:07:58.391341Z","end":"2026-08-20T01:07:58.509258Z","steps":["trace[1011059996] 'process raft request' (duration: 117.870863ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:07:58.509363Z","caller":"traceutil/trace.go:171","msg":"trace[1298885049] transaction","detail":"{read_only:false; response_revision:196; number_of_response:1; }","duration":"118.018717ms","start":"2026-08-20T01:07:58.391311Z","end":"2026-08-20T01:07:58.50933Z","steps":["trace[1298885049] 'process raft request' (duration: 117.72209ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:07:58.63516Z","caller":"traceutil/trace.go:171","msg":"trace[1375440294] linearizableReadLoop","detail":"{readStateIndex:204; appliedIndex:203; }","duration":"116.569262ms","start":"2026-08-20T01:07:58.518568Z","end":"2026-08-20T01:07:58.635137Z","steps":["trace[1375440294] 'read index received' (duration: 82.264286ms)","trace[1375440294] 'applied index is now lower than readState.Index' (duration: 34.303886ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:07:58.635426Z","caller":"traceutil/trace.go:171","msg":"trace[584303096] transaction","detail":"{read_only:false; response_revision:199; number_of_response:1; }","duration":"121.295305ms","start":"2026-08-20T01:07:58.514099Z","end":"2026-08-20T01:07:58.635394Z","steps":["trace[584303096] 'process raft request' (duration: 86.678761ms)","trace[584303096] 'compare' (duration: 34.242235ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:07:58.635526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.867959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:07:58.635718Z","caller":"traceutil/trace.go:171","msg":"trace[845893914] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:0; response_revision:199; }","duration":"117.133345ms","start":"2026-08-20T01:07:58.518525Z","end":"2026-08-20T01:07:58.635658Z","steps":["trace[845893914] 'agreement among raft nodes before linearized reading' (duration: 116.760056ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:05.25756Z","caller":"traceutil/trace.go:171","msg":"trace[1584816833] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"107.055835ms","start":"2026-08-20T01:08:05.150431Z","end":"2026-08-20T01:08:05.257487Z","steps":["trace[1584816833] 'process raft request' (duration: 100.971697ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:05.257782Z","caller":"traceutil/trace.go:171","msg":"trace[328724679] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"107.32233ms","start":"2026-08-20T01:08:05.150443Z","end":"2026-08-20T01:08:05.257765Z","steps":["trace[328724679] 'process raft request' (duration: 106.951201ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:05.258061Z","caller":"traceutil/trace.go:171","msg":"trace[24421924] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"105.770883ms","start":"2026-08-20T01:08:05.152278Z","end":"2026-08-20T01:08:05.258049Z","steps":["trace[24421924] 'process raft request' (duration: 105.368113ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:20.534366Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471728419230833570,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T01:08:20.580099Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.364523947s","expected-duration":"1s"} {"level":"info","ts":"2026-08-20T01:08:20.580742Z","caller":"traceutil/trace.go:171","msg":"trace[876672971] linearizableReadLoop","detail":"{readStateIndex:414; appliedIndex:413; }","duration":"547.227444ms","start":"2026-08-20T01:08:20.033467Z","end":"2026-08-20T01:08:20.580695Z","steps":["trace[876672971] 'read index received' (duration: 546.804834ms)","trace[876672971] 'applied index is now lower than readState.Index' (duration: 420.22µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:08:20.58087Z","caller":"traceutil/trace.go:171","msg":"trace[2018586053] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"1.365357329s","start":"2026-08-20T01:08:19.215474Z","end":"2026-08-20T01:08:20.580831Z","steps":["trace[2018586053] 'process raft request' (duration: 1.364977609s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:20.581201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.55914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4056"} {"level":"warn","ts":"2026-08-20T01:08:20.581236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.657025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-20T01:08:20.581272Z","caller":"traceutil/trace.go:171","msg":"trace[2003447056] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:398; }","duration":"517.687553ms","start":"2026-08-20T01:08:20.063568Z","end":"2026-08-20T01:08:20.581255Z","steps":["trace[2003447056] 'agreement among raft nodes before linearized reading' (duration: 517.475348ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:20.581328Z","caller":"traceutil/trace.go:171","msg":"trace[1045382135] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:398; }","duration":"547.885921ms","start":"2026-08-20T01:08:20.033416Z","end":"2026-08-20T01:08:20.581302Z","steps":["trace[1045382135] 'agreement among raft nodes before linearized reading' (duration: 547.497491ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:20.581334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:20.063519Z","time spent":"517.802975ms","remote":"127.0.0.1:49828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4080,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"warn","ts":"2026-08-20T01:08:20.581402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:20.033394Z","time spent":"547.990013ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-20T01:08:20.58148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.544668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-08-20T01:08:20.581546Z","caller":"traceutil/trace.go:171","msg":"trace[1291982072] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:398; }","duration":"395.651489ms","start":"2026-08-20T01:08:20.185879Z","end":"2026-08-20T01:08:20.58153Z","steps":["trace[1291982072] 'agreement among raft nodes before linearized reading' (duration: 395.491946ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:20.581581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:20.185867Z","time spent":"395.706992ms","remote":"127.0.0.1:49650","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-08-20T01:08:20.581594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.583742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:08:20.581655Z","caller":"traceutil/trace.go:171","msg":"trace[1416193524] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:398; }","duration":"398.663604ms","start":"2026-08-20T01:08:20.182969Z","end":"2026-08-20T01:08:20.581633Z","steps":["trace[1416193524] 'agreement among raft nodes before linearized reading' (duration: 398.550031ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:20.58172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:20.182957Z","time spent":"398.750636ms","remote":"127.0.0.1:49402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-20T01:08:20.581846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:19.215454Z","time spent":"1.365570324s","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T01:08:20.760411Z","caller":"traceutil/trace.go:171","msg":"trace[1707463504] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"174.867382ms","start":"2026-08-20T01:08:20.58547Z","end":"2026-08-20T01:08:20.760338Z","steps":["trace[1707463504] 'process raft request' (duration: 144.827767ms)","trace[1707463504] 'compare' (duration: 29.908571ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:08:20.816759Z","caller":"traceutil/trace.go:171","msg":"trace[1546203323] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"230.808568ms","start":"2026-08-20T01:08:20.585914Z","end":"2026-08-20T01:08:20.816723Z","steps":["trace[1546203323] 'process raft request' (duration: 230.650974ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:20.816891Z","caller":"traceutil/trace.go:171","msg":"trace[916859532] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"223.009284ms","start":"2026-08-20T01:08:20.593855Z","end":"2026-08-20T01:08:20.816865Z","steps":["trace[916859532] 'process raft request' (duration: 222.809689ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:20.816977Z","caller":"traceutil/trace.go:171","msg":"trace[646088602] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"222.105961ms","start":"2026-08-20T01:08:20.594854Z","end":"2026-08-20T01:08:20.81696Z","steps":["trace[646088602] 'process raft request' (duration: 221.960487ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:32.486628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.602985ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-20T01:08:32.486734Z","caller":"traceutil/trace.go:171","msg":"trace[2009897620] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"133.980414ms","start":"2026-08-20T01:08:32.352743Z","end":"2026-08-20T01:08:32.486724Z","steps":["trace[2009897620] 'process raft request' (duration: 133.953713ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:32.486827Z","caller":"traceutil/trace.go:171","msg":"trace[510188321] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"134.177059ms","start":"2026-08-20T01:08:32.352644Z","end":"2026-08-20T01:08:32.486821Z","steps":["trace[510188321] 'process raft request' (duration: 17.236694ms)","trace[510188321] 'compare' (duration: 116.488903ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:08:32.648021Z","caller":"traceutil/trace.go:171","msg":"trace[1747752613] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"102.782068ms","start":"2026-08-20T01:08:32.545217Z","end":"2026-08-20T01:08:32.647999Z","steps":["trace[1747752613] 'process raft request' (duration: 92.172981ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:32.988576Z","caller":"traceutil/trace.go:171","msg":"trace[505394452] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"277.717542ms","start":"2026-08-20T01:08:32.710784Z","end":"2026-08-20T01:08:32.988502Z","steps":["trace[505394452] 'process raft request' (duration: 277.604649ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:33.032913Z","caller":"traceutil/trace.go:171","msg":"trace[966146433] linearizableReadLoop","detail":"{readStateIndex:485; appliedIndex:484; }","duration":"208.289706ms","start":"2026-08-20T01:08:32.824596Z","end":"2026-08-20T01:08:33.032886Z","steps":["trace[966146433] 'read index received' (duration: 163.940378ms)","trace[966146433] 'applied index is now lower than readState.Index' (duration: 44.347798ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:08:33.033025Z","caller":"traceutil/trace.go:171","msg":"trace[1722346949] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"322.120352ms","start":"2026-08-20T01:08:32.710875Z","end":"2026-08-20T01:08:33.032995Z","steps":["trace[1722346949] 'process raft request' (duration: 321.866874ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:33.033112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.493562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-20T01:08:33.033159Z","caller":"traceutil/trace.go:171","msg":"trace[898879877] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:466; }","duration":"208.634465ms","start":"2026-08-20T01:08:32.824513Z","end":"2026-08-20T01:08:33.033147Z","steps":["trace[898879877] 'agreement among raft nodes before linearized reading' (duration: 208.530563ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:33.033165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:32.710866Z","time spent":"322.226284ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T01:08:33.114111Z","caller":"traceutil/trace.go:171","msg":"trace[97648066] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"117.993484ms","start":"2026-08-20T01:08:32.996083Z","end":"2026-08-20T01:08:33.114077Z","steps":["trace[97648066] 'process raft request' (duration: 112.908937ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:33.114151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.055583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-20T01:08:33.114188Z","caller":"traceutil/trace.go:171","msg":"trace[49348142] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"118.010296ms","start":"2026-08-20T01:08:32.996157Z","end":"2026-08-20T01:08:33.114167Z","steps":["trace[49348142] 'process raft request' (duration: 117.857201ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:33.114272Z","caller":"traceutil/trace.go:171","msg":"trace[1308836452] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:468; }","duration":"233.164285ms","start":"2026-08-20T01:08:32.881042Z","end":"2026-08-20T01:08:33.114207Z","steps":["trace[1308836452] 'agreement among raft nodes before linearized reading' (duration: 233.020541ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:33.114482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.608985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-20T01:08:33.114529Z","caller":"traceutil/trace.go:171","msg":"trace[413416448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:468; }","duration":"175.742359ms","start":"2026-08-20T01:08:32.938775Z","end":"2026-08-20T01:08:33.114517Z","steps":["trace[413416448] 'agreement among raft nodes before linearized reading' (duration: 175.548164ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:33.244783Z","caller":"traceutil/trace.go:171","msg":"trace[571195457] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"125.480954ms","start":"2026-08-20T01:08:33.119262Z","end":"2026-08-20T01:08:33.244743Z","steps":["trace[571195457] 'process raft request' (duration: 94.751989ms)","trace[571195457] 'compare' (duration: 30.53111ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:08:33.244971Z","caller":"traceutil/trace.go:171","msg":"trace[1463083751] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"124.101598ms","start":"2026-08-20T01:08:33.120834Z","end":"2026-08-20T01:08:33.244936Z","steps":["trace[1463083751] 'process raft request' (duration: 123.827302ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:33.245251Z","caller":"traceutil/trace.go:171","msg":"trace[1914953613] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:488; }","duration":"118.315403ms","start":"2026-08-20T01:08:33.126907Z","end":"2026-08-20T01:08:33.245222Z","steps":["trace[1914953613] 'read index received' (duration: 26.688753ms)","trace[1914953613] 'applied index is now lower than readState.Index' (duration: 91.622909ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:08:33.245433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.512897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:08:33.245491Z","caller":"traceutil/trace.go:171","msg":"trace[1209954008] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:472; }","duration":"118.60925ms","start":"2026-08-20T01:08:33.126865Z","end":"2026-08-20T01:08:33.245475Z","steps":["trace[1209954008] 'agreement among raft nodes before linearized reading' (duration: 118.498027ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:33.483358Z","caller":"traceutil/trace.go:171","msg":"trace[1659522660] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"135.793674ms","start":"2026-08-20T01:08:33.347537Z","end":"2026-08-20T01:08:33.483331Z","steps":["trace[1659522660] 'process raft request' (duration: 101.815477ms)","trace[1659522660] 'compare' (duration: 33.865564ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:08:33.53445Z","caller":"traceutil/trace.go:171","msg":"trace[545352540] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"186.174215ms","start":"2026-08-20T01:08:33.348248Z","end":"2026-08-20T01:08:33.534422Z","steps":["trace[545352540] 'process raft request' (duration: 185.888806ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:33.534451Z","caller":"traceutil/trace.go:171","msg":"trace[100058142] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"184.736438ms","start":"2026-08-20T01:08:33.349688Z","end":"2026-08-20T01:08:33.534424Z","steps":["trace[100058142] 'process raft request' (duration: 184.621214ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:33.5346Z","caller":"traceutil/trace.go:171","msg":"trace[22872305] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"183.283852ms","start":"2026-08-20T01:08:33.351298Z","end":"2026-08-20T01:08:33.534581Z","steps":["trace[22872305] 'process raft request' (duration: 183.070436ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:35.252732Z","caller":"traceutil/trace.go:171","msg":"trace[99616696] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"149.369045ms","start":"2026-08-20T01:08:35.103324Z","end":"2026-08-20T01:08:35.252693Z","steps":["trace[99616696] 'process raft request' (duration: 129.139264ms)","trace[99616696] 'compare' (duration: 20.004505ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:08:35.252855Z","caller":"traceutil/trace.go:171","msg":"trace[1763816431] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"145.349894ms","start":"2026-08-20T01:08:35.107481Z","end":"2026-08-20T01:08:35.252831Z","steps":["trace[1763816431] 'process raft request' (duration: 145.143309ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:35.252887Z","caller":"traceutil/trace.go:171","msg":"trace[1775085317] linearizableReadLoop","detail":"{readStateIndex:544; appliedIndex:541; }","duration":"130.546709ms","start":"2026-08-20T01:08:35.122316Z","end":"2026-08-20T01:08:35.252862Z","steps":["trace[1775085317] 'read index received' (duration: 10.68762ms)","trace[1775085317] 'applied index is now lower than readState.Index' (duration: 119.856389ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:08:35.253028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.699083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-20T01:08:35.253074Z","caller":"traceutil/trace.go:171","msg":"trace[1751066568] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:524; }","duration":"130.792906ms","start":"2026-08-20T01:08:35.122268Z","end":"2026-08-20T01:08:35.253061Z","steps":["trace[1751066568] 'agreement among raft nodes before linearized reading' (duration: 130.692853ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:35.272387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.687332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-20T01:08:35.272484Z","caller":"traceutil/trace.go:171","msg":"trace[2055845401] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:525; }","duration":"111.833876ms","start":"2026-08-20T01:08:35.16063Z","end":"2026-08-20T01:08:35.272463Z","steps":["trace[2055845401] 'agreement among raft nodes before linearized reading' (duration: 111.654972ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:36.15062Z","caller":"traceutil/trace.go:171","msg":"trace[567030742] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"168.182694ms","start":"2026-08-20T01:08:35.982408Z","end":"2026-08-20T01:08:36.15059Z","steps":["trace[567030742] 'process raft request' (duration: 137.349754ms)","trace[567030742] 'compare' (duration: 30.493822ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:08:36.151361Z","caller":"traceutil/trace.go:171","msg":"trace[1911205491] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"166.602505ms","start":"2026-08-20T01:08:35.984735Z","end":"2026-08-20T01:08:36.151338Z","steps":["trace[1911205491] 'process raft request' (duration: 166.199235ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:36.19565Z","caller":"traceutil/trace.go:171","msg":"trace[1061265219] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"131.922998ms","start":"2026-08-20T01:08:36.063189Z","end":"2026-08-20T01:08:36.195112Z","steps":["trace[1061265219] 'process raft request' (duration: 131.762274ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:37.000085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.742571ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T01:08:37.00018Z","caller":"traceutil/trace.go:171","msg":"trace[1247521730] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"761.784295ms","start":"2026-08-20T01:08:36.238379Z","end":"2026-08-20T01:08:37.000163Z","steps":["trace[1247521730] 'process raft request' (duration: 105.88612ms)","trace[1247521730] 'compare' (duration: 655.590277ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:08:37.000235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:36.238359Z","time spent":"761.850146ms","remote":"127.0.0.1:49436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74745,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T01:08:37.595666Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471728419230833798,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T01:08:38.096431Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471728419230833798,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T01:08:38.363931Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.019748854s","expected-duration":"1s"} {"level":"info","ts":"2026-08-20T01:08:38.448892Z","caller":"traceutil/trace.go:171","msg":"trace[1470583374] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"2.209578771s","start":"2026-08-20T01:08:36.239285Z","end":"2026-08-20T01:08:38.448863Z","steps":["trace[1470583374] 'process raft request' (duration: 2.12511683s)","trace[1470583374] 'compare' (duration: 83.924218ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:08:38.449268Z","caller":"traceutil/trace.go:171","msg":"trace[1414768615] linearizableReadLoop","detail":"{readStateIndex:584; appliedIndex:580; }","duration":"1.354334569s","start":"2026-08-20T01:08:37.0949Z","end":"2026-08-20T01:08:38.449235Z","steps":["trace[1414768615] 'read index received' (duration: 1.269395516s)","trace[1414768615] 'applied index is now lower than readState.Index' (duration: 84.937953ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:08:38.449411Z","caller":"traceutil/trace.go:171","msg":"trace[570628460] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"1.438110421s","start":"2026-08-20T01:08:37.011288Z","end":"2026-08-20T01:08:38.449399Z","steps":["trace[570628460] 'process raft request' (duration: 1.437781462s)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:38.449323Z","caller":"traceutil/trace.go:171","msg":"trace[95459539] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"2.202304207s","start":"2026-08-20T01:08:36.246944Z","end":"2026-08-20T01:08:38.449248Z","steps":["trace[95459539] 'process raft request' (duration: 2.201867756s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:38.449726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.266441013s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:08:38.449776Z","caller":"traceutil/trace.go:171","msg":"trace[668779798] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:563; }","duration":"1.266529436s","start":"2026-08-20T01:08:37.183233Z","end":"2026-08-20T01:08:38.449763Z","steps":["trace[668779798] 'agreement among raft nodes before linearized reading' (duration: 1.266453144s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:38.449808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:37.183206Z","time spent":"1.266595977s","remote":"127.0.0.1:49402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-20T01:08:38.449951Z","caller":"traceutil/trace.go:171","msg":"trace[980983533] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"1.398536939s","start":"2026-08-20T01:08:37.051382Z","end":"2026-08-20T01:08:38.449919Z","steps":["trace[980983533] 'process raft request' (duration: 1.39779676s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:38.449976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.586297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-08-20T01:08:38.450038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.138086841s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-08-20T01:08:38.450073Z","caller":"traceutil/trace.go:171","msg":"trace[1827383087] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:563; }","duration":"1.138124942s","start":"2026-08-20T01:08:37.311937Z","end":"2026-08-20T01:08:38.450062Z","steps":["trace[1827383087] 'agreement among raft nodes before linearized reading' (duration: 1.13805371s)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:38.450088Z","caller":"traceutil/trace.go:171","msg":"trace[1241107728] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:563; }","duration":"133.742071ms","start":"2026-08-20T01:08:38.316312Z","end":"2026-08-20T01:08:38.450054Z","steps":["trace[1241107728] 'agreement among raft nodes before linearized reading' (duration: 133.529696ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:38.450127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:37.051345Z","time spent":"1.398691863s","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T01:08:38.450142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.355244732s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-20T01:08:38.450187Z","caller":"traceutil/trace.go:171","msg":"trace[1766422855] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:563; }","duration":"1.355332495s","start":"2026-08-20T01:08:37.094843Z","end":"2026-08-20T01:08:38.450176Z","steps":["trace[1766422855] 'agreement among raft nodes before linearized reading' (duration: 1.35513761s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:38.450229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:37.094797Z","time spent":"1.355426047s","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-20T01:08:38.450419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.140006041s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-20T01:08:38.450469Z","caller":"traceutil/trace.go:171","msg":"trace[202251553] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:563; }","duration":"1.140085932s","start":"2026-08-20T01:08:37.31037Z","end":"2026-08-20T01:08:38.450456Z","steps":["trace[202251553] 'agreement among raft nodes before linearized reading' (duration: 1.139983739s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:38.450512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:37.310347Z","time spent":"1.140157944s","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-20T01:08:38.450621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.140062112s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-20T01:08:38.450663Z","caller":"traceutil/trace.go:171","msg":"trace[1690868254] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:563; }","duration":"1.140159814s","start":"2026-08-20T01:08:37.310493Z","end":"2026-08-20T01:08:38.450653Z","steps":["trace[1690868254] 'agreement among raft nodes before linearized reading' (duration: 1.140088252s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:38.450697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:37.310488Z","time spent":"1.140202086s","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-20T01:08:38.449556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:37.011266Z","time spent":"1.438179993s","remote":"127.0.0.1:49436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20842,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T01:08:38.449602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:36.239279Z","time spent":"2.209701264s","remote":"127.0.0.1:49436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T01:08:38.451544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:36.246915Z","time spent":"2.203011025s","remote":"127.0.0.1:49436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T01:08:38.450111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:37.311836Z","time spent":"1.138267466s","remote":"127.0.0.1:49650","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-08-20T01:08:38.616253Z","caller":"traceutil/trace.go:171","msg":"trace[279054215] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"148.64128ms","start":"2026-08-20T01:08:38.467578Z","end":"2026-08-20T01:08:38.61622Z","steps":["trace[279054215] 'process raft request' (duration: 81.813155ms)","trace[279054215] 'compare' (duration: 66.6549ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:08:38.616472Z","caller":"traceutil/trace.go:171","msg":"trace[1408740582] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:589; }","duration":"143.50334ms","start":"2026-08-20T01:08:38.47293Z","end":"2026-08-20T01:08:38.616434Z","steps":["trace[1408740582] 'read index received' (duration: 6.139366ms)","trace[1408740582] 'applied index is now lower than readState.Index' (duration: 137.362744ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:08:38.616724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.759956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:08:38.616775Z","caller":"traceutil/trace.go:171","msg":"trace[1172515602] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:569; }","duration":"143.89713ms","start":"2026-08-20T01:08:38.472865Z","end":"2026-08-20T01:08:38.616762Z","steps":["trace[1172515602] 'agreement among raft nodes before linearized reading' (duration: 143.715476ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:38.617024Z","caller":"traceutil/trace.go:171","msg":"trace[826240319] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"139.942489ms","start":"2026-08-20T01:08:38.477045Z","end":"2026-08-20T01:08:38.616987Z","steps":["trace[826240319] 'process raft request' (duration: 139.20559ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:38.748967Z","caller":"traceutil/trace.go:171","msg":"trace[1920867703] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:591; }","duration":"130.328675ms","start":"2026-08-20T01:08:38.618587Z","end":"2026-08-20T01:08:38.748916Z","steps":["trace[1920867703] 'read index received' (duration: 11.930723ms)","trace[1920867703] 'applied index is now lower than readState.Index' (duration: 118.397052ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:08:38.749142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.53169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-08-20T01:08:38.749182Z","caller":"traceutil/trace.go:171","msg":"trace[1449832447] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:571; }","duration":"130.616273ms","start":"2026-08-20T01:08:38.618554Z","end":"2026-08-20T01:08:38.749171Z","steps":["trace[1449832447] 'agreement among raft nodes before linearized reading' (duration: 130.48891ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:38.749352Z","caller":"traceutil/trace.go:171","msg":"trace[1389738480] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"135.941307ms","start":"2026-08-20T01:08:38.613345Z","end":"2026-08-20T01:08:38.749286Z","steps":["trace[1389738480] 'process raft request' (duration: 135.340072ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:38.777048Z","caller":"traceutil/trace.go:171","msg":"trace[1145426680] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"137.64545ms","start":"2026-08-20T01:08:38.639373Z","end":"2026-08-20T01:08:38.777018Z","steps":["trace[1145426680] 'process raft request' (duration: 136.987613ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:41.868696Z","caller":"traceutil/trace.go:171","msg":"trace[1641923325] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"255.922292ms","start":"2026-08-20T01:08:41.61275Z","end":"2026-08-20T01:08:41.868673Z","steps":["trace[1641923325] 'process raft request' (duration: 255.231384ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:42.583216Z","caller":"traceutil/trace.go:171","msg":"trace[1315074462] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"196.573098ms","start":"2026-08-20T01:08:42.38661Z","end":"2026-08-20T01:08:42.583183Z","steps":["trace[1315074462] 'process raft request' (duration: 195.974012ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:42.692429Z","caller":"traceutil/trace.go:171","msg":"trace[1885062092] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"105.361234ms","start":"2026-08-20T01:08:42.587046Z","end":"2026-08-20T01:08:42.692407Z","steps":["trace[1885062092] 'process raft request' (duration: 105.21089ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:42.692566Z","caller":"traceutil/trace.go:171","msg":"trace[180070566] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"105.469697ms","start":"2026-08-20T01:08:42.587089Z","end":"2026-08-20T01:08:42.692559Z","steps":["trace[180070566] 'process raft request' (duration: 105.253391ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:42.69255Z","caller":"traceutil/trace.go:171","msg":"trace[1160129110] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"103.073615ms","start":"2026-08-20T01:08:42.589424Z","end":"2026-08-20T01:08:42.692497Z","steps":["trace[1160129110] 'process raft request' (duration: 102.937782ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:46.888469Z","caller":"traceutil/trace.go:171","msg":"trace[784550083] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"157.485218ms","start":"2026-08-20T01:08:46.730956Z","end":"2026-08-20T01:08:46.888442Z","steps":["trace[784550083] 'read index received' (duration: 157.18592ms)","trace[784550083] 'applied index is now lower than readState.Index' (duration: 298.188µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:08:46.888531Z","caller":"traceutil/trace.go:171","msg":"trace[1225946566] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"193.627892ms","start":"2026-08-20T01:08:46.694875Z","end":"2026-08-20T01:08:46.888503Z","steps":["trace[1225946566] 'process raft request' (duration: 193.396725ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:46.888716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.553412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-20T01:08:46.888715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.757295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-20T01:08:46.888768Z","caller":"traceutil/trace.go:171","msg":"trace[562596304] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:618; }","duration":"152.606143ms","start":"2026-08-20T01:08:46.736145Z","end":"2026-08-20T01:08:46.888752Z","steps":["trace[562596304] 'agreement among raft nodes before linearized reading' (duration: 152.515841ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:46.888773Z","caller":"traceutil/trace.go:171","msg":"trace[242964993] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:618; }","duration":"157.866068ms","start":"2026-08-20T01:08:46.730894Z","end":"2026-08-20T01:08:46.88876Z","steps":["trace[242964993] 'agreement among raft nodes before linearized reading' (duration: 157.694983ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:46.888771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.659524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-20T01:08:46.888817Z","caller":"traceutil/trace.go:171","msg":"trace[801598540] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:618; }","duration":"152.745867ms","start":"2026-08-20T01:08:46.736058Z","end":"2026-08-20T01:08:46.888804Z","steps":["trace[801598540] 'agreement among raft nodes before linearized reading' (duration: 152.564552ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:47.448619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.310262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:08:47.448752Z","caller":"traceutil/trace.go:171","msg":"trace[384723427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"258.514507ms","start":"2026-08-20T01:08:47.190213Z","end":"2026-08-20T01:08:47.448728Z","steps":["trace[384723427] 'range keys from in-memory index tree' (duration: 258.183559ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:49.364905Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.04763481s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-20T01:08:49.365434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:48.317158Z","time spent":"1.048272539s","remote":"127.0.0.1:49428","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-08-20T01:08:49.4256Z","caller":"traceutil/trace.go:171","msg":"trace[79203847] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:644; }","duration":"532.912755ms","start":"2026-08-20T01:08:48.892663Z","end":"2026-08-20T01:08:49.425576Z","steps":["trace[79203847] 'read index received' (duration: 472.411774ms)","trace[79203847] 'applied index is now lower than readState.Index' (duration: 60.499851ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:08:49.425714Z","caller":"traceutil/trace.go:171","msg":"trace[1331704590] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"907.547024ms","start":"2026-08-20T01:08:48.518121Z","end":"2026-08-20T01:08:49.425668Z","steps":["trace[1331704590] 'process raft request' (duration: 907.197465ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:49.425913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:48.518104Z","time spent":"907.722668ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T01:08:49.426033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.357146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-20T01:08:49.426849Z","caller":"traceutil/trace.go:171","msg":"trace[93473283] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:622; }","duration":"534.176028ms","start":"2026-08-20T01:08:48.892608Z","end":"2026-08-20T01:08:49.426784Z","steps":["trace[93473283] 'agreement among raft nodes before linearized reading' (duration: 533.076369ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:49.427023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:48.892583Z","time spent":"534.377623ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-20T01:08:49.926687Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471728419230833973,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T01:08:50.369461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.485066ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T01:08:50.369722Z","caller":"traceutil/trace.go:171","msg":"trace[1312805627] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"1.00250613s","start":"2026-08-20T01:08:49.367197Z","end":"2026-08-20T01:08:50.369703Z","steps":["trace[1312805627] 'process raft request' (duration: 861.702406ms)","trace[1312805627] 'compare' (duration: 140.323321ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:08:50.369751Z","caller":"traceutil/trace.go:171","msg":"trace[72038965] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"939.42081ms","start":"2026-08-20T01:08:49.430303Z","end":"2026-08-20T01:08:50.369723Z","steps":["trace[72038965] 'process raft request' (duration: 939.267596ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:50.36975Z","caller":"traceutil/trace.go:171","msg":"trace[533670322] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:646; }","duration":"944.05641ms","start":"2026-08-20T01:08:49.425662Z","end":"2026-08-20T01:08:50.369718Z","steps":["trace[533670322] 'read index received' (duration: 803.231785ms)","trace[533670322] 'applied index is now lower than readState.Index' (duration: 140.822475ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:08:50.369802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:49.36717Z","time spent":"1.002597791s","remote":"127.0.0.1:49428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T01:08:50.369838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.186447535s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-20T01:08:50.369896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:49.430287Z","time spent":"939.530394ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T01:08:50.369992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.450356882s","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-08-20T01:08:50.370006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.382229267s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-20T01:08:50.37004Z","caller":"traceutil/trace.go:171","msg":"trace[2111463528] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:624; }","duration":"1.450446405s","start":"2026-08-20T01:08:48.919581Z","end":"2026-08-20T01:08:50.370027Z","steps":["trace[2111463528] 'agreement among raft nodes before linearized reading' (duration: 1.45025979s)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:08:50.370066Z","caller":"traceutil/trace.go:171","msg":"trace[529002654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:624; }","duration":"1.382310869s","start":"2026-08-20T01:08:48.987735Z","end":"2026-08-20T01:08:50.370046Z","steps":["trace[529002654] 'agreement among raft nodes before linearized reading' (duration: 1.382143485s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:50.370081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:48.919564Z","time spent":"1.450508936s","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-20T01:08:50.370114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:48.987721Z","time spent":"1.382384581s","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-20T01:08:50.369917Z","caller":"traceutil/trace.go:171","msg":"trace[1422916990] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"1.186570779s","start":"2026-08-20T01:08:49.183328Z","end":"2026-08-20T01:08:50.369899Z","steps":["trace[1422916990] 'agreement among raft nodes before linearized reading' (duration: 1.186452536s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:50.370162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:49.183311Z","time spent":"1.186842076s","remote":"127.0.0.1:49402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-20T01:08:50.369904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.381641442s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-20T01:08:50.370349Z","caller":"traceutil/trace.go:171","msg":"trace[575748442] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:624; }","duration":"1.382149356s","start":"2026-08-20T01:08:48.988185Z","end":"2026-08-20T01:08:50.370334Z","steps":["trace[575748442] 'agreement among raft nodes before linearized reading' (duration: 1.381577901s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:50.370396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:08:48.988154Z","time spent":"1.382228947s","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-20T01:08:52.884441Z","caller":"traceutil/trace.go:171","msg":"trace[1136330841] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"273.413221ms","start":"2026-08-20T01:08:52.610999Z","end":"2026-08-20T01:08:52.884412Z","steps":["trace[1136330841] 'process raft request' (duration: 273.250997ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:08:55.713417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.009718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-08-20T01:08:55.713512Z","caller":"traceutil/trace.go:171","msg":"trace[704518281] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:696; }","duration":"105.193423ms","start":"2026-08-20T01:08:55.608293Z","end":"2026-08-20T01:08:55.713486Z","steps":["trace[704518281] 'range keys from in-memory index tree' (duration: 104.702811ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:09:06.973875Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471728419230834349,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T01:09:07.474709Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471728419230834349,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T01:09:07.735736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.397499222s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T01:09:07.73612Z","caller":"traceutil/trace.go:171","msg":"trace[1048436596] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:780; }","duration":"1.397910922s","start":"2026-08-20T01:09:06.338142Z","end":"2026-08-20T01:09:07.736053Z","steps":["trace[1048436596] 'count revisions from in-memory index tree' (duration: 1.397333997s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:09:07.736303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:09:06.338117Z","time spent":"1.398166609s","remote":"127.0.0.1:49704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-08-20T01:09:07.772833Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.315261544s","expected-duration":"1s"} {"level":"info","ts":"2026-08-20T01:09:07.773364Z","caller":"traceutil/trace.go:171","msg":"trace[1963632031] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"1.300530541s","start":"2026-08-20T01:09:06.47281Z","end":"2026-08-20T01:09:07.77334Z","steps":["trace[1963632031] 'read index received' (duration: 1.300349706s)","trace[1963632031] 'applied index is now lower than readState.Index' (duration: 179.155µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:09:07.773432Z","caller":"traceutil/trace.go:171","msg":"trace[1366477289] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"1.315936411s","start":"2026-08-20T01:09:06.457457Z","end":"2026-08-20T01:09:07.773393Z","steps":["trace[1366477289] 'process raft request' (duration: 1.315703345s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:09:07.773617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:09:06.457425Z","time spent":"1.316090025s","remote":"127.0.0.1:49618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T01:09:07.773705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.300879171s","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-08-20T01:09:07.773729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.290384977s","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-08-20T01:09:07.773766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.267020188s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-20T01:09:07.773839Z","caller":"traceutil/trace.go:171","msg":"trace[368652202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:781; }","duration":"1.267135092s","start":"2026-08-20T01:09:06.506686Z","end":"2026-08-20T01:09:07.773821Z","steps":["trace[368652202] 'agreement among raft nodes before linearized reading' (duration: 1.266987808s)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:09:07.773756Z","caller":"traceutil/trace.go:171","msg":"trace[1597931339] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:781; }","duration":"1.301000813s","start":"2026-08-20T01:09:06.472741Z","end":"2026-08-20T01:09:07.773742Z","steps":["trace[1597931339] 'agreement among raft nodes before linearized reading' (duration: 1.300714606s)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:09:07.773843Z","caller":"traceutil/trace.go:171","msg":"trace[902931152] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:781; }","duration":"1.290541301s","start":"2026-08-20T01:09:06.483263Z","end":"2026-08-20T01:09:07.773804Z","steps":["trace[902931152] 'agreement among raft nodes before linearized reading' (duration: 1.290249023s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:09:07.773878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:09:06.472708Z","time spent":"1.301160967s","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-20T01:09:07.773878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:09:06.506661Z","time spent":"1.267208153s","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-20T01:09:07.773893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:09:06.483248Z","time spent":"1.290635294s","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-20T01:09:07.77385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.26282487s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-20T01:09:07.773966Z","caller":"traceutil/trace.go:171","msg":"trace[716988625] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:781; }","duration":"1.263024475s","start":"2026-08-20T01:09:06.510914Z","end":"2026-08-20T01:09:07.773938Z","steps":["trace[716988625] 'agreement among raft nodes before linearized reading' (duration: 1.262630025s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:09:07.774012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.178485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-7v2j9\" ","response":"range_response_count:1 size:5050"} {"level":"warn","ts":"2026-08-20T01:09:07.774034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:09:06.510887Z","time spent":"1.263137218s","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-20T01:09:07.774046Z","caller":"traceutil/trace.go:171","msg":"trace[454849114] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-7v2j9; range_end:; response_count:1; response_revision:781; }","duration":"309.261737ms","start":"2026-08-20T01:09:07.464775Z","end":"2026-08-20T01:09:07.774037Z","steps":["trace[454849114] 'agreement among raft nodes before linearized reading' (duration: 309.112503ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:09:07.774057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.923402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-20T01:09:07.774059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.28243973s","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-08-20T01:09:07.774071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:09:07.464741Z","time spent":"309.325049ms","remote":"127.0.0.1:49570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":5074,"request content":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-7v2j9\" "} {"level":"info","ts":"2026-08-20T01:09:07.774087Z","caller":"traceutil/trace.go:171","msg":"trace[2051165609] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:781; }","duration":"591.982653ms","start":"2026-08-20T01:09:07.182095Z","end":"2026-08-20T01:09:07.774078Z","steps":["trace[2051165609] 'agreement among raft nodes before linearized reading' (duration: 591.938562ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:09:07.774092Z","caller":"traceutil/trace.go:171","msg":"trace[2127766641] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:781; }","duration":"1.282489592s","start":"2026-08-20T01:09:06.491593Z","end":"2026-08-20T01:09:07.774082Z","steps":["trace[2127766641] 'agreement among raft nodes before linearized reading' (duration: 1.28239737s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:09:07.774123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:09:06.491583Z","time spent":"1.282533433s","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-20T01:09:07.774114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:09:07.182073Z","time spent":"592.035535ms","remote":"127.0.0.1:49418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-20T01:09:07.91053Z","caller":"traceutil/trace.go:171","msg":"trace[394614884] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"129.676604ms","start":"2026-08-20T01:09:07.780821Z","end":"2026-08-20T01:09:07.910498Z","steps":["trace[394614884] 'process raft request' (duration: 129.541561ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:09:07.926861Z","caller":"traceutil/trace.go:171","msg":"trace[1641600130] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"145.378482ms","start":"2026-08-20T01:09:07.781409Z","end":"2026-08-20T01:09:07.926787Z","steps":["trace[1641600130] 'process raft request' (duration: 145.092565ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:09:07.927101Z","caller":"traceutil/trace.go:171","msg":"trace[838678893] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"145.567088ms","start":"2026-08-20T01:09:07.781502Z","end":"2026-08-20T01:09:07.927069Z","steps":["trace[838678893] 'process raft request' (duration: 145.222288ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:09:07.927854Z","caller":"traceutil/trace.go:171","msg":"trace[378194797] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"146.104182ms","start":"2026-08-20T01:09:07.781732Z","end":"2026-08-20T01:09:07.927836Z","steps":["trace[378194797] 'process raft request' (duration: 145.24223ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:09:07.928208Z","caller":"traceutil/trace.go:171","msg":"trace[987331701] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"146.093632ms","start":"2026-08-20T01:09:07.782097Z","end":"2026-08-20T01:09:07.92819Z","steps":["trace[987331701] 'process raft request' (duration: 145.695572ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:09:07.928222Z","caller":"traceutil/trace.go:171","msg":"trace[551119312] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"145.510597ms","start":"2026-08-20T01:09:07.782675Z","end":"2026-08-20T01:09:07.928186Z","steps":["trace[551119312] 'process raft request' (duration: 145.406424ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:09:21.751473Z","caller":"traceutil/trace.go:171","msg":"trace[758950768] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"129.311343ms","start":"2026-08-20T01:09:21.622145Z","end":"2026-08-20T01:09:21.751456Z","steps":["trace[758950768] 'process raft request' (duration: 129.146509ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:10:18.828189Z","caller":"traceutil/trace.go:171","msg":"trace[669510581] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"334.479761ms","start":"2026-08-20T01:10:18.493678Z","end":"2026-08-20T01:10:18.828158Z","steps":["trace[669510581] 'process raft request' (duration: 334.320436ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:10:18.828372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:10:18.493638Z","time spent":"334.642175ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T01:10:18.901296Z","caller":"traceutil/trace.go:171","msg":"trace[556904001] linearizableReadLoop","detail":"{readStateIndex:1203; appliedIndex:1200; }","duration":"399.644546ms","start":"2026-08-20T01:10:18.501628Z","end":"2026-08-20T01:10:18.901273Z","steps":["trace[556904001] 'read index received' (duration: 326.358373ms)","trace[556904001] 'applied index is now lower than readState.Index' (duration: 73.285093ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T01:10:18.901366Z","caller":"traceutil/trace.go:171","msg":"trace[1075714864] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"406.632192ms","start":"2026-08-20T01:10:18.494727Z","end":"2026-08-20T01:10:18.901359Z","steps":["trace[1075714864] 'process raft request' (duration: 406.460928ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:10:18.901416Z","caller":"traceutil/trace.go:171","msg":"trace[1048142840] transaction","detail":"{read_only:false; response_revision:1158; number_of_response:1; }","duration":"232.898419ms","start":"2026-08-20T01:10:18.668507Z","end":"2026-08-20T01:10:18.901405Z","steps":["trace[1048142840] 'process raft request' (duration: 232.723884ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:10:18.901457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:10:18.494703Z","time spent":"406.690664ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T01:10:18.90131Z","caller":"traceutil/trace.go:171","msg":"trace[1685755532] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"406.898909ms","start":"2026-08-20T01:10:18.494383Z","end":"2026-08-20T01:10:18.901282Z","steps":["trace[1685755532] 'process raft request' (duration: 396.48846ms)","trace[1685755532] 'compare' (duration: 10.193374ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:10:18.90158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:10:18.494368Z","time spent":"407.188558ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T01:10:18.901721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.092738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-08-20T01:10:18.901722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.370458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-20T01:10:18.901752Z","caller":"traceutil/trace.go:171","msg":"trace[1239726662] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1158; }","duration":"400.1397ms","start":"2026-08-20T01:10:18.501604Z","end":"2026-08-20T01:10:18.901743Z","steps":["trace[1239726662] 'agreement among raft nodes before linearized reading' (duration: 400.036057ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:10:18.901768Z","caller":"traceutil/trace.go:171","msg":"trace[1595935758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1158; }","duration":"399.45548ms","start":"2026-08-20T01:10:18.5023Z","end":"2026-08-20T01:10:18.901755Z","steps":["trace[1595935758] 'agreement among raft nodes before linearized reading' (duration: 399.296556ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:10:18.901779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:10:18.501591Z","time spent":"400.18076ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-20T01:10:18.901824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:10:18.502291Z","time spent":"399.509872ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-20T01:10:21.01934Z","caller":"traceutil/trace.go:171","msg":"trace[920676244] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"111.965311ms","start":"2026-08-20T01:10:20.90733Z","end":"2026-08-20T01:10:21.019295Z","steps":["trace[920676244] 'process raft request' (duration: 75.033441ms)","trace[920676244] 'compare' (duration: 36.309463ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:10:21.01942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.211294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-20T01:10:21.020146Z","caller":"traceutil/trace.go:171","msg":"trace[1768865953] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1163; }","duration":"113.954214ms","start":"2026-08-20T01:10:20.906166Z","end":"2026-08-20T01:10:21.02012Z","steps":["trace[1768865953] 'agreement among raft nodes before linearized reading' (duration: 113.149642ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:10:21.019519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.385212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-20T01:10:21.020454Z","caller":"traceutil/trace.go:171","msg":"trace[2051023262] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1163; }","duration":"107.391278ms","start":"2026-08-20T01:10:20.913051Z","end":"2026-08-20T01:10:21.020443Z","steps":["trace[2051023262] 'agreement among raft nodes before linearized reading' (duration: 106.279589ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:10:21.019625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.843264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-20T01:10:21.020618Z","caller":"traceutil/trace.go:171","msg":"trace[1453749259] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1163; }","duration":"110.887402ms","start":"2026-08-20T01:10:20.909719Z","end":"2026-08-20T01:10:21.020607Z","steps":["trace[1453749259] 'agreement among raft nodes before linearized reading' (duration: 109.68915ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:10:21.602131Z","caller":"traceutil/trace.go:171","msg":"trace[73126045] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"310.880323ms","start":"2026-08-20T01:10:21.291227Z","end":"2026-08-20T01:10:21.602107Z","steps":["trace[73126045] 'process raft request' (duration: 310.471282ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T01:10:21.602462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T01:10:21.291211Z","time spent":"311.180011ms","remote":"127.0.0.1:49650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-20T01:10:31.170354Z","caller":"traceutil/trace.go:171","msg":"trace[1528447023] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"106.634924ms","start":"2026-08-20T01:10:31.063661Z","end":"2026-08-20T01:10:31.170296Z","steps":["trace[1528447023] 'process raft request' (duration: 83.44397ms)","trace[1528447023] 'compare' (duration: 22.992328ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T01:10:31.170525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.180191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-08-20T01:10:31.170599Z","caller":"traceutil/trace.go:171","msg":"trace[1137347500] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1195; }","duration":"100.378596ms","start":"2026-08-20T01:10:31.070202Z","end":"2026-08-20T01:10:31.17058Z","steps":["trace[1137347500] 'agreement among raft nodes before linearized reading' (duration: 100.055458ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T01:10:58.485952Z","caller":"traceutil/trace.go:171","msg":"trace[146319697] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"134.075744ms","start":"2026-08-20T01:10:58.351849Z","end":"2026-08-20T01:10:58.485924Z","steps":["trace[146319697] 'process raft request' (duration: 133.912294ms)"],"step_count":1}