{"level":"warn","ts":"2026-07-23T23:47:49.678175Z","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-23T23:47:49.678259Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223: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.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223: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-23T23:47:49.678326Z","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-23T23:47:49.678339Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-07-23T23:47:49.678356Z","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-23T23:47:49.678919Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]} {"level":"info","ts":"2026-07-23T23:47:49.678998Z","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.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223: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-23T23:47:49.685127Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.221186ms"} {"level":"info","ts":"2026-07-23T23:47:49.696204Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-07-23T23:47:49.696417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-07-23T23:47:49.696476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-07-23T23:47:49.696525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-23T23:47:49.696586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-07-23T23:47:49.696721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-07-23T23:47:49.702929Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-23T23:47:49.705685Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-23T23:47:49.70688Z","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-23T23:47:49.709853Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-23T23:47:49.710031Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-23T23:47:49.710267Z","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-23T23:47:49.710448Z","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-23T23:47:49.710586Z","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-23T23:47:49.710755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-07-23T23:47:49.710836Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-07-23T23:47:49.713898Z","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-23T23:47:49.714057Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-23T23:47:49.714086Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-23T23:47:49.714176Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-07-23T23:47:49.714199Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-07-23T23:47:50.597362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-07-23T23:47:50.59742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-23T23:47:50.597543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-07-23T23:47:50.597684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-07-23T23:47:50.597706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-07-23T23:47:50.597723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-07-23T23:47:50.597742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-07-23T23:47:50.598791Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:47:50.599919Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-23T23:47:50.599913Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"} {"level":"info","ts":"2026-07-23T23:47:50.600095Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-23T23:47:50.600414Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-23T23:47:50.600448Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-23T23:47:50.603067Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"info","ts":"2026-07-23T23:47:50.603644Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:47:50.603824Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:47:50.603879Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-23T23:47:50.605213Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-23T23:48:14.252257Z","caller":"traceutil/trace.go:171","msg":"trace[479559653] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:481; }","duration":"116.659157ms","start":"2026-07-23T23:48:14.135578Z","end":"2026-07-23T23:48:14.252237Z","steps":["trace[479559653] 'read index received' (duration: 116.363741ms)","trace[479559653] 'applied index is now lower than readState.Index' (duration: 294.786µs)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:48:14.252364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.771589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-23T23:48:14.25241Z","caller":"traceutil/trace.go:171","msg":"trace[495404007] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:466; }","duration":"116.867812ms","start":"2026-07-23T23:48:14.135535Z","end":"2026-07-23T23:48:14.252403Z","steps":["trace[495404007] 'agreement among raft nodes before linearized reading' (duration: 116.78773ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:48:14.253619Z","caller":"traceutil/trace.go:171","msg":"trace[1511630073] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"209.035922ms","start":"2026-07-23T23:48:14.04456Z","end":"2026-07-23T23:48:14.253596Z","steps":["trace[1511630073] 'process raft request' (duration: 207.408529ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:48:24.275593Z","caller":"traceutil/trace.go:171","msg":"trace[1183105704] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"120.686847ms","start":"2026-07-23T23:48:24.15488Z","end":"2026-07-23T23:48:24.275567Z","steps":["trace[1183105704] 'process raft request' (duration: 120.509584ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:25.418925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.177078ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:48:25.419059Z","caller":"traceutil/trace.go:171","msg":"trace[338927262] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"469.154282ms","start":"2026-07-23T23:48:24.949881Z","end":"2026-07-23T23:48:25.419036Z","steps":["trace[338927262] 'process raft request' (duration: 39.23497ms)","trace[338927262] 'compare' (duration: 429.015975ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:48:25.419127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:24.949863Z","time spent":"469.231263ms","remote":"127.0.0.1:45956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:48:25.445515Z","caller":"traceutil/trace.go:171","msg":"trace[1293129956] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"491.389053ms","start":"2026-07-23T23:48:24.954103Z","end":"2026-07-23T23:48:25.445492Z","steps":["trace[1293129956] 'process raft request' (duration: 490.380524ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:48:25.44589Z","caller":"traceutil/trace.go:171","msg":"trace[1819121591] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"467.434155ms","start":"2026-07-23T23:48:24.978447Z","end":"2026-07-23T23:48:25.445881Z","steps":["trace[1819121591] 'process raft request' (duration: 467.016358ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:48:25.445919Z","caller":"traceutil/trace.go:171","msg":"trace[1781880342] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"481.075926ms","start":"2026-07-23T23:48:24.964378Z","end":"2026-07-23T23:48:25.445453Z","steps":["trace[1781880342] 'process raft request' (duration: 480.281891ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:25.446202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:24.978413Z","time spent":"467.527547ms","remote":"127.0.0.1:45956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:48:25.446241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:24.96436Z","time spent":"481.599036ms","remote":"127.0.0.1:46412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:48:25.445555Z","caller":"traceutil/trace.go:171","msg":"trace[110395848] transaction","detail":"{read_only:false; number_of_response:0; response_revision:540; }","duration":"477.014669ms","start":"2026-07-23T23:48:24.968501Z","end":"2026-07-23T23:48:25.445515Z","steps":["trace[110395848] 'process raft request' (duration: 476.194063ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:25.446427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:24.968481Z","time spent":"477.918125ms","remote":"127.0.0.1:46412","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-23T23:48:25.445652Z","caller":"traceutil/trace.go:171","msg":"trace[1113742396] transaction","detail":"{read_only:false; number_of_response:1; response_revision:540; }","duration":"476.909226ms","start":"2026-07-23T23:48:24.96873Z","end":"2026-07-23T23:48:25.445639Z","steps":["trace[1113742396] 'process raft request' (duration: 475.993119ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:25.446608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:24.968725Z","time spent":"477.752543ms","remote":"127.0.0.1:45956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7365,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:48:25.445782Z","caller":"traceutil/trace.go:171","msg":"trace[434238572] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"464.146672ms","start":"2026-07-23T23:48:24.981611Z","end":"2026-07-23T23:48:25.445757Z","steps":["trace[434238572] 'process raft request' (duration: 464.02904ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:48:25.445747Z","caller":"traceutil/trace.go:171","msg":"trace[1513042401] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"481.379122ms","start":"2026-07-23T23:48:24.964336Z","end":"2026-07-23T23:48:25.445715Z","steps":["trace[1513042401] 'process raft request' (duration: 480.268171ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:25.446895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:24.96431Z","time spent":"482.525794ms","remote":"127.0.0.1:45956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:48:25.445851Z","caller":"traceutil/trace.go:171","msg":"trace[1594114724] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"474.010461ms","start":"2026-07-23T23:48:24.97183Z","end":"2026-07-23T23:48:25.445841Z","steps":["trace[1594114724] 'process raft request' (duration: 473.533562ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:25.446932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:24.981582Z","time spent":"465.246733ms","remote":"127.0.0.1:45956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:48:25.447022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:24.971822Z","time spent":"475.171853ms","remote":"127.0.0.1:45956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:48:25.445848Z","caller":"traceutil/trace.go:171","msg":"trace[1061135770] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"475.53525ms","start":"2026-07-23T23:48:24.970302Z","end":"2026-07-23T23:48:25.445837Z","steps":["trace[1061135770] 'process raft request' (duration: 474.988489ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:25.447124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:24.970293Z","time spent":"476.811725ms","remote":"127.0.0.1:45956","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-23T23:48:25.445872Z","caller":"traceutil/trace.go:171","msg":"trace[666107458] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"476.354006ms","start":"2026-07-23T23:48:24.969508Z","end":"2026-07-23T23:48:25.445862Z","steps":["trace[666107458] 'process raft request' (duration: 475.589372ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:25.445989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:24.954084Z","time spent":"491.843942ms","remote":"127.0.0.1:46412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:48:25.447387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:24.969501Z","time spent":"477.745052ms","remote":"127.0.0.1:45956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:48:25.447429Z","caller":"traceutil/trace.go:171","msg":"trace[1735057166] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"478.361223ms","start":"2026-07-23T23:48:24.969049Z","end":"2026-07-23T23:48:25.44741Z","steps":["trace[1735057166] 'process raft request' (duration: 475.737434ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:25.447495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:24.969043Z","time spent":"478.416864ms","remote":"127.0.0.1:45956","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-23T23:48:25.458173Z","caller":"traceutil/trace.go:171","msg":"trace[551710384] linearizableReadLoop","detail":"{readStateIndex:567; appliedIndex:566; }","duration":"109.792245ms","start":"2026-07-23T23:48:25.348343Z","end":"2026-07-23T23:48:25.458135Z","steps":["trace[551710384] 'read index received' (duration: 97.540593ms)","trace[551710384] 'applied index is now lower than readState.Index' (duration: 12.250402ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:48:25.458292Z","caller":"traceutil/trace.go:171","msg":"trace[864679130] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"367.518413ms","start":"2026-07-23T23:48:25.090765Z","end":"2026-07-23T23:48:25.458283Z","steps":["trace[864679130] 'process raft request' (duration: 367.203917ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:25.45838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:25.09074Z","time spent":"367.590115ms","remote":"127.0.0.1:45956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:48:25.458627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.288445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:48:25.458659Z","caller":"traceutil/trace.go:171","msg":"trace[685460005] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:547; }","duration":"110.362117ms","start":"2026-07-23T23:48:25.348284Z","end":"2026-07-23T23:48:25.458646Z","steps":["trace[685460005] 'agreement among raft nodes before linearized reading' (duration: 110.249005ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:31.491544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.632337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-77b6m\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-23T23:48:31.491628Z","caller":"traceutil/trace.go:171","msg":"trace[285298974] range","detail":"{range_begin:/registry/pods/kube-system/cilium-77b6m; range_end:; response_count:1; response_revision:630; }","duration":"395.745289ms","start":"2026-07-23T23:48:31.095861Z","end":"2026-07-23T23:48:31.491606Z","steps":["trace[285298974] 'range keys from in-memory index tree' (duration: 395.470744ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:31.491667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:31.095846Z","time spent":"395.81225ms","remote":"127.0.0.1:46060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-77b6m\" "} {"level":"info","ts":"2026-07-23T23:48:31.631456Z","caller":"traceutil/trace.go:171","msg":"trace[1125708107] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"405.996487ms","start":"2026-07-23T23:48:31.225428Z","end":"2026-07-23T23:48:31.631424Z","steps":["trace[1125708107] 'process raft request' (duration: 405.410476ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:31.631741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:31.225412Z","time spent":"406.125599ms","remote":"127.0.0.1:45996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:48:32.23858Z","caller":"traceutil/trace.go:171","msg":"trace[110722855] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"728.771141ms","start":"2026-07-23T23:48:31.509784Z","end":"2026-07-23T23:48:32.238555Z","steps":["trace[110722855] 'process raft request' (duration: 728.603808ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:32.238745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:31.509748Z","time spent":"728.905424ms","remote":"127.0.0.1:46060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:48:32.256788Z","caller":"traceutil/trace.go:171","msg":"trace[1526919239] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:653; }","duration":"386.571845ms","start":"2026-07-23T23:48:31.869988Z","end":"2026-07-23T23:48:32.25656Z","steps":["trace[1526919239] 'read index received' (duration: 368.401673ms)","trace[1526919239] 'applied index is now lower than readState.Index' (duration: 18.168692ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:48:32.256951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.938212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:48:32.256992Z","caller":"traceutil/trace.go:171","msg":"trace[1337080424] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"387.034624ms","start":"2026-07-23T23:48:31.869945Z","end":"2026-07-23T23:48:32.256979Z","steps":["trace[1337080424] 'agreement among raft nodes before linearized reading' (duration: 386.917052ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:32.257034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:31.869925Z","time spent":"387.101145ms","remote":"127.0.0.1:45902","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-23T23:48:32.257245Z","caller":"traceutil/trace.go:171","msg":"trace[2102457372] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"572.055517ms","start":"2026-07-23T23:48:31.68513Z","end":"2026-07-23T23:48:32.257185Z","steps":["trace[2102457372] 'process raft request' (duration: 571.302103ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:32.257477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:31.685105Z","time spent":"572.306112ms","remote":"127.0.0.1:46398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-23T23:48:32.840792Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521227718487393657,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-23T23:48:33.341981Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521227718487393657,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-23T23:48:33.404283Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.089297571s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-23T23:48:34.199876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:32.779928Z","time spent":"1.419940017s","remote":"127.0.0.1:54880","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-23T23:48:34.200054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.72629349s","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-23T23:48:34.200205Z","caller":"traceutil/trace.go:171","msg":"trace[1381204481] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:633; }","duration":"1.726430383s","start":"2026-07-23T23:48:32.473731Z","end":"2026-07-23T23:48:34.200161Z","steps":["trace[1381204481] 'range keys from in-memory index tree' (duration: 1.72627835s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:34.200654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.955089ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:48:34.201184Z","caller":"traceutil/trace.go:171","msg":"trace[966558482] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"1.886304018s","start":"2026-07-23T23:48:32.314852Z","end":"2026-07-23T23:48:34.201156Z","steps":["trace[966558482] 'process raft request' (duration: 1.089757319s)","trace[966558482] 'compare' (duration: 795.348697ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:48:34.201331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:32.314817Z","time spent":"1.886431631s","remote":"127.0.0.1:46136","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-23T23:48:34.201545Z","caller":"traceutil/trace.go:171","msg":"trace[756512334] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"1.548882396s","start":"2026-07-23T23:48:32.652642Z","end":"2026-07-23T23:48:34.201524Z","steps":["trace[756512334] 'process raft request' (duration: 1.548299685s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:34.201616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:32.652617Z","time spent":"1.548964688s","remote":"127.0.0.1:45996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-23T23:48:34.201707Z","caller":"traceutil/trace.go:171","msg":"trace[1101447834] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:655; }","duration":"1.861680268s","start":"2026-07-23T23:48:32.34001Z","end":"2026-07-23T23:48:34.20169Z","steps":["trace[1101447834] 'read index received' (duration: 1.064545128s)","trace[1101447834] 'applied index is now lower than readState.Index' (duration: 797.13407ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:48:34.201749Z","caller":"traceutil/trace.go:171","msg":"trace[220583634] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"1.264483052s","start":"2026-07-23T23:48:32.937252Z","end":"2026-07-23T23:48:34.201736Z","steps":["trace[220583634] 'process raft request' (duration: 1.264221128s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:34.201813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:32.93721Z","time spent":"1.264564754s","remote":"127.0.0.1:46136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:48:34.201885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.861878421s","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-23T23:48:34.201918Z","caller":"traceutil/trace.go:171","msg":"trace[1439235551] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"1.861952883s","start":"2026-07-23T23:48:32.339956Z","end":"2026-07-23T23:48:34.201909Z","steps":["trace[1439235551] 'agreement among raft nodes before linearized reading' (duration: 1.86182547s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:34.201926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.860278852s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-23T23:48:34.201953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:32.339939Z","time spent":"1.862006623s","remote":"127.0.0.1:46136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-23T23:48:34.201966Z","caller":"traceutil/trace.go:171","msg":"trace[946157976] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:636; }","duration":"1.860342763s","start":"2026-07-23T23:48:32.341611Z","end":"2026-07-23T23:48:34.201954Z","steps":["trace[946157976] 'agreement among raft nodes before linearized reading' (duration: 1.860233331s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:34.201982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.972966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.223\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-23T23:48:34.201973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.258578655s","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-23T23:48:34.202002Z","caller":"traceutil/trace.go:171","msg":"trace[1088060745] range","detail":"{range_begin:/registry/masterleases/199.204.45.223; range_end:; response_count:1; response_revision:636; }","duration":"781.027936ms","start":"2026-07-23T23:48:33.420968Z","end":"2026-07-23T23:48:34.201996Z","steps":["trace[1088060745] 'agreement among raft nodes before linearized reading' (duration: 780.988815ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:48:34.202013Z","caller":"traceutil/trace.go:171","msg":"trace[866586294] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:636; }","duration":"1.258661035s","start":"2026-07-23T23:48:32.943341Z","end":"2026-07-23T23:48:34.202002Z","steps":["trace[866586294] 'agreement among raft nodes before linearized reading' (duration: 1.258523813s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:34.202022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:33.420949Z","time spent":"781.068427ms","remote":"127.0.0.1:45940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.223\" "} {"level":"warn","ts":"2026-07-23T23:48:34.202036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.331385307s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-23T23:48:34.202045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:32.943316Z","time spent":"1.258722647s","remote":"127.0.0.1:46136","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-23T23:48:34.202062Z","caller":"traceutil/trace.go:171","msg":"trace[1070502632] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"1.331426947s","start":"2026-07-23T23:48:32.870626Z","end":"2026-07-23T23:48:34.202053Z","steps":["trace[1070502632] 'agreement among raft nodes before linearized reading' (duration: 1.331389946s)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:34.201998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:32.341597Z","time spent":"1.860392814s","remote":"127.0.0.1:46136","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-23T23:48:34.202089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:32.870615Z","time spent":"1.331467488s","remote":"127.0.0.1:45894","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-23T23:48:35.604322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.249039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:48:35.604879Z","caller":"traceutil/trace.go:171","msg":"trace[604910197] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:650; }","duration":"255.869549ms","start":"2026-07-23T23:48:35.348976Z","end":"2026-07-23T23:48:35.604845Z","steps":["trace[604910197] 'range keys from in-memory index tree' (duration: 255.149846ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:48:50.071387Z","caller":"traceutil/trace.go:171","msg":"trace[49539938] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"868.100147ms","start":"2026-07-23T23:48:49.203263Z","end":"2026-07-23T23:48:50.071363Z","steps":["trace[49539938] 'process raft request' (duration: 867.869863ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:50.071707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-23T23:48:49.203244Z","time spent":"868.222839ms","remote":"127.0.0.1:46060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-23T23:48:50.086288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.54405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-23T23:48:50.086424Z","caller":"traceutil/trace.go:171","msg":"trace[239960926] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:798; }","duration":"215.743462ms","start":"2026-07-23T23:48:49.870639Z","end":"2026-07-23T23:48:50.086382Z","steps":["trace[239960926] 'agreement among raft nodes before linearized reading' (duration: 215.560099ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:48:50.086063Z","caller":"traceutil/trace.go:171","msg":"trace[1410765612] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:824; }","duration":"215.336835ms","start":"2026-07-23T23:48:49.870702Z","end":"2026-07-23T23:48:50.086039Z","steps":["trace[1410765612] 'read index received' (duration: 200.424015ms)","trace[1410765612] 'applied index is now lower than readState.Index' (duration: 14.91117ms)"],"step_count":2} {"level":"warn","ts":"2026-07-23T23:48:50.087052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.567657ms","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-23T23:48:50.087089Z","caller":"traceutil/trace.go:171","msg":"trace[1446541338] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:798; }","duration":"171.645449ms","start":"2026-07-23T23:48:49.915433Z","end":"2026-07-23T23:48:50.087078Z","steps":["trace[1446541338] 'agreement among raft nodes before linearized reading' (duration: 171.515727ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:48:57.632477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.01911ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-23T23:48:57.632892Z","caller":"traceutil/trace.go:171","msg":"trace[1862257338] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"215.817331ms","start":"2026-07-23T23:48:57.41675Z","end":"2026-07-23T23:48:57.632567Z","steps":["trace[1862257338] 'process raft request' (duration: 98.631389ms)","trace[1862257338] 'compare' (duration: 116.878557ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:49:04.375467Z","caller":"traceutil/trace.go:171","msg":"trace[1152551335] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"110.479886ms","start":"2026-07-23T23:49:04.264937Z","end":"2026-07-23T23:49:04.375417Z","steps":["trace[1152551335] 'process raft request' (duration: 110.332783ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:19.994838Z","caller":"traceutil/trace.go:171","msg":"trace[925164048] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"115.055259ms","start":"2026-07-23T23:49:19.879755Z","end":"2026-07-23T23:49:19.994811Z","steps":["trace[925164048] 'process raft request' (duration: 114.849246ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:20.730771Z","caller":"traceutil/trace.go:171","msg":"trace[541369271] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"166.064492ms","start":"2026-07-23T23:49:20.56468Z","end":"2026-07-23T23:49:20.730745Z","steps":["trace[541369271] 'process raft request' (duration: 166.021512ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:20.730855Z","caller":"traceutil/trace.go:171","msg":"trace[558054598] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"167.323681ms","start":"2026-07-23T23:49:20.563487Z","end":"2026-07-23T23:49:20.730811Z","steps":["trace[558054598] 'process raft request' (duration: 166.56617ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:49:51.119902Z","caller":"traceutil/trace.go:171","msg":"trace[1700334374] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"216.862032ms","start":"2026-07-23T23:49:50.902993Z","end":"2026-07-23T23:49:51.119855Z","steps":["trace[1700334374] 'process raft request' (duration: 149.820595ms)","trace[1700334374] 'compare' (duration: 66.850814ms)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:49:51.121729Z","caller":"traceutil/trace.go:171","msg":"trace[854692731] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"127.48095ms","start":"2026-07-23T23:49:50.994219Z","end":"2026-07-23T23:49:51.1217Z","steps":["trace[854692731] 'process raft request' (duration: 127.351389ms)"],"step_count":1} {"level":"info","ts":"2026-07-23T23:50:13.470367Z","caller":"traceutil/trace.go:171","msg":"trace[1356846772] linearizableReadLoop","detail":"{readStateIndex:1250; appliedIndex:1249; }","duration":"155.966308ms","start":"2026-07-23T23:50:13.314382Z","end":"2026-07-23T23:50:13.470349Z","steps":["trace[1356846772] 'read index received' (duration: 155.800576ms)","trace[1356846772] 'applied index is now lower than readState.Index' (duration: 165.202µs)"],"step_count":2} {"level":"info","ts":"2026-07-23T23:50:13.470421Z","caller":"traceutil/trace.go:171","msg":"trace[349812982] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"158.075947ms","start":"2026-07-23T23:50:13.312316Z","end":"2026-07-23T23:50:13.470392Z","steps":["trace[349812982] 'process raft request' (duration: 157.915164ms)"],"step_count":1} {"level":"warn","ts":"2026-07-23T23:50:13.470564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.174151ms","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-23T23:50:13.470586Z","caller":"traceutil/trace.go:171","msg":"trace[1708773148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1204; }","duration":"156.273022ms","start":"2026-07-23T23:50:13.314307Z","end":"2026-07-23T23:50:13.47058Z","steps":["trace[1708773148] 'agreement among raft nodes before linearized reading' (duration: 156.13906ms)"],"step_count":1}