{"level":"warn","ts":"2026-07-13T12:31:02.039491Z","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-13T12:31:02.039588Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-13T12:31:02.03967Z","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-13T12:31:02.039684Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-07-13T12:31:02.039703Z","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-13T12:31:02.040375Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-07-13T12:31:02.040458Z","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.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-13T12:31:02.045023Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.338436ms"} {"level":"info","ts":"2026-07-13T12:31:02.054938Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-07-13T12:31:02.055027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-07-13T12:31:02.055049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-07-13T12:31:02.055064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-13T12:31:02.055073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-07-13T12:31:02.055109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-07-13T12:31:02.061443Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-13T12:31:02.062974Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-13T12:31:02.064097Z","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-13T12:31:02.067365Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-13T12:31:02.067758Z","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-13T12:31:02.067851Z","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-13T12:31:02.067868Z","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-13T12:31:02.067978Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-13T12:31:02.070133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-07-13T12:31:02.07036Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-07-13T12:31:02.073325Z","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-13T12:31:02.073449Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-07-13T12:31:02.073493Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-07-13T12:31:02.073626Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-13T12:31:02.073663Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-13T12:31:02.656165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-07-13T12:31:02.656277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-07-13T12:31:02.656326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-07-13T12:31:02.656346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-07-13T12:31:02.656357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-07-13T12:31:02.656372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-07-13T12:31:02.656385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-07-13T12:31:02.657531Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-13T12:31:02.658278Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-07-13T12:31:02.658503Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-13T12:31:02.660563Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-13T12:31:02.660755Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-07-13T12:31:02.660863Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-13T12:31:02.660889Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-13T12:31:02.663242Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-13T12:31:02.663298Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-13T12:31:02.664241Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-13T12:31:02.664248Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"warn","ts":"2026-07-13T12:31:06.212619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"990.134115ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-13T12:31:06.212746Z","caller":"traceutil/trace.go:171","msg":"trace[1340992370] transaction","detail":"{read_only:false; response_revision:122; number_of_response:1; }","duration":"1.136542402s","start":"2026-07-13T12:31:05.076184Z","end":"2026-07-13T12:31:06.212726Z","steps":["trace[1340992370] 'process raft request' (duration: 145.526204ms)","trace[1340992370] 'compare' (duration: 989.985411ms)"],"step_count":2} {"level":"warn","ts":"2026-07-13T12:31:06.212838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:05.076168Z","time spent":"1.136640355s","remote":"127.0.0.1:39342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":822,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-13T12:31:06.213361Z","caller":"traceutil/trace.go:171","msg":"trace[1319636643] linearizableReadLoop","detail":"{readStateIndex:127; appliedIndex:126; }","duration":"374.188407ms","start":"2026-07-13T12:31:05.839145Z","end":"2026-07-13T12:31:06.213333Z","steps":["trace[1319636643] 'read index received' (duration: 374.056133ms)","trace[1319636643] 'applied index is now lower than readState.Index' (duration: 131.234µs)"],"step_count":2} {"level":"info","ts":"2026-07-13T12:31:06.213517Z","caller":"traceutil/trace.go:171","msg":"trace[1266737686] transaction","detail":"{read_only:false; response_revision:123; number_of_response:1; }","duration":"574.690839ms","start":"2026-07-13T12:31:05.6388Z","end":"2026-07-13T12:31:06.213491Z","steps":["trace[1266737686] 'process raft request' (duration: 574.454303ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:06.213613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:05.638783Z","time spent":"574.77579ms","remote":"127.0.0.1:39168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-13T12:31:06.213909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.749002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-13T12:31:06.213965Z","caller":"traceutil/trace.go:171","msg":"trace[2032371339] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:123; }","duration":"374.845964ms","start":"2026-07-13T12:31:05.839105Z","end":"2026-07-13T12:31:06.213951Z","steps":["trace[2032371339] 'agreement among raft nodes before linearized reading' (duration: 374.637669ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:06.214012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:05.839086Z","time spent":"374.915396ms","remote":"127.0.0.1:38960","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-13T12:31:06.214251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.931073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:430"} {"level":"info","ts":"2026-07-13T12:31:06.2143Z","caller":"traceutil/trace.go:171","msg":"trace[182223710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:123; }","duration":"246.003056ms","start":"2026-07-13T12:31:05.968282Z","end":"2026-07-13T12:31:06.214285Z","steps":["trace[182223710] 'agreement among raft nodes before linearized reading' (duration: 245.920844ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:40.67219Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312674514611095,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-13T12:31:40.855918Z","caller":"traceutil/trace.go:171","msg":"trace[753561971] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"912.429311ms","start":"2026-07-13T12:31:39.943471Z","end":"2026-07-13T12:31:40.8559Z","steps":["trace[753561971] 'process raft request' (duration: 912.322288ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:40.856028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:39.94345Z","time spent":"912.522744ms","remote":"127.0.0.1:39028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-13T12:31:40.86266Z","caller":"traceutil/trace.go:171","msg":"trace[1259284882] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:554; }","duration":"691.412731ms","start":"2026-07-13T12:31:40.171234Z","end":"2026-07-13T12:31:40.862646Z","steps":["trace[1259284882] 'read index received' (duration: 685.110553ms)","trace[1259284882] 'applied index is now lower than readState.Index' (duration: 6.301618ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T12:31:40.862823Z","caller":"traceutil/trace.go:171","msg":"trace[343705938] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"917.598669ms","start":"2026-07-13T12:31:39.945214Z","end":"2026-07-13T12:31:40.862812Z","steps":["trace[343705938] 'process raft request' (duration: 916.9004ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:40.862883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:39.945168Z","time spent":"917.682421ms","remote":"127.0.0.1:39028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-13T12:31:40.862989Z","caller":"traceutil/trace.go:171","msg":"trace[1791553301] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"915.015089ms","start":"2026-07-13T12:31:39.947964Z","end":"2026-07-13T12:31:40.862979Z","steps":["trace[1791553301] 'process raft request' (duration: 914.210628ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:40.863029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:39.947956Z","time spent":"915.052211ms","remote":"127.0.0.1:39028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-13T12:31:40.863027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.484248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-13T12:31:40.863146Z","caller":"traceutil/trace.go:171","msg":"trace[1874730553] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"911.586018ms","start":"2026-07-13T12:31:39.951554Z","end":"2026-07-13T12:31:40.86314Z","steps":["trace[1874730553] 'process raft request' (duration: 910.654563ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:31:40.863096Z","caller":"traceutil/trace.go:171","msg":"trace[1325277730] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:545; }","duration":"412.56458ms","start":"2026-07-13T12:31:40.450515Z","end":"2026-07-13T12:31:40.863079Z","steps":["trace[1325277730] 'agreement among raft nodes before linearized reading' (duration: 412.377506ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:40.863187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:39.951546Z","time spent":"911.619859ms","remote":"127.0.0.1:39028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-13T12:31:40.863195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:40.450409Z","time spent":"412.777115ms","remote":"127.0.0.1:39254","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-13T12:31:40.863266Z","caller":"traceutil/trace.go:171","msg":"trace[1376443359] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"905.096235ms","start":"2026-07-13T12:31:39.958158Z","end":"2026-07-13T12:31:40.863255Z","steps":["trace[1376443359] 'process raft request' (duration: 904.090098ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:40.863308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:39.958145Z","time spent":"905.142736ms","remote":"127.0.0.1:39028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-13T12:31:40.863407Z","caller":"traceutil/trace.go:171","msg":"trace[10257682] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"895.832007ms","start":"2026-07-13T12:31:39.967567Z","end":"2026-07-13T12:31:40.863399Z","steps":["trace[10257682] 'process raft request' (duration: 894.717198ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:40.863433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.196503ms","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-13T12:31:40.863456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:39.967546Z","time spent":"895.889178ms","remote":"127.0.0.1:39028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-13T12:31:40.863463Z","caller":"traceutil/trace.go:171","msg":"trace[69042103] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:545; }","duration":"245.258766ms","start":"2026-07-13T12:31:40.618195Z","end":"2026-07-13T12:31:40.863454Z","steps":["trace[69042103] 'agreement among raft nodes before linearized reading' (duration: 245.172923ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:31:40.863569Z","caller":"traceutil/trace.go:171","msg":"trace[293184486] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"893.114896ms","start":"2026-07-13T12:31:39.970445Z","end":"2026-07-13T12:31:40.86356Z","steps":["trace[293184486] 'process raft request' (duration: 891.868172ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:40.863616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:39.970425Z","time spent":"893.170666ms","remote":"127.0.0.1:39028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-13T12:31:40.863625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.765646ms","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-13T12:31:40.863652Z","caller":"traceutil/trace.go:171","msg":"trace[540232794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:545; }","duration":"388.838398ms","start":"2026-07-13T12:31:40.474805Z","end":"2026-07-13T12:31:40.863644Z","steps":["trace[540232794] 'agreement among raft nodes before linearized reading' (duration: 388.765906ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:40.863688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:40.474783Z","time spent":"388.89884ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-13T12:31:40.863734Z","caller":"traceutil/trace.go:171","msg":"trace[77180206] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"893.250479ms","start":"2026-07-13T12:31:39.970471Z","end":"2026-07-13T12:31:40.863722Z","steps":["trace[77180206] 'process raft request' (duration: 891.879092ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:40.86378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:39.970461Z","time spent":"893.29812ms","remote":"127.0.0.1:39028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-13T12:31:40.863925Z","caller":"traceutil/trace.go:171","msg":"trace[16264432] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"885.723277ms","start":"2026-07-13T12:31:39.978182Z","end":"2026-07-13T12:31:40.863906Z","steps":["trace[16264432] 'process raft request' (duration: 884.207867ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:40.864009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:39.978175Z","time spent":"885.787629ms","remote":"127.0.0.1:39028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-13T12:31:40.864086Z","caller":"traceutil/trace.go:171","msg":"trace[1250314975] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"882.844001ms","start":"2026-07-13T12:31:39.981233Z","end":"2026-07-13T12:31:40.864077Z","steps":["trace[1250314975] 'process raft request' (duration: 881.197617ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:40.864135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:39.981218Z","time spent":"882.892472ms","remote":"127.0.0.1:39028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-13T12:31:40.864707Z","caller":"traceutil/trace.go:171","msg":"trace[1797611545] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"732.858798ms","start":"2026-07-13T12:31:40.131828Z","end":"2026-07-13T12:31:40.864687Z","steps":["trace[1797611545] 'process raft request' (duration: 730.761762ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:40.864787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:40.131803Z","time spent":"732.955151ms","remote":"127.0.0.1:39028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-13T12:31:40.864797Z","caller":"traceutil/trace.go:171","msg":"trace[1298435838] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"874.103047ms","start":"2026-07-13T12:31:39.990636Z","end":"2026-07-13T12:31:40.864739Z","steps":["trace[1298435838] 'process raft request' (duration: 871.834907ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:40.864847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.60339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-13T12:31:40.864903Z","caller":"traceutil/trace.go:171","msg":"trace[157413316] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:545; }","duration":"693.708663ms","start":"2026-07-13T12:31:40.171183Z","end":"2026-07-13T12:31:40.864892Z","steps":["trace[157413316] 'agreement among raft nodes before linearized reading' (duration: 693.603239ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:40.864951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:40.171161Z","time spent":"693.779725ms","remote":"127.0.0.1:39254","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-13T12:31:40.865912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:39.990619Z","time spent":"874.277512ms","remote":"127.0.0.1:39028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-13T12:31:48.613259Z","caller":"traceutil/trace.go:171","msg":"trace[1258386288] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"573.252559ms","start":"2026-07-13T12:31:48.039976Z","end":"2026-07-13T12:31:48.613228Z","steps":["trace[1258386288] 'process raft request' (duration: 573.027933ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:48.613426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:48.039934Z","time spent":"573.414683ms","remote":"127.0.0.1:39168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-13T12:31:48.783877Z","caller":"traceutil/trace.go:171","msg":"trace[602173495] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"165.58531ms","start":"2026-07-13T12:31:48.618275Z","end":"2026-07-13T12:31:48.78386Z","steps":["trace[602173495] 'process raft request' (duration: 94.138223ms)","trace[602173495] 'compare' (duration: 71.315794ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T12:31:48.78409Z","caller":"traceutil/trace.go:171","msg":"trace[2000293741] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"165.774604ms","start":"2026-07-13T12:31:48.618306Z","end":"2026-07-13T12:31:48.784081Z","steps":["trace[2000293741] 'process raft request' (duration: 165.515658ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:31:48.784289Z","caller":"traceutil/trace.go:171","msg":"trace[1071937294] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"163.466602ms","start":"2026-07-13T12:31:48.620772Z","end":"2026-07-13T12:31:48.784238Z","steps":["trace[1071937294] 'process raft request' (duration: 163.283188ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:49.423011Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312674514611350,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-13T12:31:49.923431Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312674514611350,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-13T12:31:49.954168Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.056799474s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-13T12:31:50.783807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.198139ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-13T12:31:50.783904Z","caller":"traceutil/trace.go:171","msg":"trace[1701223440] linearizableReadLoop","detail":"{readStateIndex:680; appliedIndex:679; }","duration":"1.861336597s","start":"2026-07-13T12:31:48.922552Z","end":"2026-07-13T12:31:50.783889Z","steps":["trace[1701223440] 'read index received' (duration: 1.031769688s)","trace[1701223440] 'applied index is now lower than readState.Index' (duration: 829.565869ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T12:31:50.783987Z","caller":"traceutil/trace.go:171","msg":"trace[1495308028] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"1.886727044s","start":"2026-07-13T12:31:48.897245Z","end":"2026-07-13T12:31:50.783972Z","steps":["trace[1495308028] 'process raft request' (duration: 1.057168975s)","trace[1495308028] 'compare' (duration: 828.998014ms)"],"step_count":2} {"level":"warn","ts":"2026-07-13T12:31:50.784072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:48.897219Z","time spent":"1.886802197s","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-13T12:31:50.784206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.861646805s","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-13T12:31:50.784249Z","caller":"traceutil/trace.go:171","msg":"trace[1241586846] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:653; }","duration":"1.861741437s","start":"2026-07-13T12:31:48.922492Z","end":"2026-07-13T12:31:50.784234Z","steps":["trace[1241586846] 'agreement among raft nodes before linearized reading' (duration: 1.861616194s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:50.784248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.860164796s","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-13T12:31:50.78428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:48.92247Z","time spent":"1.861801599s","remote":"127.0.0.1:39254","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-13T12:31:50.784304Z","caller":"traceutil/trace.go:171","msg":"trace[861677053] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:653; }","duration":"1.860272718s","start":"2026-07-13T12:31:48.924015Z","end":"2026-07-13T12:31:50.784288Z","steps":["trace[861677053] 'agreement among raft nodes before linearized reading' (duration: 1.860112694s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:50.784335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:48.924003Z","time spent":"1.860326929s","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-13T12:31:50.784348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.834302065s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-13T12:31:50.784382Z","caller":"traceutil/trace.go:171","msg":"trace[353507180] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"1.834342516s","start":"2026-07-13T12:31:48.950028Z","end":"2026-07-13T12:31:50.78437Z","steps":["trace[353507180] 'agreement among raft nodes before linearized reading' (duration: 1.834294465s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:50.784385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.854956856s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-13T12:31:50.784409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:48.950023Z","time spent":"1.834378937s","remote":"127.0.0.1:38964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-13T12:31:50.784444Z","caller":"traceutil/trace.go:171","msg":"trace[735923589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:653; }","duration":"1.855043948s","start":"2026-07-13T12:31:48.929383Z","end":"2026-07-13T12:31:50.784427Z","steps":["trace[735923589] 'agreement among raft nodes before linearized reading' (duration: 1.854846173s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:50.784475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:48.929376Z","time spent":"1.85509311s","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-13T12:31:50.784491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.855125961s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-13T12:31:50.784513Z","caller":"traceutil/trace.go:171","msg":"trace[2125831917] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:653; }","duration":"1.855169773s","start":"2026-07-13T12:31:48.929337Z","end":"2026-07-13T12:31:50.784507Z","steps":["trace[2125831917] 'agreement among raft nodes before linearized reading' (duration: 1.85511244s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:31:50.784531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:31:48.929326Z","time spent":"1.855201993s","remote":"127.0.0.1:39254","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-13T12:32:06.262572Z","caller":"traceutil/trace.go:171","msg":"trace[1544344101] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"942.720605ms","start":"2026-07-13T12:32:05.319822Z","end":"2026-07-13T12:32:06.262542Z","steps":["trace[1544344101] 'process raft request' (duration: 908.342843ms)","trace[1544344101] 'compare' (duration: 33.982821ms)"],"step_count":2} {"level":"warn","ts":"2026-07-13T12:32:06.262759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:32:05.319798Z","time spent":"942.852278ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T12:32:06.263973Z","caller":"traceutil/trace.go:171","msg":"trace[410009350] linearizableReadLoop","detail":"{readStateIndex:841; appliedIndex:839; }","duration":"349.874224ms","start":"2026-07-13T12:32:05.914004Z","end":"2026-07-13T12:32:06.263879Z","steps":["trace[410009350] 'read index received' (duration: 314.171306ms)","trace[410009350] 'applied index is now lower than readState.Index' (duration: 35.701608ms)"],"step_count":2} {"level":"warn","ts":"2026-07-13T12:32:06.264135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.11286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-13T12:32:06.264105Z","caller":"traceutil/trace.go:171","msg":"trace[1493310524] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"678.105673ms","start":"2026-07-13T12:32:05.585969Z","end":"2026-07-13T12:32:06.264074Z","steps":["trace[1493310524] 'process raft request' (duration: 677.768854ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:32:06.264198Z","caller":"traceutil/trace.go:171","msg":"trace[2014597133] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:810; }","duration":"350.219932ms","start":"2026-07-13T12:32:05.913963Z","end":"2026-07-13T12:32:06.264183Z","steps":["trace[2014597133] 'agreement among raft nodes before linearized reading' (duration: 350.074579ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:32:06.26423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:32:05.913944Z","time spent":"350.279504ms","remote":"127.0.0.1:39468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":2,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-07-13T12:32:06.26429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:32:05.585948Z","time spent":"678.277956ms","remote":"127.0.0.1:39230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T12:32:40.834883Z","caller":"traceutil/trace.go:171","msg":"trace[790660275] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"398.506754ms","start":"2026-07-13T12:32:40.436343Z","end":"2026-07-13T12:32:40.83485Z","steps":["trace[790660275] 'process raft request' (duration: 398.32914ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:32:40.835089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:32:40.436332Z","time spent":"398.640298ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-13T12:32:41.686166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"834.607666ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-13T12:32:41.686309Z","caller":"traceutil/trace.go:171","msg":"trace[831828013] linearizableReadLoop","detail":"{readStateIndex:1068; appliedIndex:1067; }","duration":"735.683881ms","start":"2026-07-13T12:32:40.950588Z","end":"2026-07-13T12:32:41.686272Z","steps":["trace[831828013] 'read index received' (duration: 28.9µs)","trace[831828013] 'applied index is now lower than readState.Index' (duration: 735.653761ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T12:32:41.686523Z","caller":"traceutil/trace.go:171","msg":"trace[968491722] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"1.167954301s","start":"2026-07-13T12:32:40.518555Z","end":"2026-07-13T12:32:41.686509Z","steps":["trace[968491722] 'process raft request' (duration: 332.910883ms)","trace[968491722] 'compare' (duration: 834.039151ms)"],"step_count":2} {"level":"warn","ts":"2026-07-13T12:32:41.686605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:32:40.518531Z","time spent":"1.168031984s","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-13T12:32:41.686877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.267896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-13T12:32:41.68695Z","caller":"traceutil/trace.go:171","msg":"trace[2134511978] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1028; }","duration":"736.376389ms","start":"2026-07-13T12:32:40.950556Z","end":"2026-07-13T12:32:41.686932Z","steps":["trace[2134511978] 'agreement among raft nodes before linearized reading' (duration: 736.251246ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:32:41.686991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:32:40.95054Z","time spent":"736.442702ms","remote":"127.0.0.1:38960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-13T12:32:41.687063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.331744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-07-13T12:32:41.687082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.535377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-07-13T12:32:41.687112Z","caller":"traceutil/trace.go:171","msg":"trace[639155377] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1028; }","duration":"498.417605ms","start":"2026-07-13T12:32:41.188683Z","end":"2026-07-13T12:32:41.6871Z","steps":["trace[639155377] 'agreement among raft nodes before linearized reading' (duration: 498.278871ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:32:41.68714Z","caller":"traceutil/trace.go:171","msg":"trace[363865499] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1028; }","duration":"507.63222ms","start":"2026-07-13T12:32:41.179495Z","end":"2026-07-13T12:32:41.687127Z","steps":["trace[363865499] 'agreement among raft nodes before linearized reading' (duration: 507.462145ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:32:41.687149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:32:41.188658Z","time spent":"498.482537ms","remote":"127.0.0.1:39254","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-13T12:32:41.687162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.546096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-13T12:32:41.687237Z","caller":"traceutil/trace.go:171","msg":"trace[1365596533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1028; }","duration":"499.650999ms","start":"2026-07-13T12:32:41.187563Z","end":"2026-07-13T12:32:41.687214Z","steps":["trace[1365596533] 'agreement among raft nodes before linearized reading' (duration: 499.475595ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:32:41.687289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:32:41.187543Z","time spent":"499.734741ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-13T12:32:41.687178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:32:41.179477Z","time spent":"507.692831ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-13T12:32:41.687139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.70062ms","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-13T12:32:41.687911Z","caller":"traceutil/trace.go:171","msg":"trace[2135772877] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1028; }","duration":"494.501982ms","start":"2026-07-13T12:32:41.193387Z","end":"2026-07-13T12:32:41.687889Z","steps":["trace[2135772877] 'agreement among raft nodes before linearized reading' (duration: 493.624129ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:32:41.687977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:32:41.193362Z","time spent":"494.598095ms","remote":"127.0.0.1:39254","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-13T12:33:03.092372Z","caller":"traceutil/trace.go:171","msg":"trace[2118822627] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"157.121489ms","start":"2026-07-13T12:33:02.935227Z","end":"2026-07-13T12:33:03.092349Z","steps":["trace[2118822627] 'process raft request' (duration: 156.936864ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:33:03.874492Z","caller":"traceutil/trace.go:171","msg":"trace[1665528262] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"114.804246ms","start":"2026-07-13T12:33:03.759661Z","end":"2026-07-13T12:33:03.874465Z","steps":["trace[1665528262] 'process raft request' (duration: 114.519228ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:33:04.108858Z","caller":"traceutil/trace.go:171","msg":"trace[1408135748] linearizableReadLoop","detail":"{readStateIndex:1147; appliedIndex:1146; }","duration":"226.187691ms","start":"2026-07-13T12:33:03.882634Z","end":"2026-07-13T12:33:04.108822Z","steps":["trace[1408135748] 'read index received' (duration: 174.689575ms)","trace[1408135748] 'applied index is now lower than readState.Index' (duration: 51.495936ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T12:33:04.108916Z","caller":"traceutil/trace.go:171","msg":"trace[822966220] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"227.323981ms","start":"2026-07-13T12:33:03.881524Z","end":"2026-07-13T12:33:04.108848Z","steps":["trace[822966220] 'process raft request' (duration: 175.695162ms)","trace[822966220] 'compare' (duration: 51.305281ms)"],"step_count":2} {"level":"warn","ts":"2026-07-13T12:33:04.109356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.707496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-13T12:33:04.109443Z","caller":"traceutil/trace.go:171","msg":"trace[2046307054] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1102; }","duration":"226.812838ms","start":"2026-07-13T12:33:03.882609Z","end":"2026-07-13T12:33:04.109422Z","steps":["trace[2046307054] 'agreement among raft nodes before linearized reading' (duration: 226.569042ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:33:04.10945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.795578ms","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-13T12:33:04.109526Z","caller":"traceutil/trace.go:171","msg":"trace[1842779019] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1102; }","duration":"226.90205ms","start":"2026-07-13T12:33:03.882604Z","end":"2026-07-13T12:33:04.109506Z","steps":["trace[1842779019] 'agreement among raft nodes before linearized reading' (duration: 226.673195ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:33:04.129323Z","caller":"traceutil/trace.go:171","msg":"trace[887496557] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"245.151776ms","start":"2026-07-13T12:33:03.884152Z","end":"2026-07-13T12:33:04.129304Z","steps":["trace[887496557] 'process raft request' (duration: 244.827376ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:33:04.129627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.456131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-13T12:33:04.129681Z","caller":"traceutil/trace.go:171","msg":"trace[451441133] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1103; }","duration":"179.604545ms","start":"2026-07-13T12:33:03.950063Z","end":"2026-07-13T12:33:04.129667Z","steps":["trace[451441133] 'agreement among raft nodes before linearized reading' (duration: 179.05493ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:33:42.58327Z","caller":"traceutil/trace.go:171","msg":"trace[1737320099] linearizableReadLoop","detail":"{readStateIndex:1333; appliedIndex:1332; }","duration":"287.306207ms","start":"2026-07-13T12:33:42.295949Z","end":"2026-07-13T12:33:42.583256Z","steps":["trace[1737320099] 'read index received' (duration: 287.118703ms)","trace[1737320099] 'applied index is now lower than readState.Index' (duration: 186.964µs)"],"step_count":2} {"level":"info","ts":"2026-07-13T12:33:42.5833Z","caller":"traceutil/trace.go:171","msg":"trace[1154557740] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"289.073974ms","start":"2026-07-13T12:33:42.294204Z","end":"2026-07-13T12:33:42.583278Z","steps":["trace[1154557740] 'process raft request' (duration: 288.9327ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:33:42.583416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.452592ms","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-13T12:33:42.58344Z","caller":"traceutil/trace.go:171","msg":"trace[321005981] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1278; }","duration":"287.505374ms","start":"2026-07-13T12:33:42.295929Z","end":"2026-07-13T12:33:42.583434Z","steps":["trace[321005981] 'agreement among raft nodes before linearized reading' (duration: 287.412151ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:33:42.583483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.050886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-13T12:33:42.58351Z","caller":"traceutil/trace.go:171","msg":"trace[1240406578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1278; }","duration":"176.112077ms","start":"2026-07-13T12:33:42.40739Z","end":"2026-07-13T12:33:42.583503Z","steps":["trace[1240406578] 'agreement among raft nodes before linearized reading' (duration: 176.023244ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:33:42.583529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.103227ms","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-13T12:33:42.583546Z","caller":"traceutil/trace.go:171","msg":"trace[979155025] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1278; }","duration":"176.151338ms","start":"2026-07-13T12:33:42.407391Z","end":"2026-07-13T12:33:42.583542Z","steps":["trace[979155025] 'agreement among raft nodes before linearized reading' (duration: 176.111137ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:33:42.945404Z","caller":"traceutil/trace.go:171","msg":"trace[708221331] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"356.337552ms","start":"2026-07-13T12:33:42.589039Z","end":"2026-07-13T12:33:42.945377Z","steps":["trace[708221331] 'process raft request' (duration: 356.229079ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:33:42.94544Z","caller":"traceutil/trace.go:171","msg":"trace[689755496] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"356.803555ms","start":"2026-07-13T12:33:42.588611Z","end":"2026-07-13T12:33:42.945414Z","steps":["trace[689755496] 'process raft request' (duration: 281.893013ms)","trace[689755496] 'compare' (duration: 74.616783ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T12:33:42.945479Z","caller":"traceutil/trace.go:171","msg":"trace[260119411] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"356.348363ms","start":"2026-07-13T12:33:42.589101Z","end":"2026-07-13T12:33:42.94545Z","steps":["trace[260119411] 'process raft request' (duration: 356.23266ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:33:42.9456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:33:42.589028Z","time spent":"356.462496ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-13T12:33:42.945604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:33:42.58859Z","time spent":"356.903518ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-13T12:33:42.94562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:33:42.589095Z","time spent":"356.448475ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T12:33:43.007295Z","caller":"traceutil/trace.go:171","msg":"trace[1524062084] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"120.306586ms","start":"2026-07-13T12:33:42.886933Z","end":"2026-07-13T12:33:43.00724Z","steps":["trace[1524062084] 'process raft request' (duration: 120.192613ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:33:44.311204Z","caller":"traceutil/trace.go:171","msg":"trace[1897039711] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"269.515982ms","start":"2026-07-13T12:33:44.04166Z","end":"2026-07-13T12:33:44.311176Z","steps":["trace[1897039711] 'process raft request' (duration: 269.310406ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:33:44.872478Z","caller":"traceutil/trace.go:171","msg":"trace[168505664] linearizableReadLoop","detail":"{readStateIndex:1342; appliedIndex:1341; }","duration":"258.944029ms","start":"2026-07-13T12:33:44.613508Z","end":"2026-07-13T12:33:44.872452Z","steps":["trace[168505664] 'read index received' (duration: 173.185488ms)","trace[168505664] 'applied index is now lower than readState.Index' (duration: 85.757091ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T12:33:44.872589Z","caller":"traceutil/trace.go:171","msg":"trace[1793206352] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"280.019013ms","start":"2026-07-13T12:33:44.592528Z","end":"2026-07-13T12:33:44.872547Z","steps":["trace[1793206352] 'process raft request' (duration: 194.152109ms)","trace[1793206352] 'compare' (duration: 85.463904ms)"],"step_count":2} {"level":"warn","ts":"2026-07-13T12:33:44.872674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.145236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5329"} {"level":"info","ts":"2026-07-13T12:33:44.87271Z","caller":"traceutil/trace.go:171","msg":"trace[1376025547] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1287; }","duration":"259.222168ms","start":"2026-07-13T12:33:44.613475Z","end":"2026-07-13T12:33:44.872697Z","steps":["trace[1376025547] 'agreement among raft nodes before linearized reading' (duration: 259.070813ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:33:44.87558Z","caller":"traceutil/trace.go:171","msg":"trace[778636565] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"209.819247ms","start":"2026-07-13T12:33:44.665746Z","end":"2026-07-13T12:33:44.875565Z","steps":["trace[778636565] 'process raft request' (duration: 209.733215ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:33:45.371403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.171465ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-13T12:33:45.371523Z","caller":"traceutil/trace.go:171","msg":"trace[256723648] linearizableReadLoop","detail":"{readStateIndex:1344; appliedIndex:1343; }","duration":"452.344018ms","start":"2026-07-13T12:33:44.919154Z","end":"2026-07-13T12:33:45.371498Z","steps":["trace[256723648] 'read index received' (duration: 92.016798ms)","trace[256723648] 'applied index is now lower than readState.Index' (duration: 360.32616ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T12:33:45.371603Z","caller":"traceutil/trace.go:171","msg":"trace[904082759] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"491.617647ms","start":"2026-07-13T12:33:44.879974Z","end":"2026-07-13T12:33:45.371592Z","steps":["trace[904082759] 'process raft request' (duration: 131.190775ms)","trace[904082759] 'compare' (duration: 360.026482ms)"],"step_count":2} {"level":"warn","ts":"2026-07-13T12:33:45.371657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:33:44.879946Z","time spent":"491.688159ms","remote":"127.0.0.1:39060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":822,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-13T12:33:45.371871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.722579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-13T12:33:45.371906Z","caller":"traceutil/trace.go:171","msg":"trace[1105415473] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1289; }","duration":"452.801681ms","start":"2026-07-13T12:33:44.919096Z","end":"2026-07-13T12:33:45.371897Z","steps":["trace[1105415473] 'agreement among raft nodes before linearized reading' (duration: 452.707108ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:33:45.371918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.199346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-13T12:33:45.371941Z","caller":"traceutil/trace.go:171","msg":"trace[1292827765] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1289; }","duration":"421.248788ms","start":"2026-07-13T12:33:44.950685Z","end":"2026-07-13T12:33:45.371934Z","steps":["trace[1292827765] 'agreement among raft nodes before linearized reading' (duration: 421.154835ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:33:45.371935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:33:44.919064Z","time spent":"452.864133ms","remote":"127.0.0.1:39368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" "} {"level":"warn","ts":"2026-07-13T12:33:45.371956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:33:44.95067Z","time spent":"421.282648ms","remote":"127.0.0.1:39254","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-13T12:33:45.372084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.23482ms","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-13T12:33:45.372151Z","caller":"traceutil/trace.go:171","msg":"trace[1708239886] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1289; }","duration":"420.316052ms","start":"2026-07-13T12:33:44.951817Z","end":"2026-07-13T12:33:45.372133Z","steps":["trace[1708239886] 'agreement among raft nodes before linearized reading' (duration: 420.093416ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:33:45.372193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:33:44.951802Z","time spent":"420.382494ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-13T12:33:45.372255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.515655ms","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-13T12:33:45.372288Z","caller":"traceutil/trace.go:171","msg":"trace[1991576385] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1289; }","duration":"421.553315ms","start":"2026-07-13T12:33:44.950723Z","end":"2026-07-13T12:33:45.372276Z","steps":["trace[1991576385] 'agreement among raft nodes before linearized reading' (duration: 421.463363ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:33:45.372322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:33:44.95072Z","time spent":"421.595586ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-13T12:33:45.735542Z","caller":"traceutil/trace.go:171","msg":"trace[1615979376] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"356.444355ms","start":"2026-07-13T12:33:45.379073Z","end":"2026-07-13T12:33:45.735518Z","steps":["trace[1615979376] 'process raft request' (duration: 356.396404ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:33:45.735656Z","caller":"traceutil/trace.go:171","msg":"trace[180835754] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"356.581009ms","start":"2026-07-13T12:33:45.37904Z","end":"2026-07-13T12:33:45.735621Z","steps":["trace[180835754] 'process raft request' (duration: 356.298252ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:33:45.735734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:33:45.379063Z","time spent":"356.558558ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-13T12:33:45.735848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:33:45.379027Z","time spent":"356.728732ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T12:33:45.743163Z","caller":"traceutil/trace.go:171","msg":"trace[365721239] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"329.491605ms","start":"2026-07-13T12:33:45.413649Z","end":"2026-07-13T12:33:45.743141Z","steps":["trace[365721239] 'process raft request' (duration: 329.321071ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:33:45.743314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:33:45.413625Z","time spent":"329.609158ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T12:33:47.526409Z","caller":"traceutil/trace.go:171","msg":"trace[1004836772] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"107.284487ms","start":"2026-07-13T12:33:47.419085Z","end":"2026-07-13T12:33:47.526369Z","steps":["trace[1004836772] 'process raft request' (duration: 107.174014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:37:16.934298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.205236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-07-13T12:37:16.934285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.642432ms","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-13T12:37:16.934362Z","caller":"traceutil/trace.go:171","msg":"trace[1876533780] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2300; }","duration":"460.307839ms","start":"2026-07-13T12:37:16.47404Z","end":"2026-07-13T12:37:16.934348Z","steps":["trace[1876533780] 'range keys from in-memory index tree' (duration: 460.043011ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:37:16.934372Z","caller":"traceutil/trace.go:171","msg":"trace[1123504652] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2300; }","duration":"173.780056ms","start":"2026-07-13T12:37:16.76057Z","end":"2026-07-13T12:37:16.93435Z","steps":["trace[1123504652] 'range keys from in-memory index tree' (duration: 173.506517ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:37:16.934389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:16.474018Z","time spent":"460.36413ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-13T12:37:16.934564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.238419ms","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-13T12:37:16.934589Z","caller":"traceutil/trace.go:171","msg":"trace[837145116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2300; }","duration":"180.324941ms","start":"2026-07-13T12:37:16.754256Z","end":"2026-07-13T12:37:16.934581Z","steps":["trace[837145116] 'range keys from in-memory index tree' (duration: 180.073534ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:37:16.934542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.812703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-13T12:37:16.934685Z","caller":"traceutil/trace.go:171","msg":"trace[332282325] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2300; }","duration":"171.993597ms","start":"2026-07-13T12:37:16.762675Z","end":"2026-07-13T12:37:16.934669Z","steps":["trace[332282325] 'range keys from in-memory index tree' (duration: 171.530966ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:37:20.037406Z","caller":"traceutil/trace.go:171","msg":"trace[1309633393] transaction","detail":"{read_only:false; response_revision:2319; number_of_response:1; }","duration":"194.585663ms","start":"2026-07-13T12:37:19.842801Z","end":"2026-07-13T12:37:20.037387Z","steps":["trace[1309633393] 'process raft request' (duration: 132.40345ms)","trace[1309633393] 'compare' (duration: 61.833625ms)"],"step_count":2} {"level":"warn","ts":"2026-07-13T12:37:25.386372Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312674514615308,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-13T12:37:25.749788Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.010868413s","expected-duration":"1s"} {"level":"info","ts":"2026-07-13T12:37:25.750165Z","caller":"traceutil/trace.go:171","msg":"trace[626519030] transaction","detail":"{read_only:false; response_revision:2337; number_of_response:1; }","duration":"1.011346446s","start":"2026-07-13T12:37:24.738796Z","end":"2026-07-13T12:37:25.750142Z","steps":["trace[626519030] 'process raft request' (duration: 1.011218213s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:37:25.750304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:24.738778Z","time spent":"1.011458949s","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T12:37:25.790741Z","caller":"traceutil/trace.go:171","msg":"trace[1909856517] linearizableReadLoop","detail":"{readStateIndex:2437; appliedIndex:2436; }","duration":"904.44549ms","start":"2026-07-13T12:37:24.886272Z","end":"2026-07-13T12:37:25.790718Z","steps":["trace[1909856517] 'read index received' (duration: 863.851449ms)","trace[1909856517] 'applied index is now lower than readState.Index' (duration: 40.593091ms)"],"step_count":2} {"level":"info","ts":"2026-07-13T12:37:25.790818Z","caller":"traceutil/trace.go:171","msg":"trace[1666940327] transaction","detail":"{read_only:false; response_revision:2338; number_of_response:1; }","duration":"668.353504ms","start":"2026-07-13T12:37:25.122433Z","end":"2026-07-13T12:37:25.790787Z","steps":["trace[1666940327] 'process raft request' (duration: 668.119988ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:37:25.790943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.651075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-07-13T12:37:25.790975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:25.122417Z","time spent":"668.467537ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T12:37:25.791011Z","caller":"traceutil/trace.go:171","msg":"trace[1098655378] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2338; }","duration":"904.748686ms","start":"2026-07-13T12:37:24.886242Z","end":"2026-07-13T12:37:25.79099Z","steps":["trace[1098655378] 'agreement among raft nodes before linearized reading' (duration: 904.566732ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:37:25.791026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.16461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-07-13T12:37:25.791051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:24.886229Z","time spent":"904.814009ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-13T12:37:25.791047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.141279ms","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":"warn","ts":"2026-07-13T12:37:25.790976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"840.700282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-13T12:37:25.791094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.566692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-13T12:37:25.791112Z","caller":"traceutil/trace.go:171","msg":"trace[1054705256] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2338; }","duration":"783.217392ms","start":"2026-07-13T12:37:25.007873Z","end":"2026-07-13T12:37:25.791091Z","steps":["trace[1054705256] 'agreement among raft nodes before linearized reading' (duration: 783.037716ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:37:25.791113Z","caller":"traceutil/trace.go:171","msg":"trace[1136740296] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2338; }","duration":"783.212741ms","start":"2026-07-13T12:37:25.007848Z","end":"2026-07-13T12:37:25.791061Z","steps":["trace[1136740296] 'agreement among raft nodes before linearized reading' (duration: 783.092328ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:37:25.791134Z","caller":"traceutil/trace.go:171","msg":"trace[1729117016] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2338; }","duration":"840.910859ms","start":"2026-07-13T12:37:24.950207Z","end":"2026-07-13T12:37:25.791118Z","steps":["trace[1729117016] 'agreement among raft nodes before linearized reading' (duration: 840.701502ms)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:37:25.79114Z","caller":"traceutil/trace.go:171","msg":"trace[1417831494] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2338; }","duration":"783.636384ms","start":"2026-07-13T12:37:25.007488Z","end":"2026-07-13T12:37:25.791124Z","steps":["trace[1417831494] 'agreement among raft nodes before linearized reading' (duration: 783.52173ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:37:25.791163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:25.007839Z","time spent":"783.316515ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-13T12:37:25.791169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:25.007868Z","time spent":"783.287014ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-07-13T12:37:25.79118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:24.950183Z","time spent":"840.987191ms","remote":"127.0.0.1:38960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-13T12:37:25.79119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:25.007473Z","time spent":"783.705745ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-13T12:37:25.791201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.916851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-07-13T12:37:25.79123Z","caller":"traceutil/trace.go:171","msg":"trace[696648670] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2338; }","duration":"777.962732ms","start":"2026-07-13T12:37:25.013257Z","end":"2026-07-13T12:37:25.79122Z","steps":["trace[696648670] 'agreement among raft nodes before linearized reading' (duration: 777.88299ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:37:25.79126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:25.013247Z","time spent":"778.007024ms","remote":"127.0.0.1:39254","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":"warn","ts":"2026-07-13T12:37:25.791283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.443924ms","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-13T12:37:25.791333Z","caller":"traceutil/trace.go:171","msg":"trace[830221699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2338; }","duration":"781.514766ms","start":"2026-07-13T12:37:25.009809Z","end":"2026-07-13T12:37:25.791324Z","steps":["trace[830221699] 'agreement among raft nodes before linearized reading' (duration: 781.420063ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:37:25.791371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:25.009795Z","time spent":"781.570227ms","remote":"127.0.0.1:39254","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-13T12:37:26.451463Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312674514615313,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-13T12:37:26.954042Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312674514615313,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-13T12:37:26.956343Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.160495386s","expected-duration":"1s"} {"level":"info","ts":"2026-07-13T12:37:27.033192Z","caller":"traceutil/trace.go:171","msg":"trace[941642022] transaction","detail":"{read_only:false; response_revision:2339; number_of_response:1; }","duration":"1.237404074s","start":"2026-07-13T12:37:25.795767Z","end":"2026-07-13T12:37:27.033171Z","steps":["trace[941642022] 'process raft request' (duration: 1.160874606s)","trace[941642022] 'compare' (duration: 76.437366ms)"],"step_count":2} {"level":"warn","ts":"2026-07-13T12:37:27.033307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:25.795751Z","time spent":"1.237497987s","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T12:37:27.034333Z","caller":"traceutil/trace.go:171","msg":"trace[71683930] transaction","detail":"{read_only:false; response_revision:2340; number_of_response:1; }","duration":"1.237961578s","start":"2026-07-13T12:37:25.796359Z","end":"2026-07-13T12:37:27.03432Z","steps":["trace[71683930] 'process raft request' (duration: 1.237875636s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:37:27.034409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:25.796339Z","time spent":"1.238039931s","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T12:37:27.034589Z","caller":"traceutil/trace.go:171","msg":"trace[418614085] transaction","detail":"{read_only:false; response_revision:2341; number_of_response:1; }","duration":"1.238211106s","start":"2026-07-13T12:37:25.796368Z","end":"2026-07-13T12:37:27.034579Z","steps":["trace[418614085] 'process raft request' (duration: 1.237917037s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:37:27.034632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:25.796358Z","time spent":"1.238249506s","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T12:37:27.03474Z","caller":"traceutil/trace.go:171","msg":"trace[507670659] transaction","detail":"{read_only:false; response_revision:2343; number_of_response:1; }","duration":"1.237951758s","start":"2026-07-13T12:37:25.796781Z","end":"2026-07-13T12:37:27.034733Z","steps":["trace[507670659] 'process raft request' (duration: 1.237801895s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:37:27.034793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:25.796776Z","time spent":"1.237985129s","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T12:37:27.03474Z","caller":"traceutil/trace.go:171","msg":"trace[1462620089] transaction","detail":"{read_only:false; response_revision:2342; number_of_response:1; }","duration":"1.238219136s","start":"2026-07-13T12:37:25.79642Z","end":"2026-07-13T12:37:27.034639Z","steps":["trace[1462620089] 'process raft request' (duration: 1.238028171s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:37:27.034938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:25.796415Z","time spent":"1.238431471s","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-13T12:37:27.034944Z","caller":"traceutil/trace.go:171","msg":"trace[71243062] linearizableReadLoop","detail":"{readStateIndex:2443; appliedIndex:2437; }","duration":"1.084140683s","start":"2026-07-13T12:37:25.95078Z","end":"2026-07-13T12:37:27.034921Z","steps":["trace[71243062] 'read index received' (duration: 1.005870729s)","trace[71243062] 'applied index is now lower than readState.Index' (duration: 78.268514ms)"],"step_count":2} {"level":"warn","ts":"2026-07-13T12:37:27.035109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.084321447s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-13T12:37:27.035134Z","caller":"traceutil/trace.go:171","msg":"trace[2095771187] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2344; }","duration":"1.084413429s","start":"2026-07-13T12:37:25.950713Z","end":"2026-07-13T12:37:27.035126Z","steps":["trace[2095771187] 'agreement among raft nodes before linearized reading' (duration: 1.084312477s)"],"step_count":1} {"level":"info","ts":"2026-07-13T12:37:27.035078Z","caller":"traceutil/trace.go:171","msg":"trace[29638916] transaction","detail":"{read_only:false; response_revision:2344; number_of_response:1; }","duration":"1.237804334s","start":"2026-07-13T12:37:25.797222Z","end":"2026-07-13T12:37:27.035026Z","steps":["trace[29638916] 'process raft request' (duration: 1.237477226s)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:37:27.03516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:25.95069Z","time spent":"1.084464263s","remote":"127.0.0.1:38960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-13T12:37:27.035283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:25.797216Z","time spent":"1.2379624s","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-13T12:37:27.035414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.610137ms","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-13T12:37:27.035442Z","caller":"traceutil/trace.go:171","msg":"trace[1226022464] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2344; }","duration":"971.68215ms","start":"2026-07-13T12:37:26.063753Z","end":"2026-07-13T12:37:27.035435Z","steps":["trace[1226022464] 'agreement among raft nodes before linearized reading' (duration: 971.578287ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:37:27.035459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:26.06373Z","time spent":"971.724921ms","remote":"127.0.0.1:39254","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-13T12:37:27.0358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.141069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:525"} {"level":"info","ts":"2026-07-13T12:37:27.03583Z","caller":"traceutil/trace.go:171","msg":"trace[288794076] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2344; }","duration":"866.208531ms","start":"2026-07-13T12:37:26.169612Z","end":"2026-07-13T12:37:27.035821Z","steps":["trace[288794076] 'agreement among raft nodes before linearized reading' (duration: 866.134789ms)"],"step_count":1} {"level":"warn","ts":"2026-07-13T12:37:27.035849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-13T12:37:26.169592Z","time spent":"866.251893ms","remote":"127.0.0.1:39254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "}