{"level":"warn","ts":"2026-07-10T03:35:56.39585Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-10T03:35:56.395984Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-10T03:35:56.396052Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-10T03:35:56.396067Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-07-10T03:35:56.396085Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-10T03:35:56.396774Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-07-10T03:35:56.396849Z","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.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-10T03:35:56.443225Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"46.167911ms"} {"level":"info","ts":"2026-07-10T03:35:58.61849Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-07-10T03:35:58.620682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-07-10T03:35:58.620738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-07-10T03:35:58.620773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-10T03:35:58.62079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-07-10T03:35:58.620864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-07-10T03:35:58.70291Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-10T03:35:58.704654Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-10T03:35:58.705879Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-10T03:35:58.709102Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-10T03:35:58.70924Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-10T03:35:58.709816Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-10T03:35:58.710169Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-10T03:35:58.710256Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-10T03:35:58.711643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-07-10T03:35:58.711793Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-07-10T03:35:58.713229Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-10T03:35:58.713294Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-07-10T03:35:58.713363Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-07-10T03:35:58.713502Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-10T03:35:58.713614Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-10T03:35:58.893824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-07-10T03:35:58.89389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-07-10T03:35:58.893937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-07-10T03:35:58.893965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-07-10T03:35:58.893976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-07-10T03:35:58.893991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-07-10T03:35:58.894004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-07-10T03:35:58.895024Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-07-10T03:35:58.895046Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-10T03:35:58.895113Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-10T03:35:58.89504Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-10T03:35:58.895504Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-10T03:35:58.89556Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-10T03:35:58.896078Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-07-10T03:35:58.896189Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-10T03:35:58.896226Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-10T03:35:58.900573Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-10T03:35:58.900841Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-07-10T03:36:35.664553Z","caller":"traceutil/trace.go:171","msg":"trace[720648240] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"308.911962ms","start":"2026-07-10T03:36:35.355615Z","end":"2026-07-10T03:36:35.664527Z","steps":["trace[720648240] 'process raft request' (duration: 308.761528ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:35.665312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:35.355597Z","time spent":"309.051907ms","remote":"127.0.0.1:40498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-10T03:36:35.680288Z","caller":"traceutil/trace.go:171","msg":"trace[25656615] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"320.562041ms","start":"2026-07-10T03:36:35.359694Z","end":"2026-07-10T03:36:35.680256Z","steps":["trace[25656615] 'process raft request' (duration: 320.399307ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:36:35.68034Z","caller":"traceutil/trace.go:171","msg":"trace[537825979] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"320.53133ms","start":"2026-07-10T03:36:35.359771Z","end":"2026-07-10T03:36:35.680302Z","steps":["trace[537825979] 'process raft request' (duration: 320.426378ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:35.680423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:35.359677Z","time spent":"320.686125ms","remote":"127.0.0.1:40498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-10T03:36:35.680462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:35.359745Z","time spent":"320.658904ms","remote":"127.0.0.1:40498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-10T03:36:35.680566Z","caller":"traceutil/trace.go:171","msg":"trace[1458264022] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"311.366807ms","start":"2026-07-10T03:36:35.369179Z","end":"2026-07-10T03:36:35.680546Z","steps":["trace[1458264022] 'process raft request' (duration: 311.112761ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:36:35.680588Z","caller":"traceutil/trace.go:171","msg":"trace[1482665907] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"310.171757ms","start":"2026-07-10T03:36:35.370387Z","end":"2026-07-10T03:36:35.680559Z","steps":["trace[1482665907] 'process raft request' (duration: 309.944901ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:36:35.680607Z","caller":"traceutil/trace.go:171","msg":"trace[231211673] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"316.019481ms","start":"2026-07-10T03:36:35.364555Z","end":"2026-07-10T03:36:35.680574Z","steps":["trace[231211673] 'process raft request' (duration: 315.690523ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:35.680667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:35.36917Z","time spent":"311.448269ms","remote":"127.0.0.1:40498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-10T03:36:35.680717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:35.364547Z","time spent":"316.104924ms","remote":"127.0.0.1:40498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-10T03:36:35.680763Z","caller":"traceutil/trace.go:171","msg":"trace[1901252265] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"310.29751ms","start":"2026-07-10T03:36:35.370456Z","end":"2026-07-10T03:36:35.680754Z","steps":["trace[1901252265] 'process raft request' (duration: 309.90992ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:35.680809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:35.370451Z","time spent":"310.339271ms","remote":"127.0.0.1:40498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-10T03:36:35.680758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:35.370379Z","time spent":"310.315111ms","remote":"127.0.0.1:40498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-10T03:36:35.680923Z","caller":"traceutil/trace.go:171","msg":"trace[724565655] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"307.885457ms","start":"2026-07-10T03:36:35.373031Z","end":"2026-07-10T03:36:35.680917Z","steps":["trace[724565655] 'process raft request' (duration: 307.492176ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:35.680958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:35.373006Z","time spent":"307.936737ms","remote":"127.0.0.1:40498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-10T03:36:35.681008Z","caller":"traceutil/trace.go:171","msg":"trace[815320077] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"303.996354ms","start":"2026-07-10T03:36:35.376998Z","end":"2026-07-10T03:36:35.680994Z","steps":["trace[815320077] 'process raft request' (duration: 303.614453ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:36:35.68114Z","caller":"traceutil/trace.go:171","msg":"trace[779132921] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"303.757437ms","start":"2026-07-10T03:36:35.377316Z","end":"2026-07-10T03:36:35.681074Z","steps":["trace[779132921] 'process raft request' (duration: 303.601764ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:36:35.681159Z","caller":"traceutil/trace.go:171","msg":"trace[903701367] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"282.133804ms","start":"2026-07-10T03:36:35.399018Z","end":"2026-07-10T03:36:35.681152Z","steps":["trace[903701367] 'process raft request' (duration: 281.982351ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:35.681148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:35.37699Z","time spent":"304.082935ms","remote":"127.0.0.1:40498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-10T03:36:35.681237Z","caller":"traceutil/trace.go:171","msg":"trace[945603120] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"112.257379ms","start":"2026-07-10T03:36:35.568966Z","end":"2026-07-10T03:36:35.681223Z","steps":["trace[945603120] 'process raft request' (duration: 112.144706ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:35.681251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:35.37731Z","time spent":"303.85573ms","remote":"127.0.0.1:40498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-10T03:36:35.681222Z","caller":"traceutil/trace.go:171","msg":"trace[1506176249] linearizableReadLoop","detail":"{readStateIndex:556; appliedIndex:544; }","duration":"105.011909ms","start":"2026-07-10T03:36:35.576186Z","end":"2026-07-10T03:36:35.681198Z","steps":["trace[1506176249] 'read index received' (duration: 88.187073ms)","trace[1506176249] 'applied index is now lower than readState.Index' (duration: 16.824026ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T03:36:35.681446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.235485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-10T03:36:35.681524Z","caller":"traceutil/trace.go:171","msg":"trace[1491487614] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:538; }","duration":"105.346637ms","start":"2026-07-10T03:36:35.576166Z","end":"2026-07-10T03:36:35.681513Z","steps":["trace[1491487614] 'agreement among raft nodes before linearized reading' (duration: 105.169842ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:42.003493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.196041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-10T03:36:42.00356Z","caller":"traceutil/trace.go:171","msg":"trace[229205822] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:633; }","duration":"281.299083ms","start":"2026-07-10T03:36:41.722247Z","end":"2026-07-10T03:36:42.003546Z","steps":["trace[229205822] 'range keys from in-memory index tree' (duration: 281.113838ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:42.00409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.253013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8vwf7\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-07-10T03:36:42.00409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.599596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-10T03:36:42.00414Z","caller":"traceutil/trace.go:171","msg":"trace[2035286906] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8vwf7; range_end:; response_count:1; response_revision:633; }","duration":"199.337814ms","start":"2026-07-10T03:36:41.80479Z","end":"2026-07-10T03:36:42.004128Z","steps":["trace[2035286906] 'range keys from in-memory index tree' (duration: 198.884722ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:36:42.004157Z","caller":"traceutil/trace.go:171","msg":"trace[1270053799] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:633; }","duration":"195.707648ms","start":"2026-07-10T03:36:41.808432Z","end":"2026-07-10T03:36:42.00414Z","steps":["trace[1270053799] 'range keys from in-memory index tree' (duration: 195.296147ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:36:42.325124Z","caller":"traceutil/trace.go:171","msg":"trace[601314557] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"323.766146ms","start":"2026-07-10T03:36:42.001296Z","end":"2026-07-10T03:36:42.325062Z","steps":["trace[601314557] 'process raft request' (duration: 322.798531ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:42.325778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:42.001267Z","time spent":"324.150066ms","remote":"127.0.0.1:40538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T03:36:42.758329Z","caller":"traceutil/trace.go:171","msg":"trace[634265708] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"741.439827ms","start":"2026-07-10T03:36:42.016868Z","end":"2026-07-10T03:36:42.758308Z","steps":["trace[634265708] 'process raft request' (duration: 741.387306ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:42.758462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:42.016849Z","time spent":"741.549339ms","remote":"127.0.0.1:40642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-10T03:36:42.75852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:42.004678Z","time spent":"753.840944ms","remote":"127.0.0.1:40478","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-10T03:36:42.758886Z","caller":"traceutil/trace.go:171","msg":"trace[2129374143] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"751.526745ms","start":"2026-07-10T03:36:42.00733Z","end":"2026-07-10T03:36:42.758856Z","steps":["trace[2129374143] 'process raft request' (duration: 750.755144ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:36:42.759045Z","caller":"traceutil/trace.go:171","msg":"trace[1371597362] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"749.83618ms","start":"2026-07-10T03:36:42.008777Z","end":"2026-07-10T03:36:42.758613Z","steps":["trace[1371597362] 'process raft request' (duration: 749.443599ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:42.759311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:42.00876Z","time spent":"750.399174ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-10T03:36:42.759124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:42.007309Z","time spent":"751.651947ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T03:36:42.779911Z","caller":"traceutil/trace.go:171","msg":"trace[82088395] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"401.976635ms","start":"2026-07-10T03:36:42.377911Z","end":"2026-07-10T03:36:42.779888Z","steps":["trace[82088395] 'process raft request' (duration: 401.76803ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:36:42.780004Z","caller":"traceutil/trace.go:171","msg":"trace[699794201] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:658; }","duration":"170.766588ms","start":"2026-07-10T03:36:42.609046Z","end":"2026-07-10T03:36:42.779813Z","steps":["trace[699794201] 'read index received' (duration: 134.204931ms)","trace[699794201] 'applied index is now lower than readState.Index' (duration: 36.560737ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T03:36:42.78005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:42.377888Z","time spent":"402.102349ms","remote":"127.0.0.1:40690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-10T03:36:42.78017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.123837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-10T03:36:42.780197Z","caller":"traceutil/trace.go:171","msg":"trace[390470621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:638; }","duration":"171.20268ms","start":"2026-07-10T03:36:42.608987Z","end":"2026-07-10T03:36:42.780189Z","steps":["trace[390470621] 'agreement among raft nodes before linearized reading' (duration: 171.044326ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:43.482116Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680221075957869201,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-10T03:36:43.982312Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680221075957869201,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-10T03:36:44.446737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"806.670295ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T03:36:44.446828Z","caller":"traceutil/trace.go:171","msg":"trace[1038602178] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:640; }","duration":"806.802448ms","start":"2026-07-10T03:36:43.640011Z","end":"2026-07-10T03:36:44.446813Z","steps":["trace[1038602178] 'range keys from in-memory index tree' (duration: 806.654685ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:44.449854Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.636189191s","expected-duration":"1s"} {"level":"info","ts":"2026-07-10T03:36:44.450098Z","caller":"traceutil/trace.go:171","msg":"trace[1720864212] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:665; }","duration":"1.468641059s","start":"2026-07-10T03:36:42.981441Z","end":"2026-07-10T03:36:44.450082Z","steps":["trace[1720864212] 'read index received' (duration: 1.468506614s)","trace[1720864212] 'applied index is now lower than readState.Index' (duration: 133.785µs)"],"step_count":2} {"level":"info","ts":"2026-07-10T03:36:44.450175Z","caller":"traceutil/trace.go:171","msg":"trace[90939360] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"1.636589833s","start":"2026-07-10T03:36:42.81357Z","end":"2026-07-10T03:36:44.45016Z","steps":["trace[90939360] 'process raft request' (duration: 1.636421587s)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:44.450265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:42.813554Z","time spent":"1.636661694s","remote":"127.0.0.1:40642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-10T03:36:44.450277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.468837413s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-10T03:36:44.45028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.452230365s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T03:36:44.450369Z","caller":"traceutil/trace.go:171","msg":"trace[503405446] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"1.452358558s","start":"2026-07-10T03:36:42.997982Z","end":"2026-07-10T03:36:44.45034Z","steps":["trace[503405446] 'agreement among raft nodes before linearized reading' (duration: 1.452232665s)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:44.450411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:42.997961Z","time spent":"1.452442191s","remote":"127.0.0.1:47384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-10T03:36:44.450309Z","caller":"traceutil/trace.go:171","msg":"trace[324714368] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:641; }","duration":"1.468910595s","start":"2026-07-10T03:36:42.981389Z","end":"2026-07-10T03:36:44.450299Z","steps":["trace[324714368] 'agreement among raft nodes before linearized reading' (duration: 1.468766321s)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:44.450487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:42.981368Z","time spent":"1.469110591s","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-10T03:36:46.177627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.330478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T03:36:46.177719Z","caller":"traceutil/trace.go:171","msg":"trace[1500730386] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:680; }","duration":"179.467561ms","start":"2026-07-10T03:36:45.998234Z","end":"2026-07-10T03:36:46.177702Z","steps":["trace[1500730386] 'range keys from in-memory index tree' (duration: 179.250846ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:36:46.177814Z","caller":"traceutil/trace.go:171","msg":"trace[1537756206] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"149.560551ms","start":"2026-07-10T03:36:46.028237Z","end":"2026-07-10T03:36:46.177798Z","steps":["trace[1537756206] 'process raft request' (duration: 149.465168ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:49.125503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.829844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-07-10T03:36:49.125646Z","caller":"traceutil/trace.go:171","msg":"trace[1185062042] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:717; }","duration":"101.000218ms","start":"2026-07-10T03:36:49.024599Z","end":"2026-07-10T03:36:49.125599Z","steps":["trace[1185062042] 'range keys from in-memory index tree' (duration: 100.597497ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:57.166905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.189571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T03:36:57.166988Z","caller":"traceutil/trace.go:171","msg":"trace[1972913047] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:779; }","duration":"166.319594ms","start":"2026-07-10T03:36:57.000652Z","end":"2026-07-10T03:36:57.166972Z","steps":["trace[1972913047] 'range keys from in-memory index tree' (duration: 166.100869ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:36:57.167109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.759407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-k5bvl\" ","response":"range_response_count:1 size:4740"} {"level":"info","ts":"2026-07-10T03:36:57.167182Z","caller":"traceutil/trace.go:171","msg":"trace[1195783965] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-k5bvl; range_end:; response_count:1; response_revision:779; }","duration":"216.870109ms","start":"2026-07-10T03:36:56.950291Z","end":"2026-07-10T03:36:57.167161Z","steps":["trace[1195783965] 'range keys from in-memory index tree' (duration: 216.323936ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:37:00.272126Z","caller":"traceutil/trace.go:171","msg":"trace[1325484993] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"558.824242ms","start":"2026-07-10T03:36:59.713279Z","end":"2026-07-10T03:37:00.272103Z","steps":["trace[1325484993] 'process raft request' (duration: 558.679658ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:00.272289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:59.713252Z","time spent":"558.943146ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T03:37:00.364594Z","caller":"traceutil/trace.go:171","msg":"trace[527243102] linearizableReadLoop","detail":"{readStateIndex:833; appliedIndex:831; }","duration":"365.663088ms","start":"2026-07-10T03:36:59.99891Z","end":"2026-07-10T03:37:00.364573Z","steps":["trace[527243102] 'read index received' (duration: 273.106953ms)","trace[527243102] 'applied index is now lower than readState.Index' (duration: 92.555015ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T03:37:00.364937Z","caller":"traceutil/trace.go:171","msg":"trace[2139578691] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"379.988168ms","start":"2026-07-10T03:36:59.984935Z","end":"2026-07-10T03:37:00.364923Z","steps":["trace[2139578691] 'process raft request' (duration: 379.498735ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:00.36506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:59.984916Z","time spent":"380.063709ms","remote":"127.0.0.1:40690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-10T03:37:00.365265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.344966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T03:37:00.36531Z","caller":"traceutil/trace.go:171","msg":"trace[1964907209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"366.415929ms","start":"2026-07-10T03:36:59.998882Z","end":"2026-07-10T03:37:00.365298Z","steps":["trace[1964907209] 'agreement among raft nodes before linearized reading' (duration: 366.340476ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:00.365437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:36:59.998867Z","time spent":"366.559353ms","remote":"127.0.0.1:47384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-10T03:37:35.112181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.722945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-10T03:37:35.112247Z","caller":"traceutil/trace.go:171","msg":"trace[1024929866] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1019; }","duration":"406.857329ms","start":"2026-07-10T03:37:34.705377Z","end":"2026-07-10T03:37:35.112234Z","steps":["trace[1024929866] 'range keys from in-memory index tree' (duration: 406.545801ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:35.112275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:37:34.705348Z","time spent":"406.92125ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-10T03:37:35.112357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.260412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-10T03:37:35.112433Z","caller":"traceutil/trace.go:171","msg":"trace[646914732] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1019; }","duration":"560.393486ms","start":"2026-07-10T03:37:34.552023Z","end":"2026-07-10T03:37:35.112417Z","steps":["trace[646914732] 'count revisions from in-memory index tree' (duration: 560.167089ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:35.112453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.306432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-10T03:37:35.112496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:37:34.552004Z","time spent":"560.481548ms","remote":"127.0.0.1:40790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":16,"response size":29,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"info","ts":"2026-07-10T03:37:35.112522Z","caller":"traceutil/trace.go:171","msg":"trace[2144115785] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1019; }","duration":"379.432884ms","start":"2026-07-10T03:37:34.733067Z","end":"2026-07-10T03:37:35.1125Z","steps":["trace[2144115785] 'count revisions from in-memory index tree' (duration: 379.174319ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:35.112554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:37:34.733049Z","time spent":"379.497176ms","remote":"127.0.0.1:40698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":29,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-07-10T03:37:35.112795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.490992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T03:37:35.112866Z","caller":"traceutil/trace.go:171","msg":"trace[276929942] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1019; }","duration":"101.599204ms","start":"2026-07-10T03:37:35.01125Z","end":"2026-07-10T03:37:35.112849Z","steps":["trace[276929942] 'count revisions from in-memory index tree' (duration: 101.41752ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:37:35.694961Z","caller":"traceutil/trace.go:171","msg":"trace[708606631] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"578.530845ms","start":"2026-07-10T03:37:35.116387Z","end":"2026-07-10T03:37:35.694918Z","steps":["trace[708606631] 'process raft request' (duration: 578.389471ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:35.695079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:37:35.116369Z","time spent":"578.648838ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T03:37:35.863727Z","caller":"traceutil/trace.go:171","msg":"trace[1408316854] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"746.739789ms","start":"2026-07-10T03:37:35.116967Z","end":"2026-07-10T03:37:35.863707Z","steps":["trace[1408316854] 'process raft request' (duration: 746.606585ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:35.86385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:37:35.116942Z","time spent":"746.838712ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T03:37:35.864001Z","caller":"traceutil/trace.go:171","msg":"trace[1185436356] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"746.638496ms","start":"2026-07-10T03:37:35.117347Z","end":"2026-07-10T03:37:35.863986Z","steps":["trace[1185436356] 'process raft request' (duration: 746.329328ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:35.864061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:37:35.11733Z","time spent":"746.703677ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T03:37:35.864222Z","caller":"traceutil/trace.go:171","msg":"trace[791134487] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"746.789579ms","start":"2026-07-10T03:37:35.117413Z","end":"2026-07-10T03:37:35.864203Z","steps":["trace[791134487] 'process raft request' (duration: 746.528983ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:35.864345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:37:35.117406Z","time spent":"746.894953ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T03:37:35.864687Z","caller":"traceutil/trace.go:171","msg":"trace[1893354681] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"481.272065ms","start":"2026-07-10T03:37:35.383363Z","end":"2026-07-10T03:37:35.864635Z","steps":["trace[1893354681] 'process raft request' (duration: 480.775192ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:35.864887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:37:35.383347Z","time spent":"481.439789ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T03:37:35.864979Z","caller":"traceutil/trace.go:171","msg":"trace[193168828] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"394.374469ms","start":"2026-07-10T03:37:35.470593Z","end":"2026-07-10T03:37:35.864967Z","steps":["trace[193168828] 'process raft request' (duration: 393.898908ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:35.865042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:37:35.470572Z","time spent":"394.438441ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T03:37:56.843273Z","caller":"traceutil/trace.go:171","msg":"trace[2105727553] linearizableReadLoop","detail":"{readStateIndex:1134; appliedIndex:1133; }","duration":"269.051075ms","start":"2026-07-10T03:37:56.574198Z","end":"2026-07-10T03:37:56.843249Z","steps":["trace[2105727553] 'read index received' (duration: 268.87451ms)","trace[2105727553] 'applied index is now lower than readState.Index' (duration: 175.625µs)"],"step_count":2} {"level":"info","ts":"2026-07-10T03:37:56.843345Z","caller":"traceutil/trace.go:171","msg":"trace[579023535] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"446.169007ms","start":"2026-07-10T03:37:56.397158Z","end":"2026-07-10T03:37:56.843327Z","steps":["trace[579023535] 'process raft request' (duration: 445.95931ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:56.843467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:37:56.397138Z","time spent":"446.263418ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-10T03:37:56.843471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.260301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-10T03:37:56.843508Z","caller":"traceutil/trace.go:171","msg":"trace[1278040539] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1091; }","duration":"269.350353ms","start":"2026-07-10T03:37:56.574147Z","end":"2026-07-10T03:37:56.843497Z","steps":["trace[1278040539] 'agreement among raft nodes before linearized reading' (duration: 269.215369ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:37:57.26904Z","caller":"traceutil/trace.go:171","msg":"trace[1799614384] linearizableReadLoop","detail":"{readStateIndex:1135; appliedIndex:1134; }","duration":"272.130217ms","start":"2026-07-10T03:37:56.996886Z","end":"2026-07-10T03:37:57.269016Z","steps":["trace[1799614384] 'read index received' (duration: 271.934091ms)","trace[1799614384] 'applied index is now lower than readState.Index' (duration: 195.296µs)"],"step_count":2} {"level":"warn","ts":"2026-07-10T03:37:57.269156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.26416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T03:37:57.269191Z","caller":"traceutil/trace.go:171","msg":"trace[1360809818] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1092; }","duration":"272.338772ms","start":"2026-07-10T03:37:56.996839Z","end":"2026-07-10T03:37:57.269178Z","steps":["trace[1360809818] 'agreement among raft nodes before linearized reading' (duration: 272.27351ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:37:57.269206Z","caller":"traceutil/trace.go:171","msg":"trace[444346293] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"422.127489ms","start":"2026-07-10T03:37:56.847013Z","end":"2026-07-10T03:37:57.26914Z","steps":["trace[444346293] 'process raft request' (duration: 421.874762ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:57.269401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:37:56.846995Z","time spent":"422.324974ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-10T03:37:58.336745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.497489ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-10T03:37:58.336843Z","caller":"traceutil/trace.go:171","msg":"trace[622806520] linearizableReadLoop","detail":"{readStateIndex:1138; appliedIndex:1137; }","duration":"379.215453ms","start":"2026-07-10T03:37:57.957601Z","end":"2026-07-10T03:37:58.336817Z","steps":["trace[622806520] 'read index received' (duration: 138.396025ms)","trace[622806520] 'applied index is now lower than readState.Index' (duration: 240.818428ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T03:37:58.336991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.438893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-10T03:37:58.337022Z","caller":"traceutil/trace.go:171","msg":"trace[1131556048] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1094; }","duration":"372.498775ms","start":"2026-07-10T03:37:57.964515Z","end":"2026-07-10T03:37:58.337014Z","steps":["trace[1131556048] 'agreement among raft nodes before linearized reading' (duration: 372.394522ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:58.337042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:37:57.964501Z","time spent":"372.536075ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-10T03:37:58.337021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.127605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-10T03:37:58.33707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.70679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-10T03:37:58.337068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.447109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-10T03:37:58.337095Z","caller":"traceutil/trace.go:171","msg":"trace[1460924402] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1094; }","duration":"298.257498ms","start":"2026-07-10T03:37:58.038819Z","end":"2026-07-10T03:37:58.337077Z","steps":["trace[1460924402] 'agreement among raft nodes before linearized reading' (duration: 298.112415ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:37:58.337131Z","caller":"traceutil/trace.go:171","msg":"trace[1835070963] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1094; }","duration":"338.797562ms","start":"2026-07-10T03:37:57.998318Z","end":"2026-07-10T03:37:58.337115Z","steps":["trace[1835070963] 'agreement among raft nodes before linearized reading' (duration: 338.70948ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:37:58.337147Z","caller":"traceutil/trace.go:171","msg":"trace[430116401] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1094; }","duration":"379.562532ms","start":"2026-07-10T03:37:57.957565Z","end":"2026-07-10T03:37:58.337127Z","steps":["trace[430116401] 'agreement among raft nodes before linearized reading' (duration: 379.325656ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:58.337171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:37:57.998302Z","time spent":"338.858564ms","remote":"127.0.0.1:47384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-10T03:37:58.337194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:37:57.957548Z","time spent":"379.633234ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-10T03:37:58.33718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.848817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-10T03:37:58.33726Z","caller":"traceutil/trace.go:171","msg":"trace[488742170] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1094; }","duration":"371.938249ms","start":"2026-07-10T03:37:57.965302Z","end":"2026-07-10T03:37:58.33724Z","steps":["trace[488742170] 'agreement among raft nodes before linearized reading' (duration: 371.749525ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:58.337318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:37:57.965298Z","time spent":"372.007921ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-10T03:37:58.337492Z","caller":"traceutil/trace.go:171","msg":"trace[1758590943] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"399.068258ms","start":"2026-07-10T03:37:57.938405Z","end":"2026-07-10T03:37:58.337473Z","steps":["trace[1758590943] 'process raft request' (duration: 157.610594ms)","trace[1758590943] 'compare' (duration: 240.402836ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T03:37:58.337781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:37:57.93838Z","time spent":"399.146881ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T03:37:59.642645Z","caller":"traceutil/trace.go:171","msg":"trace[855243878] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"365.12282ms","start":"2026-07-10T03:37:59.277451Z","end":"2026-07-10T03:37:59.642574Z","steps":["trace[855243878] 'process raft request' (duration: 364.964746ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:37:59.643035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:37:59.27744Z","time spent":"365.511889ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-10T03:38:16.168324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.122175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-10T03:38:16.168402Z","caller":"traceutil/trace.go:171","msg":"trace[1156104141] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1202; }","duration":"207.242019ms","start":"2026-07-10T03:38:15.961142Z","end":"2026-07-10T03:38:16.168384Z","steps":["trace[1156104141] 'range keys from in-memory index tree' (duration: 206.946801ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:16.168395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.563157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T03:38:16.168468Z","caller":"traceutil/trace.go:171","msg":"trace[953652743] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1202; }","duration":"170.67211ms","start":"2026-07-10T03:38:15.997777Z","end":"2026-07-10T03:38:16.168449Z","steps":["trace[953652743] 'range keys from in-memory index tree' (duration: 170.438123ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:38:16.707664Z","caller":"traceutil/trace.go:171","msg":"trace[1586129939] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"535.297445ms","start":"2026-07-10T03:38:16.172343Z","end":"2026-07-10T03:38:16.707641Z","steps":["trace[1586129939] 'process raft request' (duration: 535.1239ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:16.707809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:16.172318Z","time spent":"535.420408ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T03:38:16.819965Z","caller":"traceutil/trace.go:171","msg":"trace[50677631] linearizableReadLoop","detail":"{readStateIndex:1253; appliedIndex:1251; }","duration":"368.608132ms","start":"2026-07-10T03:38:16.451331Z","end":"2026-07-10T03:38:16.819939Z","steps":["trace[50677631] 'read index received' (duration: 256.188235ms)","trace[50677631] 'applied index is now lower than readState.Index' (duration: 112.418767ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T03:38:16.820098Z","caller":"traceutil/trace.go:171","msg":"trace[1903859031] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"425.836706ms","start":"2026-07-10T03:38:16.394219Z","end":"2026-07-10T03:38:16.820056Z","steps":["trace[1903859031] 'process raft request' (duration: 396.112889ms)","trace[1903859031] 'compare' (duration: 29.48778ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T03:38:16.820209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.862948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-10T03:38:16.820256Z","caller":"traceutil/trace.go:171","msg":"trace[1160913079] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1204; }","duration":"368.981251ms","start":"2026-07-10T03:38:16.45126Z","end":"2026-07-10T03:38:16.820241Z","steps":["trace[1160913079] 'agreement among raft nodes before linearized reading' (duration: 368.819847ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:16.820291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:16.3942Z","time spent":"425.987911ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-10T03:38:16.820327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.819154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-10T03:38:16.820377Z","caller":"traceutil/trace.go:171","msg":"trace[501148295] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1204; }","duration":"363.904167ms","start":"2026-07-10T03:38:16.456461Z","end":"2026-07-10T03:38:16.820365Z","steps":["trace[501148295] 'agreement among raft nodes before linearized reading' (duration: 363.769504ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:16.820406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:16.456442Z","time spent":"363.957329ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-10T03:38:16.820429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.003611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-10T03:38:16.820307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:16.451236Z","time spent":"369.058003ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-10T03:38:16.820474Z","caller":"traceutil/trace.go:171","msg":"trace[106007740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1204; }","duration":"355.080442ms","start":"2026-07-10T03:38:16.465384Z","end":"2026-07-10T03:38:16.820464Z","steps":["trace[106007740] 'agreement among raft nodes before linearized reading' (duration: 354.96895ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:16.82051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:16.465369Z","time spent":"355.134104ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-10T03:38:31.957581Z","caller":"traceutil/trace.go:171","msg":"trace[592065662] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"172.299913ms","start":"2026-07-10T03:38:31.785266Z","end":"2026-07-10T03:38:31.957566Z","steps":["trace[592065662] 'process raft request' (duration: 171.857671ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:32.269129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:31.963862Z","time spent":"305.260605ms","remote":"127.0.0.1:40478","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-10T03:38:33.055875Z","caller":"traceutil/trace.go:171","msg":"trace[489492876] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"279.076301ms","start":"2026-07-10T03:38:32.776777Z","end":"2026-07-10T03:38:33.055853Z","steps":["trace[489492876] 'process raft request' (duration: 278.943117ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:33.997522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.798765ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T03:38:33.997664Z","caller":"traceutil/trace.go:171","msg":"trace[432257702] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1277; }","duration":"357.966699ms","start":"2026-07-10T03:38:33.639676Z","end":"2026-07-10T03:38:33.997643Z","steps":["trace[432257702] 'range keys from in-memory index tree' (duration: 357.785214ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:33.997807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.027331ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-10T03:38:33.998072Z","caller":"traceutil/trace.go:171","msg":"trace[996706065] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"742.709209ms","start":"2026-07-10T03:38:33.255344Z","end":"2026-07-10T03:38:33.998053Z","steps":["trace[996706065] 'process raft request' (duration: 742.591585ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:38:33.998107Z","caller":"traceutil/trace.go:171","msg":"trace[602758662] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"1.102684222s","start":"2026-07-10T03:38:32.895401Z","end":"2026-07-10T03:38:33.998086Z","steps":["trace[602758662] 'process raft request' (duration: 528.241129ms)","trace[602758662] 'compare' (duration: 573.756095ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T03:38:33.998166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:33.255323Z","time spent":"742.802681ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T03:38:33.998145Z","caller":"traceutil/trace.go:171","msg":"trace[346096526] linearizableReadLoop","detail":"{readStateIndex:1331; appliedIndex:1329; }","duration":"1.101574593s","start":"2026-07-10T03:38:32.896548Z","end":"2026-07-10T03:38:33.998123Z","steps":["trace[346096526] 'read index received' (duration: 159.180536ms)","trace[346096526] 'applied index is now lower than readState.Index' (duration: 942.390977ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T03:38:33.998214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:32.895373Z","time spent":"1.102780885s","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-10T03:38:33.998343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.174179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-10T03:38:33.998367Z","caller":"traceutil/trace.go:171","msg":"trace[416492758] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1279; }","duration":"792.229921ms","start":"2026-07-10T03:38:33.20613Z","end":"2026-07-10T03:38:33.99836Z","steps":["trace[416492758] 'agreement among raft nodes before linearized reading' (duration: 792.175769ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:33.998368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.101825049s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-10T03:38:33.998394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.052978315s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-10T03:38:33.998424Z","caller":"traceutil/trace.go:171","msg":"trace[1595521404] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1279; }","duration":"1.101915561s","start":"2026-07-10T03:38:32.896496Z","end":"2026-07-10T03:38:33.998411Z","steps":["trace[1595521404] 'agreement among raft nodes before linearized reading' (duration: 1.101745007s)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:33.998444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.000499936s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T03:38:33.998502Z","caller":"traceutil/trace.go:171","msg":"trace[1997388257] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1279; }","duration":"1.000582948s","start":"2026-07-10T03:38:32.997905Z","end":"2026-07-10T03:38:33.998488Z","steps":["trace[1997388257] 'agreement among raft nodes before linearized reading' (duration: 1.000502206s)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:33.998547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:32.997891Z","time spent":"1.000646759s","remote":"127.0.0.1:47384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-10T03:38:33.998559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.01880107s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-10T03:38:33.998599Z","caller":"traceutil/trace.go:171","msg":"trace[1717104676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1279; }","duration":"1.018862861s","start":"2026-07-10T03:38:32.979724Z","end":"2026-07-10T03:38:33.998587Z","steps":["trace[1717104676] 'agreement among raft nodes before linearized reading' (duration: 1.018754189s)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:38:33.998455Z","caller":"traceutil/trace.go:171","msg":"trace[1754240279] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1279; }","duration":"1.053067908s","start":"2026-07-10T03:38:32.945373Z","end":"2026-07-10T03:38:33.998441Z","steps":["trace[1754240279] 'agreement among raft nodes before linearized reading' (duration: 1.052918474s)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:33.998644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:32.979713Z","time spent":"1.018921743s","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-10T03:38:33.998654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:32.945358Z","time spent":"1.053286813s","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-10T03:38:33.998385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:33.206111Z","time spent":"792.270451ms","remote":"127.0.0.1:53838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":4,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-07-10T03:38:33.998463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:32.896482Z","time spent":"1.101971532s","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-10T03:38:34.175652Z","caller":"traceutil/trace.go:171","msg":"trace[1926557200] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"171.476581ms","start":"2026-07-10T03:38:34.004156Z","end":"2026-07-10T03:38:34.175633Z","steps":["trace[1926557200] 'process raft request' (duration: 171.402939ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:38:34.175702Z","caller":"traceutil/trace.go:171","msg":"trace[2102971953] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"171.559713ms","start":"2026-07-10T03:38:34.004108Z","end":"2026-07-10T03:38:34.175668Z","steps":["trace[2102971953] 'process raft request' (duration: 112.133909ms)","trace[2102971953] 'compare' (duration: 59.212189ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T03:38:34.1758Z","caller":"traceutil/trace.go:171","msg":"trace[1107758253] linearizableReadLoop","detail":"{readStateIndex:1336; appliedIndex:1332; }","duration":"168.931273ms","start":"2026-07-10T03:38:34.006859Z","end":"2026-07-10T03:38:34.175791Z","steps":["trace[1107758253] 'read index received' (duration: 27.380305ms)","trace[1107758253] 'applied index is now lower than readState.Index' (duration: 141.550238ms)"],"step_count":2} {"level":"warn","ts":"2026-07-10T03:38:34.175881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.016835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T03:38:34.175908Z","caller":"traceutil/trace.go:171","msg":"trace[233711876] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1283; }","duration":"169.093678ms","start":"2026-07-10T03:38:34.006806Z","end":"2026-07-10T03:38:34.1759Z","steps":["trace[233711876] 'agreement among raft nodes before linearized reading' (duration: 169.023445ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:38:34.175925Z","caller":"traceutil/trace.go:171","msg":"trace[531956916] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"171.656747ms","start":"2026-07-10T03:38:34.004259Z","end":"2026-07-10T03:38:34.175916Z","steps":["trace[531956916] 'process raft request' (duration: 171.350009ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:34.513727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.49956ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-10T03:38:34.51394Z","caller":"traceutil/trace.go:171","msg":"trace[771890176] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"242.576343ms","start":"2026-07-10T03:38:34.271348Z","end":"2026-07-10T03:38:34.513924Z","steps":["trace[771890176] 'process raft request' (duration: 242.541003ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:38:34.514229Z","caller":"traceutil/trace.go:171","msg":"trace[1337803662] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"245.598344ms","start":"2026-07-10T03:38:34.26857Z","end":"2026-07-10T03:38:34.514168Z","steps":["trace[1337803662] 'process raft request' (duration: 30.59791ms)","trace[1337803662] 'compare' (duration: 214.376097ms)"],"step_count":2} {"level":"info","ts":"2026-07-10T03:38:34.514247Z","caller":"traceutil/trace.go:171","msg":"trace[582064306] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"243.694234ms","start":"2026-07-10T03:38:34.270517Z","end":"2026-07-10T03:38:34.514211Z","steps":["trace[582064306] 'process raft request' (duration: 243.315643ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:38:35.182786Z","caller":"traceutil/trace.go:171","msg":"trace[909132394] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"117.874783ms","start":"2026-07-10T03:38:35.064887Z","end":"2026-07-10T03:38:35.182762Z","steps":["trace[909132394] 'process raft request' (duration: 117.715418ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:38:42.138842Z","caller":"traceutil/trace.go:171","msg":"trace[1074871673] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"117.045431ms","start":"2026-07-10T03:38:42.021772Z","end":"2026-07-10T03:38:42.138817Z","steps":["trace[1074871673] 'process raft request' (duration: 116.895796ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:38:44.461265Z","caller":"traceutil/trace.go:171","msg":"trace[1784927813] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"406.68409ms","start":"2026-07-10T03:38:44.054548Z","end":"2026-07-10T03:38:44.461232Z","steps":["trace[1784927813] 'process raft request' (duration: 406.435654ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:44.461453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:44.054532Z","time spent":"406.827753ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-10T03:38:45.607068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.088955718s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-10T03:38:45.60719Z","caller":"traceutil/trace.go:171","msg":"trace[1247835842] linearizableReadLoop","detail":"{readStateIndex:1410; appliedIndex:1408; }","duration":"1.453297186s","start":"2026-07-10T03:38:44.153877Z","end":"2026-07-10T03:38:45.607175Z","steps":["trace[1247835842] 'read index received' (duration: 307.086981ms)","trace[1247835842] 'applied index is now lower than readState.Index' (duration: 1.146209095s)"],"step_count":2} {"level":"warn","ts":"2026-07-10T03:38:45.607412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.393051091s","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-07-10T03:38:45.607464Z","caller":"traceutil/trace.go:171","msg":"trace[1077022031] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1355; }","duration":"1.393144063s","start":"2026-07-10T03:38:44.214307Z","end":"2026-07-10T03:38:45.607451Z","steps":["trace[1077022031] 'agreement among raft nodes before linearized reading' (duration: 1.392960579s)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:45.6075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:44.214287Z","time spent":"1.393204095s","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-10T03:38:45.607742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.453865012s","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-07-10T03:38:45.60779Z","caller":"traceutil/trace.go:171","msg":"trace[1099793218] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1355; }","duration":"1.453939973s","start":"2026-07-10T03:38:44.153837Z","end":"2026-07-10T03:38:45.607777Z","steps":["trace[1099793218] 'agreement among raft nodes before linearized reading' (duration: 1.45383243s)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:38:45.607298Z","caller":"traceutil/trace.go:171","msg":"trace[759497362] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"1.463839105s","start":"2026-07-10T03:38:44.143415Z","end":"2026-07-10T03:38:45.607254Z","steps":["trace[759497362] 'process raft request' (duration: 374.62305ms)","trace[759497362] 'compare' (duration: 1.088793714s)"],"step_count":2} {"level":"warn","ts":"2026-07-10T03:38:45.608134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.844678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-07-10T03:38:45.608186Z","caller":"traceutil/trace.go:171","msg":"trace[477318655] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1355; }","duration":"729.92577ms","start":"2026-07-10T03:38:44.878245Z","end":"2026-07-10T03:38:45.608171Z","steps":["trace[477318655] 'agreement among raft nodes before linearized reading' (duration: 729.787337ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:45.608163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.124481679s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-07-10T03:38:45.608224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:44.878225Z","time spent":"729.991571ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-07-10T03:38:45.608207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.390485613s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-10T03:38:45.608256Z","caller":"traceutil/trace.go:171","msg":"trace[1500435578] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1355; }","duration":"1.124633723s","start":"2026-07-10T03:38:44.483598Z","end":"2026-07-10T03:38:45.608231Z","steps":["trace[1500435578] 'agreement among raft nodes before linearized reading' (duration: 1.124355146s)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:38:45.608287Z","caller":"traceutil/trace.go:171","msg":"trace[2137691318] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1355; }","duration":"1.390608856s","start":"2026-07-10T03:38:44.217658Z","end":"2026-07-10T03:38:45.608267Z","steps":["trace[2137691318] 'agreement among raft nodes before linearized reading' (duration: 1.39037371s)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:45.608314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:44.483573Z","time spent":"1.124729915s","remote":"127.0.0.1:41024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":161,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-07-10T03:38:45.608131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.535886ms","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-07-10T03:38:45.608527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:44.21764Z","time spent":"1.390876054s","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-10T03:38:45.608517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.392588079s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-07-10T03:38:45.60869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.082119338s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-07-10T03:38:45.60871Z","caller":"traceutil/trace.go:171","msg":"trace[894415117] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1355; }","duration":"1.39299925s","start":"2026-07-10T03:38:44.215678Z","end":"2026-07-10T03:38:45.608677Z","steps":["trace[894415117] 'agreement among raft nodes before linearized reading' (duration: 1.392317162s)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:45.608836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:44.215619Z","time spent":"1.393200654s","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-10T03:38:45.608735Z","caller":"traceutil/trace.go:171","msg":"trace[1273165249] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1355; }","duration":"1.082191499s","start":"2026-07-10T03:38:44.526533Z","end":"2026-07-10T03:38:45.608725Z","steps":["trace[1273165249] 'agreement among raft nodes before linearized reading' (duration: 1.081785128s)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:45.609239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:44.526523Z","time spent":"1.082700412s","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":495,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-07-10T03:38:45.60927Z","caller":"traceutil/trace.go:171","msg":"trace[733515366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1355; }","duration":"390.004578ms","start":"2026-07-10T03:38:45.218552Z","end":"2026-07-10T03:38:45.608557Z","steps":["trace[733515366] 'agreement among raft nodes before linearized reading' (duration: 389.486344ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:38:45.609334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:45.218535Z","time spent":"390.788109ms","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-10T03:38:45.607818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:44.153827Z","time spent":"1.453984855s","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-10T03:38:45.6079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-10T03:38:44.143391Z","time spent":"1.464466892s","remote":"127.0.0.1:40710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-10T03:38:45.7175Z","caller":"traceutil/trace.go:171","msg":"trace[1712847102] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"104.407045ms","start":"2026-07-10T03:38:45.613054Z","end":"2026-07-10T03:38:45.717461Z","steps":["trace[1712847102] 'process raft request' (duration: 104.102208ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:38:45.722875Z","caller":"traceutil/trace.go:171","msg":"trace[381420566] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"109.716136ms","start":"2026-07-10T03:38:45.613134Z","end":"2026-07-10T03:38:45.72285Z","steps":["trace[381420566] 'process raft request' (duration: 109.518531ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:38:45.722924Z","caller":"traceutil/trace.go:171","msg":"trace[578574117] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"108.674848ms","start":"2026-07-10T03:38:45.614232Z","end":"2026-07-10T03:38:45.722907Z","steps":["trace[578574117] 'process raft request' (duration: 108.571595ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:38:45.722966Z","caller":"traceutil/trace.go:171","msg":"trace[578287837] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"108.974766ms","start":"2026-07-10T03:38:45.613982Z","end":"2026-07-10T03:38:45.722957Z","steps":["trace[578287837] 'process raft request' (duration: 108.787791ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:38:45.723193Z","caller":"traceutil/trace.go:171","msg":"trace[958399331] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"109.262843ms","start":"2026-07-10T03:38:45.613907Z","end":"2026-07-10T03:38:45.72317Z","steps":["trace[958399331] 'process raft request' (duration: 108.827002ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:38:45.723218Z","caller":"traceutil/trace.go:171","msg":"trace[1737900558] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"108.908034ms","start":"2026-07-10T03:38:45.614278Z","end":"2026-07-10T03:38:45.723186Z","steps":["trace[1737900558] 'process raft request' (duration: 108.574795ms)"],"step_count":1} {"level":"info","ts":"2026-07-10T03:38:45.723339Z","caller":"traceutil/trace.go:171","msg":"trace[2120414005] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"108.448212ms","start":"2026-07-10T03:38:45.61488Z","end":"2026-07-10T03:38:45.723328Z","steps":["trace[2120414005] 'process raft request' (duration: 108.217496ms)"],"step_count":1} {"level":"warn","ts":"2026-07-10T03:42:53.217586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.652647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-10T03:42:53.217692Z","caller":"traceutil/trace.go:171","msg":"trace[2045966309] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2517; }","duration":"221.797851ms","start":"2026-07-10T03:42:52.995875Z","end":"2026-07-10T03:42:53.217673Z","steps":["trace[2045966309] 'range keys from in-memory index tree' (duration: 221.589296ms)"],"step_count":1}