{"level":"warn","ts":"2026-07-28T14:09:09.332046Z","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-28T14:09:09.332139Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.35: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.35:2380","--initial-cluster=instance=https://199.204.45.35:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.35:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.35: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-28T14:09:09.332207Z","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-28T14:09:09.332219Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-07-28T14:09:09.332242Z","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-28T14:09:09.332966Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"]} {"level":"info","ts":"2026-07-28T14:09:09.333049Z","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.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.35: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-28T14:09:09.347168Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"13.58938ms"} {"level":"info","ts":"2026-07-28T14:09:09.357902Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fb85913747d92cac","cluster-id":"636a84d5a3ba9c31"} {"level":"info","ts":"2026-07-28T14:09:09.358019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=()"} {"level":"info","ts":"2026-07-28T14:09:09.358056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 0"} {"level":"info","ts":"2026-07-28T14:09:09.358074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fb85913747d92cac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-28T14:09:09.358095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 1"} {"level":"info","ts":"2026-07-28T14:09:09.358149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"warn","ts":"2026-07-28T14:09:09.371534Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-28T14:09:09.372978Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-28T14:09:09.375273Z","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-28T14:09:09.377601Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fb85913747d92cac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-28T14:09:09.378615Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fb85913747d92cac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-28T14:09:09.3787Z","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-28T14:09:09.378786Z","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-28T14:09:09.378798Z","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-28T14:09:09.384764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"info","ts":"2026-07-28T14:09:09.385082Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","added-peer-id":"fb85913747d92cac","added-peer-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-07-28T14:09:09.388513Z","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-28T14:09:09.388652Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-07-28T14:09:09.388682Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-07-28T14:09:09.389681Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fb85913747d92cac","initial-advertise-peer-urls":["https://199.204.45.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-28T14:09:09.389729Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-28T14:09:10.159294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac is starting a new election at term 1"} {"level":"info","ts":"2026-07-28T14:09:10.159335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became pre-candidate at term 1"} {"level":"info","ts":"2026-07-28T14:09:10.159359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgPreVoteResp from fb85913747d92cac at term 1"} {"level":"info","ts":"2026-07-28T14:09:10.159369Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became candidate at term 2"} {"level":"info","ts":"2026-07-28T14:09:10.159374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgVoteResp from fb85913747d92cac at term 2"} {"level":"info","ts":"2026-07-28T14:09:10.159382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became leader at term 2"} {"level":"info","ts":"2026-07-28T14:09:10.159389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fb85913747d92cac elected leader fb85913747d92cac at term 2"} {"level":"info","ts":"2026-07-28T14:09:10.160304Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fb85913747d92cac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.35:2379]}","request-path":"/0/members/fb85913747d92cac/attributes","cluster-id":"636a84d5a3ba9c31","publish-timeout":"7s"} {"level":"info","ts":"2026-07-28T14:09:10.16033Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-28T14:09:10.160364Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-28T14:09:10.160403Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T14:09:10.161625Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T14:09:10.161754Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T14:09:10.161808Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T14:09:10.16187Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-28T14:09:10.161907Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-28T14:09:10.162135Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-28T14:09:10.162139Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.35:2379"} {"level":"warn","ts":"2026-07-28T14:09:16.77198Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219123382110187683,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-28T14:09:17.272574Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219123382110187683,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-28T14:09:18.091332Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219123382110187683,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-28T14:09:18.111389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999862991s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-28T14:09:18.111478Z","caller":"traceutil/trace.go:171","msg":"trace[243486301] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000033349s","start":"2026-07-28T14:09:16.111425Z","end":"2026-07-28T14:09:18.111459Z","steps":["trace[243486301] 'agreement among raft nodes before linearized reading' (duration: 1.999889113s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:09:18.111521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:09:16.111404Z","time spent":"2.000109383s","remote":"127.0.0.1:40428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-28T14:09:18.592159Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219123382110187683,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-28T14:09:19.092568Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219123382110187683,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-28T14:09:19.592956Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219123382110187683,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-28T14:09:20.081639Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.970212335s","expected-duration":"1s"} {"level":"info","ts":"2026-07-28T14:09:20.082016Z","caller":"traceutil/trace.go:171","msg":"trace[2059033281] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"3.970650193s","start":"2026-07-28T14:09:16.111346Z","end":"2026-07-28T14:09:20.081996Z","steps":["trace[2059033281] 'process raft request' (duration: 3.970523248s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:09:20.083137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:09:16.111331Z","time spent":"3.970724517s","remote":"127.0.0.1:40658","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-28T14:09:20.140946Z","caller":"traceutil/trace.go:171","msg":"trace[1207830177] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"3.991175565s","start":"2026-07-28T14:09:16.149732Z","end":"2026-07-28T14:09:20.140907Z","steps":["trace[1207830177] 'process raft request' (duration: 3.990745896s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:09:20.141239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:09:16.149712Z","time spent":"3.991369103s","remote":"127.0.0.1:40576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4645,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T14:09:20.141222Z","caller":"traceutil/trace.go:171","msg":"trace[824950045] linearizableReadLoop","detail":"{readStateIndex:315; appliedIndex:312; }","duration":"4.02966347s","start":"2026-07-28T14:09:16.11146Z","end":"2026-07-28T14:09:20.141123Z","steps":["trace[824950045] 'read index received' (duration: 3.970431204s)","trace[824950045] 'applied index is now lower than readState.Index' (duration: 59.228866ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T14:09:20.141311Z","caller":"traceutil/trace.go:171","msg":"trace[348515212] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"1.726884371s","start":"2026-07-28T14:09:18.414401Z","end":"2026-07-28T14:09:20.141285Z","steps":["trace[348515212] 'process raft request' (duration: 1.72640533s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:09:20.141448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:09:18.414384Z","time spent":"1.726983155s","remote":"127.0.0.1:40506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-28T14:09:20.141677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.029177058s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-28T14:09:20.141719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.050019503s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-28T14:09:20.141751Z","caller":"traceutil/trace.go:171","msg":"trace[1437069777] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:306; }","duration":"2.050075376s","start":"2026-07-28T14:09:18.091665Z","end":"2026-07-28T14:09:20.14174Z","steps":["trace[1437069777] 'agreement among raft nodes before linearized reading' (duration: 2.050016943s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:09:20.141779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:09:18.091636Z","time spent":"2.050138018s","remote":"127.0.0.1:40658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-28T14:09:20.141774Z","caller":"traceutil/trace.go:171","msg":"trace[1367723338] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:0; response_revision:306; }","duration":"4.029376757s","start":"2026-07-28T14:09:16.112356Z","end":"2026-07-28T14:09:20.141733Z","steps":["trace[1367723338] 'agreement among raft nodes before linearized reading' (duration: 4.029070454s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:09:20.141842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:09:16.112348Z","time spent":"4.029477231s","remote":"127.0.0.1:40596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" "} {"level":"warn","ts":"2026-07-28T14:09:20.14187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.737660307s","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-28T14:09:20.141971Z","caller":"traceutil/trace.go:171","msg":"trace[257169339] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:306; }","duration":"1.737817244s","start":"2026-07-28T14:09:18.404128Z","end":"2026-07-28T14:09:20.141946Z","steps":["trace[257169339] 'agreement among raft nodes before linearized reading' (duration: 1.737566234s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:09:20.142033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:09:18.404087Z","time spent":"1.737933069s","remote":"127.0.0.1:40658","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-28T14:09:20.142037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.446157517s","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-28T14:09:20.142119Z","caller":"traceutil/trace.go:171","msg":"trace[1162286596] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:306; }","duration":"3.446276881s","start":"2026-07-28T14:09:16.695827Z","end":"2026-07-28T14:09:20.142103Z","steps":["trace[1162286596] 'agreement among raft nodes before linearized reading' (duration: 3.445922106s)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:09:20.142189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:09:16.695804Z","time spent":"3.446376536s","remote":"127.0.0.1:40658","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-28T14:09:42.56635Z","caller":"traceutil/trace.go:171","msg":"trace[1446427331] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"216.0536ms","start":"2026-07-28T14:09:42.350269Z","end":"2026-07-28T14:09:42.566322Z","steps":["trace[1446427331] 'process raft request' (duration: 215.982457ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:09:42.566536Z","caller":"traceutil/trace.go:171","msg":"trace[1871680319] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"216.230877ms","start":"2026-07-28T14:09:42.350263Z","end":"2026-07-28T14:09:42.566494Z","steps":["trace[1871680319] 'process raft request' (duration: 211.907248ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:09:47.142796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"785.583894ms","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-28T14:09:47.142929Z","caller":"traceutil/trace.go:171","msg":"trace[632993915] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:483; }","duration":"785.813354ms","start":"2026-07-28T14:09:46.357055Z","end":"2026-07-28T14:09:47.142868Z","steps":["trace[632993915] 'range keys from in-memory index tree' (duration: 785.47495ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:09:47.142964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:09:46.357045Z","time spent":"785.910927ms","remote":"127.0.0.1:40658","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-28T14:09:47.142951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.792242ms","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-28T14:09:47.143024Z","caller":"traceutil/trace.go:171","msg":"trace[668464552] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:483; }","duration":"560.906836ms","start":"2026-07-28T14:09:46.582099Z","end":"2026-07-28T14:09:47.143006Z","steps":["trace[668464552] 'range keys from in-memory index tree' (duration: 560.720179ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:09:47.143059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:09:46.582089Z","time spent":"560.961169ms","remote":"127.0.0.1:40658","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-28T14:09:47.14312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"990.108164ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-28T14:09:47.143186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.866818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-28T14:09:47.143215Z","caller":"traceutil/trace.go:171","msg":"trace[987666117] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:483; }","duration":"404.91443ms","start":"2026-07-28T14:09:46.738292Z","end":"2026-07-28T14:09:47.143207Z","steps":["trace[987666117] 'range keys from in-memory index tree' (duration: 404.810875ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:09:47.143217Z","caller":"traceutil/trace.go:171","msg":"trace[693837381] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:483; }","duration":"990.215158ms","start":"2026-07-28T14:09:46.152988Z","end":"2026-07-28T14:09:47.143203Z","steps":["trace[693837381] 'range keys from in-memory index tree' (duration: 990.095654ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:09:47.143237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:09:46.738283Z","time spent":"404.949242ms","remote":"127.0.0.1:40658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-28T14:09:47.143293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.085241ms","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-28T14:09:47.143326Z","caller":"traceutil/trace.go:171","msg":"trace[2127640934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:483; }","duration":"866.151303ms","start":"2026-07-28T14:09:46.277167Z","end":"2026-07-28T14:09:47.143318Z","steps":["trace[2127640934] 'range keys from in-memory index tree' (duration: 866.022277ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:09:47.143344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:09:46.277149Z","time spent":"866.190395ms","remote":"127.0.0.1:40658","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-28T14:09:54.577908Z","caller":"traceutil/trace.go:171","msg":"trace[623565291] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"227.170032ms","start":"2026-07-28T14:09:54.350719Z","end":"2026-07-28T14:09:54.577889Z","steps":["trace[623565291] 'process raft request' (duration: 227.050027ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:09:54.58753Z","caller":"traceutil/trace.go:171","msg":"trace[1916265147] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"227.181613ms","start":"2026-07-28T14:09:54.36031Z","end":"2026-07-28T14:09:54.587491Z","steps":["trace[1916265147] 'process raft request' (duration: 226.936373ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:09:54.587592Z","caller":"traceutil/trace.go:171","msg":"trace[1453859911] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"226.387611ms","start":"2026-07-28T14:09:54.361183Z","end":"2026-07-28T14:09:54.58757Z","steps":["trace[1453859911] 'process raft request' (duration: 226.175882ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:09:54.58778Z","caller":"traceutil/trace.go:171","msg":"trace[1715366891] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"209.911724ms","start":"2026-07-28T14:09:54.377687Z","end":"2026-07-28T14:09:54.587599Z","steps":["trace[1715366891] 'process raft request' (duration: 209.759078ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:09:54.588031Z","caller":"traceutil/trace.go:171","msg":"trace[396788024] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"210.172155ms","start":"2026-07-28T14:09:54.377845Z","end":"2026-07-28T14:09:54.588017Z","steps":["trace[396788024] 'process raft request' (duration: 209.774589ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:09:54.588441Z","caller":"traceutil/trace.go:171","msg":"trace[946910655] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"210.624293ms","start":"2026-07-28T14:09:54.377806Z","end":"2026-07-28T14:09:54.58843Z","steps":["trace[946910655] 'process raft request' (duration: 209.693675ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:09:54.588525Z","caller":"traceutil/trace.go:171","msg":"trace[859824925] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"197.21923ms","start":"2026-07-28T14:09:54.391298Z","end":"2026-07-28T14:09:54.588518Z","steps":["trace[859824925] 'process raft request' (duration: 196.453799ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:09:54.588507Z","caller":"traceutil/trace.go:171","msg":"trace[563714519] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"208.486416ms","start":"2026-07-28T14:09:54.380004Z","end":"2026-07-28T14:09:54.58849Z","steps":["trace[563714519] 'process raft request' (duration: 207.555299ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:09:54.58858Z","caller":"traceutil/trace.go:171","msg":"trace[1474853018] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"156.228022ms","start":"2026-07-28T14:09:54.432346Z","end":"2026-07-28T14:09:54.588574Z","steps":["trace[1474853018] 'process raft request' (duration: 155.483382ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:09:54.588573Z","caller":"traceutil/trace.go:171","msg":"trace[1853484213] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"208.444895ms","start":"2026-07-28T14:09:54.380087Z","end":"2026-07-28T14:09:54.588532Z","steps":["trace[1853484213] 'process raft request' (duration: 207.58533ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:09:54.587618Z","caller":"traceutil/trace.go:171","msg":"trace[1035230917] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"209.920095ms","start":"2026-07-28T14:09:54.377642Z","end":"2026-07-28T14:09:54.587562Z","steps":["trace[1035230917] 'process raft request' (duration: 209.761788ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:10:00.23857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.725262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T14:10:00.238711Z","caller":"traceutil/trace.go:171","msg":"trace[1381571430] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"126.9253ms","start":"2026-07-28T14:10:00.111759Z","end":"2026-07-28T14:10:00.238684Z","steps":["trace[1381571430] 'range keys from in-memory index tree' (duration: 126.218762ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:10:00.551735Z","caller":"traceutil/trace.go:171","msg":"trace[620964458] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"301.400023ms","start":"2026-07-28T14:10:00.250294Z","end":"2026-07-28T14:10:00.551694Z","steps":["trace[620964458] 'process raft request' (duration: 301.08009ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:10:00.55196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:10:00.250264Z","time spent":"301.58742ms","remote":"127.0.0.1:40576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T14:10:00.891735Z","caller":"traceutil/trace.go:171","msg":"trace[1545443353] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"446.997671ms","start":"2026-07-28T14:10:00.44471Z","end":"2026-07-28T14:10:00.891708Z","steps":["trace[1545443353] 'process raft request' (duration: 446.47732ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:10:00.891894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:10:00.44468Z","time spent":"447.136106ms","remote":"127.0.0.1:40520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-28T14:10:01.618501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.158081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T14:10:01.61859Z","caller":"traceutil/trace.go:171","msg":"trace[170117321] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"510.286246ms","start":"2026-07-28T14:10:01.108284Z","end":"2026-07-28T14:10:01.61857Z","steps":["trace[170117321] 'range keys from in-memory index tree' (duration: 510.055108ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:10:01.618627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:10:01.108259Z","time spent":"510.360759ms","remote":"127.0.0.1:40432","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-28T14:10:01.6188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.43036ms","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-28T14:10:01.618914Z","caller":"traceutil/trace.go:171","msg":"trace[1345727042] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:643; }","duration":"372.633777ms","start":"2026-07-28T14:10:01.246256Z","end":"2026-07-28T14:10:01.61889Z","steps":["trace[1345727042] 'range keys from in-memory index tree' (duration: 372.272203ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:10:01.618968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:10:01.246231Z","time spent":"372.727221ms","remote":"127.0.0.1:40658","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-28T14:10:01.618962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.73088ms","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-28T14:10:01.619082Z","caller":"traceutil/trace.go:171","msg":"trace[1977930049] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:643; }","duration":"394.909257ms","start":"2026-07-28T14:10:01.224143Z","end":"2026-07-28T14:10:01.619052Z","steps":["trace[1977930049] 'range keys from in-memory index tree' (duration: 394.595965ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:10:01.619154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:10:01.224116Z","time spent":"395.021242ms","remote":"127.0.0.1:40658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-28T14:10:01.619115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.182969ms","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-28T14:10:01.619263Z","caller":"traceutil/trace.go:171","msg":"trace[315355944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:643; }","duration":"370.319115ms","start":"2026-07-28T14:10:01.248886Z","end":"2026-07-28T14:10:01.619205Z","steps":["trace[315355944] 'range keys from in-memory index tree' (duration: 369.936069ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:10:01.619354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:10:01.248872Z","time spent":"370.467441ms","remote":"127.0.0.1:40658","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-28T14:10:01.6195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.216849ms","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-28T14:10:01.620125Z","caller":"traceutil/trace.go:171","msg":"trace[108746000] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:643; }","duration":"385.869455ms","start":"2026-07-28T14:10:01.234236Z","end":"2026-07-28T14:10:01.620105Z","steps":["trace[108746000] 'range keys from in-memory index tree' (duration: 384.9693ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:10:01.620172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:10:01.23422Z","time spent":"385.936789ms","remote":"127.0.0.1:40658","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-28T14:10:01.944044Z","caller":"traceutil/trace.go:171","msg":"trace[1732392739] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"322.357528ms","start":"2026-07-28T14:10:01.621641Z","end":"2026-07-28T14:10:01.943998Z","steps":["trace[1732392739] 'read index received' (duration: 317.006605ms)","trace[1732392739] 'applied index is now lower than readState.Index' (duration: 5.350133ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T14:10:01.944153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.490033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T14:10:01.944177Z","caller":"traceutil/trace.go:171","msg":"trace[664615377] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:644; }","duration":"322.572717ms","start":"2026-07-28T14:10:01.621596Z","end":"2026-07-28T14:10:01.944169Z","steps":["trace[664615377] 'agreement among raft nodes before linearized reading' (duration: 322.509075ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:10:01.944142Z","caller":"traceutil/trace.go:171","msg":"trace[957778703] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"598.805322ms","start":"2026-07-28T14:10:01.345296Z","end":"2026-07-28T14:10:01.944102Z","steps":["trace[957778703] 'process raft request' (duration: 596.448228ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:10:01.944204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:10:01.621574Z","time spent":"322.624729ms","remote":"127.0.0.1:40428","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-28T14:10:01.944289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:10:01.345264Z","time spent":"598.959669ms","remote":"127.0.0.1:40520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T14:10:01.94586Z","caller":"traceutil/trace.go:171","msg":"trace[96954748] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"322.516105ms","start":"2026-07-28T14:10:01.623326Z","end":"2026-07-28T14:10:01.945842Z","steps":["trace[96954748] 'process raft request' (duration: 322.296006ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:10:01.94585Z","caller":"traceutil/trace.go:171","msg":"trace[2127379500] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"321.928361ms","start":"2026-07-28T14:10:01.623897Z","end":"2026-07-28T14:10:01.945826Z","steps":["trace[2127379500] 'process raft request' (duration: 321.873069ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:10:01.945966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:10:01.623291Z","time spent":"322.612388ms","remote":"127.0.0.1:40658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-28T14:10:01.946004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:10:01.62389Z","time spent":"322.028875ms","remote":"127.0.0.1:40658","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-28T14:10:01.946178Z","caller":"traceutil/trace.go:171","msg":"trace[774323688] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"321.868879ms","start":"2026-07-28T14:10:01.624299Z","end":"2026-07-28T14:10:01.946168Z","steps":["trace[774323688] 'process raft request' (duration: 321.498894ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:10:01.946181Z","caller":"traceutil/trace.go:171","msg":"trace[1133101550] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"321.824477ms","start":"2026-07-28T14:10:01.624339Z","end":"2026-07-28T14:10:01.946163Z","steps":["trace[1133101550] 'process raft request' (duration: 321.682901ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:10:01.946223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:10:01.624292Z","time spent":"321.90755ms","remote":"127.0.0.1:40658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-28T14:10:01.946303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:10:01.624333Z","time spent":"321.89108ms","remote":"127.0.0.1:40658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-28T14:10:03.594715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.830597ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-28T14:10:03.594908Z","caller":"traceutil/trace.go:171","msg":"trace[458205481] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"243.301884ms","start":"2026-07-28T14:10:03.351564Z","end":"2026-07-28T14:10:03.594866Z","steps":["trace[458205481] 'compare' (duration: 235.654801ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:10:16.680452Z","caller":"traceutil/trace.go:171","msg":"trace[1490637255] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"341.138549ms","start":"2026-07-28T14:10:16.339277Z","end":"2026-07-28T14:10:16.680415Z","steps":["trace[1490637255] 'process raft request' (duration: 340.941881ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:10:16.680919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:10:16.339253Z","time spent":"341.294645ms","remote":"127.0.0.1:40576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T14:10:17.028768Z","caller":"traceutil/trace.go:171","msg":"trace[1202269611] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"512.271522ms","start":"2026-07-28T14:10:16.51646Z","end":"2026-07-28T14:10:17.028732Z","steps":["trace[1202269611] 'process raft request' (duration: 511.985811ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:10:17.02938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:10:16.516432Z","time spent":"512.438948ms","remote":"127.0.0.1:40574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4904,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}