{"level":"warn","ts":"2026-04-10T03:51:08.494411Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-10T03:51:08.494557Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.43: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://162.253.55.43:2380","--initial-cluster=instance=https://162.253.55.43:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.43:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.43: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-04-10T03:51:08.494654Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-10T03:51:08.494665Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.43:2380"]} {"level":"info","ts":"2026-04-10T03:51:08.494696Z","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-04-10T03:51:08.495659Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"]} {"level":"info","ts":"2026-04-10T03:51:08.495843Z","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://162.253.55.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.43: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-04-10T03:51:08.500423Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.275859ms"} {"level":"info","ts":"2026-04-10T03:51:08.512163Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"14f8f2dfdaccebdb","cluster-id":"5f02ccb15672f35d"} {"level":"info","ts":"2026-04-10T03:51:08.512313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=()"} {"level":"info","ts":"2026-04-10T03:51:08.512372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 0"} {"level":"info","ts":"2026-04-10T03:51:08.512396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 14f8f2dfdaccebdb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-10T03:51:08.512406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 1"} {"level":"info","ts":"2026-04-10T03:51:08.512472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"} {"level":"warn","ts":"2026-04-10T03:51:08.518482Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-10T03:51:08.521292Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-10T03:51:08.522518Z","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-04-10T03:51:08.526081Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"14f8f2dfdaccebdb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-10T03:51:08.528021Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"14f8f2dfdaccebdb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-10T03:51:08.528138Z","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-04-10T03:51:08.528205Z","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-04-10T03:51:08.528215Z","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-04-10T03:51:08.528553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"} {"level":"info","ts":"2026-04-10T03:51:08.530742Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","added-peer-id":"14f8f2dfdaccebdb","added-peer-peer-urls":["https://162.253.55.43:2380"]} {"level":"info","ts":"2026-04-10T03:51:08.532034Z","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-04-10T03:51:08.532137Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.43:2380"} {"level":"info","ts":"2026-04-10T03:51:08.532154Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.43:2380"} {"level":"info","ts":"2026-04-10T03:51:08.532312Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"14f8f2dfdaccebdb","initial-advertise-peer-urls":["https://162.253.55.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-10T03:51:08.532349Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-10T03:51:08.813321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb is starting a new election at term 1"} {"level":"info","ts":"2026-04-10T03:51:08.814465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became pre-candidate at term 1"} {"level":"info","ts":"2026-04-10T03:51:08.815024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgPreVoteResp from 14f8f2dfdaccebdb at term 1"} {"level":"info","ts":"2026-04-10T03:51:08.815058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became candidate at term 2"} {"level":"info","ts":"2026-04-10T03:51:08.81507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgVoteResp from 14f8f2dfdaccebdb at term 2"} {"level":"info","ts":"2026-04-10T03:51:08.815087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became leader at term 2"} {"level":"info","ts":"2026-04-10T03:51:08.81514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 14f8f2dfdaccebdb elected leader 14f8f2dfdaccebdb at term 2"} {"level":"info","ts":"2026-04-10T03:51:08.815981Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T03:51:08.816531Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"14f8f2dfdaccebdb","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.43:2379]}","request-path":"/0/members/14f8f2dfdaccebdb/attributes","cluster-id":"5f02ccb15672f35d","publish-timeout":"7s"} {"level":"info","ts":"2026-04-10T03:51:08.816702Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T03:51:08.816784Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T03:51:08.816952Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T03:51:08.817227Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T03:51:08.817274Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T03:51:08.819788Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-10T03:51:08.819885Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-10T03:51:08.820341Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-10T03:51:08.821353Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.43:2379"} {"level":"info","ts":"2026-04-10T03:51:10.450526Z","caller":"traceutil/trace.go:171","msg":"trace[1688149157] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:5; }","duration":"117.525352ms","start":"2026-04-10T03:51:10.332968Z","end":"2026-04-10T03:51:10.450494Z","steps":["trace[1688149157] 'read index received' (duration: 100.216175ms)","trace[1688149157] 'applied index is now lower than readState.Index' (duration: 17.307837ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:10.450602Z","caller":"traceutil/trace.go:171","msg":"trace[1645473048] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"131.517157ms","start":"2026-04-10T03:51:10.319029Z","end":"2026-04-10T03:51:10.450546Z","steps":["trace[1645473048] 'process raft request' (duration: 114.082588ms)","trace[1645473048] 'compare' (duration: 17.249235ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:10.45078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.777816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T03:51:10.450919Z","caller":"traceutil/trace.go:171","msg":"trace[1297873383] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:3; }","duration":"117.912628ms","start":"2026-04-10T03:51:10.332961Z","end":"2026-04-10T03:51:10.450874Z","steps":["trace[1297873383] 'agreement among raft nodes before linearized reading' (duration: 117.670434ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:10.492193Z","caller":"traceutil/trace.go:171","msg":"trace[1477910554] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"155.910102ms","start":"2026-04-10T03:51:10.336241Z","end":"2026-04-10T03:51:10.492151Z","steps":["trace[1477910554] 'process raft request' (duration: 155.7671ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:10.492369Z","caller":"traceutil/trace.go:171","msg":"trace[625501096] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"155.879372ms","start":"2026-04-10T03:51:10.336472Z","end":"2026-04-10T03:51:10.492351Z","steps":["trace[625501096] 'process raft request' (duration: 155.570306ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:10.492211Z","caller":"traceutil/trace.go:171","msg":"trace[1903599451] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"156.195778ms","start":"2026-04-10T03:51:10.335911Z","end":"2026-04-10T03:51:10.492107Z","steps":["trace[1903599451] 'process raft request' (duration: 155.966784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:10.4926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.695967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T03:51:10.492656Z","caller":"traceutil/trace.go:171","msg":"trace[1183307067] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"156.76259ms","start":"2026-04-10T03:51:10.335877Z","end":"2026-04-10T03:51:10.49264Z","steps":["trace[1183307067] 'agreement among raft nodes before linearized reading' (duration: 156.691898ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:10.492282Z","caller":"traceutil/trace.go:171","msg":"trace[1649027552] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"155.383803ms","start":"2026-04-10T03:51:10.336871Z","end":"2026-04-10T03:51:10.492254Z","steps":["trace[1649027552] 'process raft request' (duration: 155.233911ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:10.492745Z","caller":"traceutil/trace.go:171","msg":"trace[1171349989] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"156.022096ms","start":"2026-04-10T03:51:10.336526Z","end":"2026-04-10T03:51:10.492548Z","steps":["trace[1171349989] 'process raft request' (duration: 155.552258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:10.492534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.169794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-10T03:51:10.492667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.764432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T03:51:10.492871Z","caller":"traceutil/trace.go:171","msg":"trace[788348226] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"158.535602ms","start":"2026-04-10T03:51:10.334325Z","end":"2026-04-10T03:51:10.49286Z","steps":["trace[788348226] 'agreement among raft nodes before linearized reading' (duration: 158.146564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:10.492543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.850727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T03:51:10.493044Z","caller":"traceutil/trace.go:171","msg":"trace[1922459448] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"106.422138ms","start":"2026-04-10T03:51:10.386611Z","end":"2026-04-10T03:51:10.493033Z","steps":["trace[1922459448] 'agreement among raft nodes before linearized reading' (duration: 105.737595ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:10.493041Z","caller":"traceutil/trace.go:171","msg":"trace[1629428768] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"120.144508ms","start":"2026-04-10T03:51:10.372746Z","end":"2026-04-10T03:51:10.492891Z","steps":["trace[1629428768] 'agreement among raft nodes before linearized reading' (duration: 119.604128ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:10.493208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.521569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.43\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T03:51:10.493243Z","caller":"traceutil/trace.go:171","msg":"trace[1039697313] range","detail":"{range_begin:/registry/masterleases/162.253.55.43; range_end:; response_count:0; response_revision:11; }","duration":"159.56929ms","start":"2026-04-10T03:51:10.333666Z","end":"2026-04-10T03:51:10.493235Z","steps":["trace[1039697313] 'agreement among raft nodes before linearized reading' (duration: 159.51463ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:10.492603Z","caller":"traceutil/trace.go:171","msg":"trace[654267036] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"155.562676ms","start":"2026-04-10T03:51:10.337023Z","end":"2026-04-10T03:51:10.492585Z","steps":["trace[654267036] 'process raft request' (duration: 155.115178ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:10.493068Z","caller":"traceutil/trace.go:171","msg":"trace[639749240] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"136.292774ms","start":"2026-04-10T03:51:10.356758Z","end":"2026-04-10T03:51:10.493051Z","steps":["trace[639749240] 'process raft request' (duration: 135.475219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:10.492743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.065728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T03:51:10.493472Z","caller":"traceutil/trace.go:171","msg":"trace[58269275] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"144.992383ms","start":"2026-04-10T03:51:10.347915Z","end":"2026-04-10T03:51:10.492907Z","steps":["trace[58269275] 'process raft request' (duration: 144.274801ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:10.493557Z","caller":"traceutil/trace.go:171","msg":"trace[1094325242] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"120.971314ms","start":"2026-04-10T03:51:10.372551Z","end":"2026-04-10T03:51:10.493522Z","steps":["trace[1094325242] 'agreement among raft nodes before linearized reading' (duration: 120.022806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:10.792534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.58324ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-10T03:51:10.792672Z","caller":"traceutil/trace.go:171","msg":"trace[1115662088] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"293.776797ms","start":"2026-04-10T03:51:10.498875Z","end":"2026-04-10T03:51:10.792652Z","steps":["trace[1115662088] 'process raft request' (duration: 162.225249ms)","trace[1115662088] 'compare' (duration: 130.360116ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:10.799867Z","caller":"traceutil/trace.go:171","msg":"trace[67793934] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"299.734975ms","start":"2026-04-10T03:51:10.500109Z","end":"2026-04-10T03:51:10.799844Z","steps":["trace[67793934] 'process raft request' (duration: 299.537313ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:10.800551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:10.500095Z","time spent":"300.408968ms","remote":"127.0.0.1:54594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:51:10.800031Z","caller":"traceutil/trace.go:171","msg":"trace[1488488183] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"298.822959ms","start":"2026-04-10T03:51:10.501177Z","end":"2026-04-10T03:51:10.799999Z","steps":["trace[1488488183] 'process raft request' (duration: 298.682796ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:10.800083Z","caller":"traceutil/trace.go:171","msg":"trace[1230390835] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"298.058495ms","start":"2026-04-10T03:51:10.502003Z","end":"2026-04-10T03:51:10.800062Z","steps":["trace[1230390835] 'process raft request' (duration: 297.917182ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:10.800066Z","caller":"traceutil/trace.go:171","msg":"trace[411451504] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"299.574973ms","start":"2026-04-10T03:51:10.500302Z","end":"2026-04-10T03:51:10.799877Z","steps":["trace[411451504] 'process raft request' (duration: 299.479081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:10.80105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:10.500273Z","time spent":"300.716493ms","remote":"127.0.0.1:54594","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":26,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:51:10.800101Z","caller":"traceutil/trace.go:171","msg":"trace[506980888] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"298.88009ms","start":"2026-04-10T03:51:10.501092Z","end":"2026-04-10T03:51:10.799972Z","steps":["trace[506980888] 'process raft request' (duration: 298.717227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:10.80129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:10.501085Z","time spent":"300.163524ms","remote":"127.0.0.1:55014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:51:10.800146Z","caller":"traceutil/trace.go:171","msg":"trace[1947087970] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"298.612875ms","start":"2026-04-10T03:51:10.501517Z","end":"2026-04-10T03:51:10.80013Z","steps":["trace[1947087970] 'process raft request' (duration: 298.370541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:10.801552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:10.501459Z","time spent":"300.045251ms","remote":"127.0.0.1:54894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:51:10.800146Z","caller":"traceutil/trace.go:171","msg":"trace[466527791] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"298.089905ms","start":"2026-04-10T03:51:10.502044Z","end":"2026-04-10T03:51:10.800134Z","steps":["trace[466527791] 'process raft request' (duration: 297.934053ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:10.800167Z","caller":"traceutil/trace.go:171","msg":"trace[959529780] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"298.142376ms","start":"2026-04-10T03:51:10.502015Z","end":"2026-04-10T03:51:10.800157Z","steps":["trace[959529780] 'process raft request' (duration: 297.935852ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:10.800149Z","caller":"traceutil/trace.go:171","msg":"trace[1655540089] linearizableReadLoop","detail":"{readStateIndex:17; appliedIndex:14; }","duration":"299.129194ms","start":"2026-04-10T03:51:10.500995Z","end":"2026-04-10T03:51:10.800124Z","steps":["trace[1655540089] 'read index received' (duration: 160.11781ms)","trace[1655540089] 'applied index is now lower than readState.Index' (duration: 139.010304ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:10.80021Z","caller":"traceutil/trace.go:171","msg":"trace[1141446026] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"293.738037ms","start":"2026-04-10T03:51:10.506458Z","end":"2026-04-10T03:51:10.800197Z","steps":["trace[1141446026] 'process raft request' (duration: 293.548763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:10.800305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.288028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T03:51:10.80219Z","caller":"traceutil/trace.go:171","msg":"trace[1918830492] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"301.197822ms","start":"2026-04-10T03:51:10.50097Z","end":"2026-04-10T03:51:10.802168Z","steps":["trace[1918830492] 'agreement among raft nodes before linearized reading' (duration: 299.232987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:10.802263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:10.500959Z","time spent":"301.278464ms","remote":"127.0.0.1:54478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T03:51:10.859271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.703661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-10T03:51:10.859318Z","caller":"traceutil/trace.go:171","msg":"trace[1698256147] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"301.783034ms","start":"2026-04-10T03:51:10.557524Z","end":"2026-04-10T03:51:10.859307Z","steps":["trace[1698256147] 'agreement among raft nodes before linearized reading' (duration: 301.6469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:10.859346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:10.557512Z","time spent":"301.825324ms","remote":"127.0.0.1:54594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":372,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-10T03:51:10.859344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.241107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T03:51:10.859384Z","caller":"traceutil/trace.go:171","msg":"trace[1955956070] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:21; }","duration":"158.346908ms","start":"2026-04-10T03:51:10.701025Z","end":"2026-04-10T03:51:10.859372Z","steps":["trace[1955956070] 'agreement among raft nodes before linearized reading' (duration: 158.274938ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:11.073406Z","caller":"traceutil/trace.go:171","msg":"trace[629155456] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"269.152681ms","start":"2026-04-10T03:51:10.804211Z","end":"2026-04-10T03:51:11.073363Z","steps":["trace[629155456] 'process raft request' (duration: 214.379813ms)","trace[629155456] 'compare' (duration: 54.482013ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:11.073457Z","caller":"traceutil/trace.go:171","msg":"trace[533202292] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"268.135083ms","start":"2026-04-10T03:51:10.805282Z","end":"2026-04-10T03:51:11.073417Z","steps":["trace[533202292] 'process raft request' (duration: 267.968589ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:11.07352Z","caller":"traceutil/trace.go:171","msg":"trace[1223922610] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"267.041902ms","start":"2026-04-10T03:51:10.806444Z","end":"2026-04-10T03:51:11.073486Z","steps":["trace[1223922610] 'process raft request' (duration: 266.94235ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:11.073816Z","caller":"traceutil/trace.go:171","msg":"trace[534464553] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"267.492901ms","start":"2026-04-10T03:51:10.806299Z","end":"2026-04-10T03:51:11.073792Z","steps":["trace[534464553] 'process raft request' (duration: 267.056843ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:11.073846Z","caller":"traceutil/trace.go:171","msg":"trace[1412568393] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"267.705845ms","start":"2026-04-10T03:51:10.806082Z","end":"2026-04-10T03:51:11.073787Z","steps":["trace[1412568393] 'process raft request' (duration: 267.229927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:11.073851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.184138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-10T03:51:11.073953Z","caller":"traceutil/trace.go:171","msg":"trace[2033705413] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:27; }","duration":"271.352572ms","start":"2026-04-10T03:51:10.802589Z","end":"2026-04-10T03:51:11.073941Z","steps":["trace[2033705413] 'agreement among raft nodes before linearized reading' (duration: 271.094567ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:11.073635Z","caller":"traceutil/trace.go:171","msg":"trace[1901760814] linearizableReadLoop","detail":"{readStateIndex:30; appliedIndex:25; }","duration":"214.524371ms","start":"2026-04-10T03:51:10.859084Z","end":"2026-04-10T03:51:11.073609Z","steps":["trace[1901760814] 'read index received' (duration: 159.570088ms)","trace[1901760814] 'applied index is now lower than readState.Index' (duration: 54.951783ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:11.074396Z","caller":"traceutil/trace.go:171","msg":"trace[2139881942] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"212.779499ms","start":"2026-04-10T03:51:10.861606Z","end":"2026-04-10T03:51:11.074385Z","steps":["trace[2139881942] 'process raft request' (duration: 212.740338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:11.074438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.848451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T03:51:11.073943Z","caller":"traceutil/trace.go:171","msg":"trace[1908631242] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"213.271408ms","start":"2026-04-10T03:51:10.860637Z","end":"2026-04-10T03:51:11.073908Z","steps":["trace[1908631242] 'process raft request' (duration: 212.78071ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:11.074543Z","caller":"traceutil/trace.go:171","msg":"trace[993613181] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:27; }","duration":"266.575283ms","start":"2026-04-10T03:51:10.807947Z","end":"2026-04-10T03:51:11.074523Z","steps":["trace[993613181] 'agreement among raft nodes before linearized reading' (duration: 265.782909ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:11.074962Z","caller":"traceutil/trace.go:171","msg":"trace[835872386] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"213.649295ms","start":"2026-04-10T03:51:10.861274Z","end":"2026-04-10T03:51:11.074923Z","steps":["trace[835872386] 'process raft request' (duration: 212.173718ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:11.190181Z","caller":"traceutil/trace.go:171","msg":"trace[1913297415] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"111.528383ms","start":"2026-04-10T03:51:11.078616Z","end":"2026-04-10T03:51:11.190145Z","steps":["trace[1913297415] 'process raft request' (duration: 99.591765ms)","trace[1913297415] 'compare' (duration: 11.675993ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:11.190261Z","caller":"traceutil/trace.go:171","msg":"trace[1707575426] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"111.37852ms","start":"2026-04-10T03:51:11.078855Z","end":"2026-04-10T03:51:11.190233Z","steps":["trace[1707575426] 'process raft request' (duration: 111.138986ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:11.190534Z","caller":"traceutil/trace.go:171","msg":"trace[1442498246] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"111.273548ms","start":"2026-04-10T03:51:11.079244Z","end":"2026-04-10T03:51:11.190517Z","steps":["trace[1442498246] 'process raft request' (duration: 111.028513ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:11.190574Z","caller":"traceutil/trace.go:171","msg":"trace[667817368] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"111.677736ms","start":"2026-04-10T03:51:11.078883Z","end":"2026-04-10T03:51:11.190561Z","steps":["trace[667817368] 'process raft request' (duration: 111.186087ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:11.190612Z","caller":"traceutil/trace.go:171","msg":"trace[479040919] linearizableReadLoop","detail":"{readStateIndex:39; appliedIndex:34; }","duration":"111.401851ms","start":"2026-04-10T03:51:11.079183Z","end":"2026-04-10T03:51:11.190585Z","steps":["trace[479040919] 'read index received' (duration: 64.919894ms)","trace[479040919] 'applied index is now lower than readState.Index' (duration: 46.480417ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:11.190672Z","caller":"traceutil/trace.go:171","msg":"trace[51661178] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"111.705806ms","start":"2026-04-10T03:51:11.078956Z","end":"2026-04-10T03:51:11.190662Z","steps":["trace[51661178] 'process raft request' (duration: 111.275528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:11.190808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.594234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T03:51:11.190878Z","caller":"traceutil/trace.go:171","msg":"trace[1003368341] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:37; }","duration":"111.701395ms","start":"2026-04-10T03:51:11.079148Z","end":"2026-04-10T03:51:11.19085Z","steps":["trace[1003368341] 'agreement among raft nodes before linearized reading' (duration: 111.537463ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:11.190993Z","caller":"traceutil/trace.go:171","msg":"trace[1368701305] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"112.062452ms","start":"2026-04-10T03:51:11.07891Z","end":"2026-04-10T03:51:11.190972Z","steps":["trace[1368701305] 'process raft request' (duration: 111.271728ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:11.73434Z","caller":"traceutil/trace.go:171","msg":"trace[903807881] linearizableReadLoop","detail":"{readStateIndex:55; appliedIndex:53; }","duration":"447.693451ms","start":"2026-04-10T03:51:11.286613Z","end":"2026-04-10T03:51:11.734307Z","steps":["trace[903807881] 'read index received' (duration: 399.516753ms)","trace[903807881] 'applied index is now lower than readState.Index' (duration: 48.175248ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:11.734539Z","caller":"traceutil/trace.go:171","msg":"trace[820232385] transaction","detail":"{read_only:false; response_revision:51; number_of_response:1; }","duration":"448.004756ms","start":"2026-04-10T03:51:11.286519Z","end":"2026-04-10T03:51:11.734524Z","steps":["trace[820232385] 'process raft request' (duration: 447.670739ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:11.734621Z","caller":"traceutil/trace.go:171","msg":"trace[384428477] transaction","detail":"{read_only:false; response_revision:50; number_of_response:1; }","duration":"449.991062ms","start":"2026-04-10T03:51:11.284585Z","end":"2026-04-10T03:51:11.734576Z","steps":["trace[384428477] 'process raft request' (duration: 401.474848ms)","trace[384428477] 'compare' (duration: 47.890472ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:11.734846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:11.284566Z","time spent":"450.189787ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":826,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:51:11.734959Z","caller":"traceutil/trace.go:171","msg":"trace[1600786472] transaction","detail":"{read_only:false; response_revision:52; number_of_response:1; }","duration":"444.91913ms","start":"2026-04-10T03:51:11.289999Z","end":"2026-04-10T03:51:11.734918Z","steps":["trace[1600786472] 'process raft request' (duration: 444.251558ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:11.735047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.407714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-10T03:51:11.735216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.479545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T03:51:11.735235Z","caller":"traceutil/trace.go:171","msg":"trace[604649789] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:52; }","duration":"448.625948ms","start":"2026-04-10T03:51:11.286583Z","end":"2026-04-10T03:51:11.735209Z","steps":["trace[604649789] 'agreement among raft nodes before linearized reading' (duration: 448.309143ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:11.735291Z","caller":"traceutil/trace.go:171","msg":"trace[1112173503] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:52; }","duration":"228.554006ms","start":"2026-04-10T03:51:11.506697Z","end":"2026-04-10T03:51:11.735251Z","steps":["trace[1112173503] 'agreement among raft nodes before linearized reading' (duration: 228.499055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:11.735291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:11.289985Z","time spent":"445.031262ms","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1059,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T03:51:11.735316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.300977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T03:51:11.73537Z","caller":"traceutil/trace.go:171","msg":"trace[161099997] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:52; }","duration":"445.368568ms","start":"2026-04-10T03:51:11.289984Z","end":"2026-04-10T03:51:11.735352Z","steps":["trace[161099997] 'agreement among raft nodes before linearized reading' (duration: 445.292457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:11.735344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:11.286569Z","time spent":"448.76061ms","remote":"127.0.0.1:54848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/admin\" "} {"level":"warn","ts":"2026-04-10T03:51:11.735422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:11.289972Z","time spent":"445.439049ms","remote":"127.0.0.1:54484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T03:51:11.734693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:11.286488Z","time spent":"448.105568ms","remote":"127.0.0.1:54878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T03:51:11.73514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.152625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-10T03:51:11.735789Z","caller":"traceutil/trace.go:171","msg":"trace[1106204967] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:52; }","duration":"445.865847ms","start":"2026-04-10T03:51:11.289908Z","end":"2026-04-10T03:51:11.735774Z","steps":["trace[1106204967] 'agreement among raft nodes before linearized reading' (duration: 445.080273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:11.735838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:11.28988Z","time spent":"445.944999ms","remote":"127.0.0.1:54608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":26,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"info","ts":"2026-04-10T03:51:12.838646Z","caller":"traceutil/trace.go:171","msg":"trace[1812499736] transaction","detail":"{read_only:false; response_revision:120; number_of_response:1; }","duration":"221.529892ms","start":"2026-04-10T03:51:12.617082Z","end":"2026-04-10T03:51:12.838611Z","steps":["trace[1812499736] 'process raft request' (duration: 182.675877ms)","trace[1812499736] 'compare' (duration: 38.701492ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:13.080854Z","caller":"traceutil/trace.go:171","msg":"trace[779007034] transaction","detail":"{read_only:false; response_revision:126; number_of_response:1; }","duration":"149.57222ms","start":"2026-04-10T03:51:12.931248Z","end":"2026-04-10T03:51:13.080821Z","steps":["trace[779007034] 'process raft request' (duration: 149.509819ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:13.080991Z","caller":"traceutil/trace.go:171","msg":"trace[1240978402] transaction","detail":"{read_only:false; response_revision:125; number_of_response:1; }","duration":"151.770699ms","start":"2026-04-10T03:51:12.929174Z","end":"2026-04-10T03:51:13.080945Z","steps":["trace[1240978402] 'process raft request' (duration: 77.140609ms)","trace[1240978402] 'compare' (duration: 74.256053ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:13.420912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.28734ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-10T03:51:13.421019Z","caller":"traceutil/trace.go:171","msg":"trace[1839899214] linearizableReadLoop","detail":"{readStateIndex:132; appliedIndex:131; }","duration":"113.362479ms","start":"2026-04-10T03:51:13.307637Z","end":"2026-04-10T03:51:13.420999Z","steps":["trace[1839899214] 'read index received' (duration: 5.873785ms)","trace[1839899214] 'applied index is now lower than readState.Index' (duration: 107.487194ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:13.421165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.469181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T03:51:13.421202Z","caller":"traceutil/trace.go:171","msg":"trace[654838261] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:128; }","duration":"113.565013ms","start":"2026-04-10T03:51:13.307627Z","end":"2026-04-10T03:51:13.421192Z","steps":["trace[654838261] 'agreement among raft nodes before linearized reading' (duration: 113.423311ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:13.421312Z","caller":"traceutil/trace.go:171","msg":"trace[1080253586] transaction","detail":"{read_only:false; response_revision:128; number_of_response:1; }","duration":"320.792443ms","start":"2026-04-10T03:51:13.100354Z","end":"2026-04-10T03:51:13.421146Z","steps":["trace[1080253586] 'process raft request' (duration: 213.193167ms)","trace[1080253586] 'compare' (duration: 107.115586ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:13.421672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:13.100342Z","time spent":"321.133399ms","remote":"127.0.0.1:54848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":828,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T03:51:13.940201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.717482ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-10T03:51:13.940334Z","caller":"traceutil/trace.go:171","msg":"trace[434161422] linearizableReadLoop","detail":"{readStateIndex:138; appliedIndex:137; }","duration":"234.262968ms","start":"2026-04-10T03:51:13.70605Z","end":"2026-04-10T03:51:13.940313Z","steps":["trace[434161422] 'read index received' (duration: 123.26106ms)","trace[434161422] 'applied index is now lower than readState.Index' (duration: 111.000558ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:13.940571Z","caller":"traceutil/trace.go:171","msg":"trace[989655628] transaction","detail":"{read_only:false; response_revision:134; number_of_response:1; }","duration":"262.776654ms","start":"2026-04-10T03:51:13.677637Z","end":"2026-04-10T03:51:13.940414Z","steps":["trace[989655628] 'process raft request' (duration: 151.755566ms)","trace[989655628] 'compare' (duration: 110.500248ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:13.94061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.559432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T03:51:13.940837Z","caller":"traceutil/trace.go:171","msg":"trace[833209868] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:134; }","duration":"234.757726ms","start":"2026-04-10T03:51:13.70603Z","end":"2026-04-10T03:51:13.940788Z","steps":["trace[833209868] 'agreement among raft nodes before linearized reading' (duration: 234.337048ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:15.12458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.538696ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-10T03:51:15.124697Z","caller":"traceutil/trace.go:171","msg":"trace[781759981] transaction","detail":"{read_only:false; response_revision:137; number_of_response:1; }","duration":"1.129062377s","start":"2026-04-10T03:51:13.995614Z","end":"2026-04-10T03:51:15.124677Z","steps":["trace[781759981] 'process raft request' (duration: 802.337538ms)","trace[781759981] 'compare' (duration: 326.390864ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:15.124756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:13.995588Z","time spent":"1.129143999s","remote":"127.0.0.1:54848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":713,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T03:51:15.156915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:14.176104Z","time spent":"980.803433ms","remote":"127.0.0.1:54560","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-10T03:51:15.157018Z","caller":"traceutil/trace.go:171","msg":"trace[1960768799] transaction","detail":"{read_only:false; response_revision:138; number_of_response:1; }","duration":"575.030041ms","start":"2026-04-10T03:51:14.581958Z","end":"2026-04-10T03:51:15.156988Z","steps":["trace[1960768799] 'process raft request' (duration: 574.814657ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:15.157038Z","caller":"traceutil/trace.go:171","msg":"trace[2067502520] transaction","detail":"{read_only:false; response_revision:139; number_of_response:1; }","duration":"520.368107ms","start":"2026-04-10T03:51:14.63665Z","end":"2026-04-10T03:51:15.157018Z","steps":["trace[2067502520] 'process raft request' (duration: 520.266085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:15.157123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:14.581928Z","time spent":"575.142334ms","remote":"127.0.0.1:54664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5877,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T03:51:15.157219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:14.636622Z","time spent":"520.512789ms","remote":"127.0.0.1:54664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T03:51:15.157349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.402491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T03:51:15.15748Z","caller":"traceutil/trace.go:171","msg":"trace[1627457044] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:139; }","duration":"750.523283ms","start":"2026-04-10T03:51:14.406922Z","end":"2026-04-10T03:51:15.157445Z","steps":["trace[1627457044] 'agreement among raft nodes before linearized reading' (duration: 750.280439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:15.157597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:14.406847Z","time spent":"750.694626ms","remote":"127.0.0.1:54484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-10T03:51:15.158232Z","caller":"traceutil/trace.go:171","msg":"trace[253063031] linearizableReadLoop","detail":"{readStateIndex:142; appliedIndex:140; }","duration":"750.010445ms","start":"2026-04-10T03:51:14.406939Z","end":"2026-04-10T03:51:15.15695Z","steps":["trace[253063031] 'read index received' (duration: 391.096898ms)","trace[253063031] 'applied index is now lower than readState.Index' (duration: 358.912357ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:15.159201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.40531ms","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-04-10T03:51:15.159563Z","caller":"traceutil/trace.go:171","msg":"trace[1917569698] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:139; }","duration":"523.818968ms","start":"2026-04-10T03:51:14.63569Z","end":"2026-04-10T03:51:15.159509Z","steps":["trace[1917569698] 'agreement among raft nodes before linearized reading' (duration: 522.766579ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:15.160673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:14.635669Z","time spent":"524.984049ms","remote":"127.0.0.1:54756","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-04-10T03:51:16.711995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.484968907s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-10T03:51:16.712272Z","caller":"traceutil/trace.go:171","msg":"trace[1195167236] linearizableReadLoop","detail":"{readStateIndex:149; appliedIndex:145; }","duration":"1.206481517s","start":"2026-04-10T03:51:15.505772Z","end":"2026-04-10T03:51:16.712254Z","steps":["trace[1195167236] 'read index received' (duration: 117.709493ms)","trace[1195167236] 'applied index is now lower than readState.Index' (duration: 1.088770824s)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:16.712289Z","caller":"traceutil/trace.go:171","msg":"trace[121397531] transaction","detail":"{read_only:false; response_revision:141; number_of_response:1; }","duration":"1.549017147s","start":"2026-04-10T03:51:15.163235Z","end":"2026-04-10T03:51:16.712252Z","steps":["trace[121397531] 'process raft request' (duration: 63.721574ms)","trace[121397531] 'compare' (duration: 1.484803104s)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:16.71238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.206609299s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T03:51:16.712421Z","caller":"traceutil/trace.go:171","msg":"trace[894435812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:144; }","duration":"1.206699211s","start":"2026-04-10T03:51:15.505707Z","end":"2026-04-10T03:51:16.712406Z","steps":["trace[894435812] 'agreement among raft nodes before linearized reading' (duration: 1.206605299s)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:16.712381Z","caller":"traceutil/trace.go:171","msg":"trace[404194542] transaction","detail":"{read_only:false; response_revision:142; number_of_response:1; }","duration":"1.548724582s","start":"2026-04-10T03:51:15.163578Z","end":"2026-04-10T03:51:16.712303Z","steps":["trace[404194542] 'process raft request' (duration: 1.548505938s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:16.712459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:15.50568Z","time spent":"1.206771433s","remote":"127.0.0.1:54484","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-04-10T03:51:16.71245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:15.163216Z","time spent":"1.549159649s","remote":"127.0.0.1:54848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":678,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:51:16.712531Z","caller":"traceutil/trace.go:171","msg":"trace[1084252730] transaction","detail":"{read_only:false; response_revision:143; number_of_response:1; }","duration":"1.547424339s","start":"2026-04-10T03:51:15.165086Z","end":"2026-04-10T03:51:16.71251Z","steps":["trace[1084252730] 'process raft request' (duration: 1.547076123s)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:16.712593Z","caller":"traceutil/trace.go:171","msg":"trace[91357768] transaction","detail":"{read_only:false; response_revision:144; number_of_response:1; }","duration":"1.535974423s","start":"2026-04-10T03:51:15.176579Z","end":"2026-04-10T03:51:16.712553Z","steps":["trace[91357768] 'process raft request' (duration: 1.535626037s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:16.712663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:15.165077Z","time spent":"1.54752008s","remote":"127.0.0.1:54756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T03:51:16.712663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:15.163558Z","time spent":"1.548942345s","remote":"127.0.0.1:54756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T03:51:16.712801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:15.176557Z","time spent":"1.536132186s","remote":"127.0.0.1:54560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:51:17.511517Z","caller":"traceutil/trace.go:171","msg":"trace[1680964984] transaction","detail":"{read_only:false; response_revision:234; number_of_response:1; }","duration":"104.30106ms","start":"2026-04-10T03:51:17.407184Z","end":"2026-04-10T03:51:17.511485Z","steps":["trace[1680964984] 'process raft request' (duration: 71.80153ms)","trace[1680964984] 'compare' (duration: 32.366528ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:18.086314Z","caller":"traceutil/trace.go:171","msg":"trace[510352682] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"102.473901ms","start":"2026-04-10T03:51:17.983813Z","end":"2026-04-10T03:51:18.086287Z","steps":["trace[510352682] 'process raft request' (duration: 33.312282ms)","trace[510352682] 'compare' (duration: 69.053287ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:18.788495Z","caller":"traceutil/trace.go:171","msg":"trace[804464520] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"197.255515ms","start":"2026-04-10T03:51:18.591214Z","end":"2026-04-10T03:51:18.78847Z","steps":["trace[804464520] 'process raft request' (duration: 182.301029ms)","trace[804464520] 'compare' (duration: 14.792573ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:21.085901Z","caller":"traceutil/trace.go:171","msg":"trace[482426292] transaction","detail":"{read_only:false; number_of_response:0; response_revision:317; }","duration":"251.676409ms","start":"2026-04-10T03:51:20.834194Z","end":"2026-04-10T03:51:21.085871Z","steps":["trace[482426292] 'process raft request' (duration: 251.539736ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:21.08591Z","caller":"traceutil/trace.go:171","msg":"trace[1026844506] transaction","detail":"{read_only:false; number_of_response:0; response_revision:317; }","duration":"251.720339ms","start":"2026-04-10T03:51:20.834133Z","end":"2026-04-10T03:51:21.085853Z","steps":["trace[1026844506] 'process raft request' (duration: 251.495616ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:21.086078Z","caller":"traceutil/trace.go:171","msg":"trace[503823472] linearizableReadLoop","detail":"{readStateIndex:338; appliedIndex:330; }","duration":"166.987014ms","start":"2026-04-10T03:51:20.919062Z","end":"2026-04-10T03:51:21.086049Z","steps":["trace[503823472] 'read index received' (duration: 166.388083ms)","trace[503823472] 'applied index is now lower than readState.Index' (duration: 597.371µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:21.086222Z","caller":"traceutil/trace.go:171","msg":"trace[666701712] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"237.854154ms","start":"2026-04-10T03:51:20.848344Z","end":"2026-04-10T03:51:21.086198Z","steps":["trace[666701712] 'process raft request' (duration: 237.531809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:21.086251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.168066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4130"} {"level":"info","ts":"2026-04-10T03:51:21.086299Z","caller":"traceutil/trace.go:171","msg":"trace[2028081769] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:322; }","duration":"167.268738ms","start":"2026-04-10T03:51:20.919019Z","end":"2026-04-10T03:51:21.086287Z","steps":["trace[2028081769] 'agreement among raft nodes before linearized reading' (duration: 167.148966ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:21.086427Z","caller":"traceutil/trace.go:171","msg":"trace[1057838744] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"238.19355ms","start":"2026-04-10T03:51:20.848216Z","end":"2026-04-10T03:51:21.086409Z","steps":["trace[1057838744] 'process raft request' (duration: 237.57247ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:21.086591Z","caller":"traceutil/trace.go:171","msg":"trace[493950717] transaction","detail":"{read_only:false; number_of_response:0; response_revision:317; }","duration":"252.073907ms","start":"2026-04-10T03:51:20.834509Z","end":"2026-04-10T03:51:21.086583Z","steps":["trace[493950717] 'process raft request' (duration: 251.257102ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:21.086621Z","caller":"traceutil/trace.go:171","msg":"trace[97273322] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"237.085731ms","start":"2026-04-10T03:51:20.849519Z","end":"2026-04-10T03:51:21.086604Z","steps":["trace[97273322] 'process raft request' (duration: 236.409729ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:21.08677Z","caller":"traceutil/trace.go:171","msg":"trace[62907576] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"234.621338ms","start":"2026-04-10T03:51:20.852139Z","end":"2026-04-10T03:51:21.08676Z","steps":["trace[62907576] 'process raft request' (duration: 233.825863ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:21.086889Z","caller":"traceutil/trace.go:171","msg":"trace[1326612556] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"233.066641ms","start":"2026-04-10T03:51:20.853809Z","end":"2026-04-10T03:51:21.086875Z","steps":["trace[1326612556] 'process raft request' (duration: 232.188025ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:21.383746Z","caller":"traceutil/trace.go:171","msg":"trace[1070044371] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"178.594244ms","start":"2026-04-10T03:51:21.20509Z","end":"2026-04-10T03:51:21.383684Z","steps":["trace[1070044371] 'process raft request' (duration: 100.618511ms)","trace[1070044371] 'compare' (duration: 77.81184ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:21.384156Z","caller":"traceutil/trace.go:171","msg":"trace[590961120] linearizableReadLoop","detail":"{readStateIndex:344; appliedIndex:343; }","duration":"135.816481ms","start":"2026-04-10T03:51:21.248316Z","end":"2026-04-10T03:51:21.384133Z","steps":["trace[590961120] 'read index received' (duration: 57.283878ms)","trace[590961120] 'applied index is now lower than readState.Index' (duration: 78.530163ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:21.384804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.028834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-10T03:51:21.384945Z","caller":"traceutil/trace.go:171","msg":"trace[1292864535] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:329; }","duration":"136.664186ms","start":"2026-04-10T03:51:21.248237Z","end":"2026-04-10T03:51:21.384901Z","steps":["trace[1292864535] 'agreement among raft nodes before linearized reading' (duration: 135.966533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:21.820449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.053255ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T03:51:21.82067Z","caller":"traceutil/trace.go:171","msg":"trace[1416200730] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"372.398536ms","start":"2026-04-10T03:51:21.448254Z","end":"2026-04-10T03:51:21.820652Z","steps":["trace[1416200730] 'process raft request' (duration: 372.332455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:21.820746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:21.448243Z","time spent":"372.471817ms","remote":"127.0.0.1:54682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":217,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:51:21.820791Z","caller":"traceutil/trace.go:171","msg":"trace[376062111] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"384.477429ms","start":"2026-04-10T03:51:21.436263Z","end":"2026-04-10T03:51:21.82074Z","steps":["trace[376062111] 'process raft request' (duration: 248.018866ms)","trace[376062111] 'compare' (duration: 135.932413ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:21.820963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:21.436253Z","time spent":"384.615211ms","remote":"127.0.0.1:54664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7279,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T03:51:22.825544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.01469ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-10T03:51:22.82566Z","caller":"traceutil/trace.go:171","msg":"trace[411675682] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"917.323786ms","start":"2026-04-10T03:51:21.908317Z","end":"2026-04-10T03:51:22.82564Z","steps":["trace[411675682] 'process raft request' (duration: 480.141583ms)","trace[411675682] 'compare' (duration: 436.887438ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:22.825747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:21.908304Z","time spent":"917.410868ms","remote":"127.0.0.1:54682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":178,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T03:51:24.524458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.097708805s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-10T03:51:24.524574Z","caller":"traceutil/trace.go:171","msg":"trace[1658012618] linearizableReadLoop","detail":"{readStateIndex:353; appliedIndex:352; }","duration":"1.432407402s","start":"2026-04-10T03:51:23.092149Z","end":"2026-04-10T03:51:24.524557Z","steps":["trace[1658012618] 'read index received' (duration: 334.454732ms)","trace[1658012618] 'applied index is now lower than readState.Index' (duration: 1.09795151s)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:24.524658Z","caller":"traceutil/trace.go:171","msg":"trace[1781528562] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"1.687074018s","start":"2026-04-10T03:51:22.837574Z","end":"2026-04-10T03:51:24.524648Z","steps":["trace[1781528562] 'process raft request' (duration: 589.108378ms)","trace[1781528562] 'compare' (duration: 1.097556783s)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:24.524713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:22.837552Z","time spent":"1.68713297s","remote":"127.0.0.1:54682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T03:51:24.524828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.431457297s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-10T03:51:24.524821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.432568117s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-10T03:51:24.524821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.134188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T03:51:24.524885Z","caller":"traceutil/trace.go:171","msg":"trace[2051202915] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:337; }","duration":"1.431537947s","start":"2026-04-10T03:51:23.09333Z","end":"2026-04-10T03:51:24.524868Z","steps":["trace[2051202915] 'agreement among raft nodes before linearized reading' (duration: 1.431408155s)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:24.524902Z","caller":"traceutil/trace.go:171","msg":"trace[836591625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:337; }","duration":"1.432696357s","start":"2026-04-10T03:51:23.092182Z","end":"2026-04-10T03:51:24.524878Z","steps":["trace[836591625] 'agreement among raft nodes before linearized reading' (duration: 1.432514115s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:24.524925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:23.09332Z","time spent":"1.431597889s","remote":"127.0.0.1:54756","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-04-10T03:51:24.524946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:23.092157Z","time spent":"1.432780709s","remote":"127.0.0.1:54756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-10T03:51:24.52494Z","caller":"traceutil/trace.go:171","msg":"trace[884161838] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:337; }","duration":"112.30234ms","start":"2026-04-10T03:51:24.412607Z","end":"2026-04-10T03:51:24.52491Z","steps":["trace[884161838] 'agreement among raft nodes before linearized reading' (duration: 112.103986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:24.524974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.432791179s","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-04-10T03:51:24.525064Z","caller":"traceutil/trace.go:171","msg":"trace[574144566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:337; }","duration":"1.432928163s","start":"2026-04-10T03:51:23.092114Z","end":"2026-04-10T03:51:24.525042Z","steps":["trace[574144566] 'agreement among raft nodes before linearized reading' (duration: 1.432690189s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:24.525109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:23.092097Z","time spent":"1.433003984s","remote":"127.0.0.1:54756","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-04-10T03:51:25.034743Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995350746861527816,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-10T03:51:25.496102Z","caller":"traceutil/trace.go:171","msg":"trace[113286724] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"962.782949ms","start":"2026-04-10T03:51:24.533282Z","end":"2026-04-10T03:51:25.496065Z","steps":["trace[113286724] 'process raft request' (duration: 962.019825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:25.496262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:24.533271Z","time spent":"962.906682ms","remote":"127.0.0.1:54756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T03:51:25.648626Z","caller":"traceutil/trace.go:171","msg":"trace[1239434307] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"1.11504653s","start":"2026-04-10T03:51:24.533528Z","end":"2026-04-10T03:51:25.648575Z","steps":["trace[1239434307] 'process raft request' (duration: 1.114754704s)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:25.648773Z","caller":"traceutil/trace.go:171","msg":"trace[1107158751] linearizableReadLoop","detail":"{readStateIndex:357; appliedIndex:353; }","duration":"1.114037041s","start":"2026-04-10T03:51:24.534702Z","end":"2026-04-10T03:51:25.648739Z","steps":["trace[1107158751] 'read index received' (duration: 961.237881ms)","trace[1107158751] 'applied index is now lower than readState.Index' (duration: 152.79772ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:25.648807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:24.533461Z","time spent":"1.115250224s","remote":"127.0.0.1:54756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T03:51:25.648635Z","caller":"traceutil/trace.go:171","msg":"trace[281264842] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"1.111247764s","start":"2026-04-10T03:51:24.537361Z","end":"2026-04-10T03:51:25.648609Z","steps":["trace[281264842] 'process raft request' (duration: 1.11104436s)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:25.649003Z","caller":"traceutil/trace.go:171","msg":"trace[1128425949] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"1.107852545s","start":"2026-04-10T03:51:24.54114Z","end":"2026-04-10T03:51:25.648993Z","steps":["trace[1128425949] 'process raft request' (duration: 1.107320616s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:25.649066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:24.537352Z","time spent":"1.111676811s","remote":"127.0.0.1:54756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T03:51:25.649173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:24.541114Z","time spent":"1.107921395s","remote":"127.0.0.1:54664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7279,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T03:51:25.649339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.114634393s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T03:51:25.649383Z","caller":"traceutil/trace.go:171","msg":"trace[433843691] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:0; response_revision:341; }","duration":"1.114701774s","start":"2026-04-10T03:51:24.534665Z","end":"2026-04-10T03:51:25.649367Z","steps":["trace[433843691] 'agreement among raft nodes before linearized reading' (duration: 1.114639502s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:25.649374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.86796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T03:51:25.649414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:24.534655Z","time spent":"1.114752624s","remote":"127.0.0.1:54682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"info","ts":"2026-04-10T03:51:25.649473Z","caller":"traceutil/trace.go:171","msg":"trace[1449482714] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:341; }","duration":"115.089744ms","start":"2026-04-10T03:51:25.534366Z","end":"2026-04-10T03:51:25.649456Z","steps":["trace[1449482714] 'agreement among raft nodes before linearized reading' (duration: 114.93635ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:25.775346Z","caller":"traceutil/trace.go:171","msg":"trace[1423285877] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"117.458225ms","start":"2026-04-10T03:51:25.657872Z","end":"2026-04-10T03:51:25.77533Z","steps":["trace[1423285877] 'process raft request' (duration: 115.664093ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:25.815747Z","caller":"traceutil/trace.go:171","msg":"trace[150167960] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"155.507987ms","start":"2026-04-10T03:51:25.660221Z","end":"2026-04-10T03:51:25.815729Z","steps":["trace[150167960] 'process raft request' (duration: 155.318823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:26.255862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.046939ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-10T03:51:26.256047Z","caller":"traceutil/trace.go:171","msg":"trace[447726139] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"141.754031ms","start":"2026-04-10T03:51:26.114202Z","end":"2026-04-10T03:51:26.255957Z","steps":["trace[447726139] 'process raft request' (duration: 34.529449ms)","trace[447726139] 'compare' (duration: 106.874096ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:26.256414Z","caller":"traceutil/trace.go:171","msg":"trace[1689747206] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"135.219908ms","start":"2026-04-10T03:51:26.121167Z","end":"2026-04-10T03:51:26.256387Z","steps":["trace[1689747206] 'process raft request' (duration: 135.016864ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:26.256502Z","caller":"traceutil/trace.go:171","msg":"trace[1462012380] linearizableReadLoop","detail":"{readStateIndex:370; appliedIndex:365; }","duration":"125.331356ms","start":"2026-04-10T03:51:26.131128Z","end":"2026-04-10T03:51:26.256459Z","steps":["trace[1462012380] 'read index received' (duration: 17.711718ms)","trace[1462012380] 'applied index is now lower than readState.Index' (duration: 107.617948ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:26.256723Z","caller":"traceutil/trace.go:171","msg":"trace[893371233] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"133.671501ms","start":"2026-04-10T03:51:26.123032Z","end":"2026-04-10T03:51:26.256703Z","steps":["trace[893371233] 'process raft request' (duration: 133.378626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:26.256862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.716313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-10T03:51:26.256933Z","caller":"traceutil/trace.go:171","msg":"trace[653215837] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:354; }","duration":"125.805844ms","start":"2026-04-10T03:51:26.13111Z","end":"2026-04-10T03:51:26.256916Z","steps":["trace[653215837] 'agreement among raft nodes before linearized reading' (duration: 125.690112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:26.256977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.045626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-10T03:51:26.257023Z","caller":"traceutil/trace.go:171","msg":"trace[1837759733] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:354; }","duration":"123.103587ms","start":"2026-04-10T03:51:26.133905Z","end":"2026-04-10T03:51:26.257008Z","steps":["trace[1837759733] 'agreement among raft nodes before linearized reading' (duration: 123.026146ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:26.256867Z","caller":"traceutil/trace.go:171","msg":"trace[1936085648] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"134.521926ms","start":"2026-04-10T03:51:26.122328Z","end":"2026-04-10T03:51:26.25685Z","steps":["trace[1936085648] 'process raft request' (duration: 134.032927ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:26.256783Z","caller":"traceutil/trace.go:171","msg":"trace[1972001972] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"134.446735ms","start":"2026-04-10T03:51:26.122299Z","end":"2026-04-10T03:51:26.256746Z","steps":["trace[1972001972] 'process raft request' (duration: 134.004687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:26.925188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.078677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4368"} {"level":"warn","ts":"2026-04-10T03:51:26.925198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.132648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-04-10T03:51:26.925257Z","caller":"traceutil/trace.go:171","msg":"trace[701073012] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:385; }","duration":"172.202559ms","start":"2026-04-10T03:51:26.75304Z","end":"2026-04-10T03:51:26.925242Z","steps":["trace[701073012] 'range keys from in-memory index tree' (duration: 171.985475ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:26.925282Z","caller":"traceutil/trace.go:171","msg":"trace[1356205223] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:385; }","duration":"172.28437ms","start":"2026-04-10T03:51:26.752976Z","end":"2026-04-10T03:51:26.92526Z","steps":["trace[1356205223] 'range keys from in-memory index tree' (duration: 171.983515ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:27.107415Z","caller":"traceutil/trace.go:171","msg":"trace[2138715631] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"105.70031ms","start":"2026-04-10T03:51:27.001689Z","end":"2026-04-10T03:51:27.107389Z","steps":["trace[2138715631] 'process raft request' (duration: 87.615557ms)","trace[2138715631] 'compare' (duration: 17.86871ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:27.108411Z","caller":"traceutil/trace.go:171","msg":"trace[1696654539] linearizableReadLoop","detail":"{readStateIndex:404; appliedIndex:402; }","duration":"106.156608ms","start":"2026-04-10T03:51:27.002238Z","end":"2026-04-10T03:51:27.108394Z","steps":["trace[1696654539] 'read index received' (duration: 21.849589ms)","trace[1696654539] 'applied index is now lower than readState.Index' (duration: 84.297229ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:27.108568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.31711ms","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-04-10T03:51:27.109246Z","caller":"traceutil/trace.go:171","msg":"trace[1320682420] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:389; }","duration":"107.019853ms","start":"2026-04-10T03:51:27.00219Z","end":"2026-04-10T03:51:27.10921Z","steps":["trace[1320682420] 'agreement among raft nodes before linearized reading' (duration: 106.31088ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:28.296547Z","caller":"traceutil/trace.go:171","msg":"trace[1595862648] linearizableReadLoop","detail":"{readStateIndex:422; appliedIndex:421; }","duration":"200.246368ms","start":"2026-04-10T03:51:28.09627Z","end":"2026-04-10T03:51:28.296517Z","steps":["trace[1595862648] 'read index received' (duration: 194.224744ms)","trace[1595862648] 'applied index is now lower than readState.Index' (duration: 6.020404ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:28.29657Z","caller":"traceutil/trace.go:171","msg":"trace[518397621] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"301.134911ms","start":"2026-04-10T03:51:27.995402Z","end":"2026-04-10T03:51:28.296537Z","steps":["trace[518397621] 'process raft request' (duration: 295.196658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:28.296919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:27.995382Z","time spent":"301.458987ms","remote":"127.0.0.1:54560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T03:51:28.297023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.713177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4368"} {"level":"info","ts":"2026-04-10T03:51:28.297145Z","caller":"traceutil/trace.go:171","msg":"trace[2015679804] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:405; }","duration":"200.90328ms","start":"2026-04-10T03:51:28.096216Z","end":"2026-04-10T03:51:28.29712Z","steps":["trace[2015679804] 'agreement among raft nodes before linearized reading' (duration: 200.583904ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:30.065815Z","caller":"traceutil/trace.go:171","msg":"trace[1363337284] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"103.069893ms","start":"2026-04-10T03:51:29.962715Z","end":"2026-04-10T03:51:30.065785Z","steps":["trace[1363337284] 'process raft request' (duration: 102.901031ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:31.071647Z","caller":"traceutil/trace.go:171","msg":"trace[2115716336] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"196.028536ms","start":"2026-04-10T03:51:30.875584Z","end":"2026-04-10T03:51:31.071613Z","steps":["trace[2115716336] 'process raft request' (duration: 195.900144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:50.227358Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995350746861528191,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-10T03:51:50.511151Z","caller":"traceutil/trace.go:171","msg":"trace[23518253] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"898.691286ms","start":"2026-04-10T03:51:49.612428Z","end":"2026-04-10T03:51:50.511119Z","steps":["trace[23518253] 'process raft request' (duration: 819.800106ms)","trace[23518253] 'compare' (duration: 78.334425ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:50.511291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.61242Z","time spent":"898.812429ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:51:50.511294Z","caller":"traceutil/trace.go:171","msg":"trace[255443903] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"898.799768ms","start":"2026-04-10T03:51:49.61247Z","end":"2026-04-10T03:51:50.51127Z","steps":["trace[255443903] 'process raft request' (duration: 898.550291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:50.511387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.612467Z","time spent":"898.87353ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:51:50.511173Z","caller":"traceutil/trace.go:171","msg":"trace[2050359982] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"897.629357ms","start":"2026-04-10T03:51:49.613513Z","end":"2026-04-10T03:51:50.511143Z","steps":["trace[2050359982] 'process raft request' (duration: 897.573926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:50.511496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.613507Z","time spent":"897.935915ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:51:50.607346Z","caller":"traceutil/trace.go:171","msg":"trace[1228946831] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"988.664265ms","start":"2026-04-10T03:51:49.618648Z","end":"2026-04-10T03:51:50.607312Z","steps":["trace[1228946831] 'process raft request' (duration: 988.545752ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:50.607357Z","caller":"traceutil/trace.go:171","msg":"trace[2044168112] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"988.574363ms","start":"2026-04-10T03:51:49.618753Z","end":"2026-04-10T03:51:50.607327Z","steps":["trace[2044168112] 'process raft request' (duration: 988.499911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:50.607522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.618749Z","time spent":"988.677966ms","remote":"127.0.0.1:55014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T03:51:50.607554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.618641Z","time spent":"988.779198ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T03:51:50.607696Z","caller":"traceutil/trace.go:171","msg":"trace[2038369978] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"991.391332ms","start":"2026-04-10T03:51:49.616291Z","end":"2026-04-10T03:51:50.607682Z","steps":["trace[2038369978] 'process raft request' (duration: 990.758975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:50.607786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.616284Z","time spent":"991.476585ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:51:50.607951Z","caller":"traceutil/trace.go:171","msg":"trace[1935592405] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"985.225948ms","start":"2026-04-10T03:51:49.622703Z","end":"2026-04-10T03:51:50.607929Z","steps":["trace[1935592405] 'process raft request' (duration: 984.94073ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:50.607983Z","caller":"traceutil/trace.go:171","msg":"trace[1079597735] transaction","detail":"{read_only:false; number_of_response:1; response_revision:532; }","duration":"989.059157ms","start":"2026-04-10T03:51:49.618865Z","end":"2026-04-10T03:51:50.607924Z","steps":["trace[1079597735] 'process raft request' (duration: 988.424449ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:50.608182Z","caller":"traceutil/trace.go:171","msg":"trace[2125991078] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"982.288046ms","start":"2026-04-10T03:51:49.625884Z","end":"2026-04-10T03:51:50.608172Z","steps":["trace[2125991078] 'process raft request' (duration: 981.795182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:50.608355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.618861Z","time spent":"989.313844ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6936,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T03:51:50.608046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.6227Z","time spent":"985.30649ms","remote":"127.0.0.1:55014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T03:51:50.608558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.625878Z","time spent":"982.338317ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T03:51:50.608558Z","caller":"traceutil/trace.go:171","msg":"trace[842551429] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"973.707993ms","start":"2026-04-10T03:51:49.634809Z","end":"2026-04-10T03:51:50.608517Z","steps":["trace[842551429] 'process raft request' (duration: 972.962782ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:50.60809Z","caller":"traceutil/trace.go:171","msg":"trace[240728966] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"985.846776ms","start":"2026-04-10T03:51:49.622223Z","end":"2026-04-10T03:51:50.60807Z","steps":["trace[240728966] 'process raft request' (duration: 985.27779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:50.608679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.634795Z","time spent":"973.825587ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T03:51:50.608698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.62221Z","time spent":"986.463023ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:51:50.608089Z","caller":"traceutil/trace.go:171","msg":"trace[316067969] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"985.408134ms","start":"2026-04-10T03:51:49.622671Z","end":"2026-04-10T03:51:50.608079Z","steps":["trace[316067969] 'process raft request' (duration: 984.926971ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:50.608785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.622664Z","time spent":"986.104744ms","remote":"127.0.0.1:55014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:51:50.609529Z","caller":"traceutil/trace.go:171","msg":"trace[78294398] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"946.912908ms","start":"2026-04-10T03:51:49.662584Z","end":"2026-04-10T03:51:50.609497Z","steps":["trace[78294398] 'process raft request' (duration: 946.276061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:50.609656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.662547Z","time spent":"947.046212ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:51:50.61054Z","caller":"traceutil/trace.go:171","msg":"trace[1745515016] linearizableReadLoop","detail":"{readStateIndex:563; appliedIndex:549; }","duration":"883.276006ms","start":"2026-04-10T03:51:49.727244Z","end":"2026-04-10T03:51:50.61052Z","steps":["trace[1745515016] 'read index received' (duration: 704.966082ms)","trace[1745515016] 'applied index is now lower than readState.Index' (duration: 178.309054ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:50.610634Z","caller":"traceutil/trace.go:171","msg":"trace[1298127197] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"290.456355ms","start":"2026-04-10T03:51:50.320168Z","end":"2026-04-10T03:51:50.610624Z","steps":["trace[1298127197] 'process raft request' (duration: 290.29712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:50.610767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.525943ms","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-04-10T03:51:50.610805Z","caller":"traceutil/trace.go:171","msg":"trace[121745893] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:540; }","duration":"883.623516ms","start":"2026-04-10T03:51:49.727173Z","end":"2026-04-10T03:51:50.610796Z","steps":["trace[121745893] 'agreement among raft nodes before linearized reading' (duration: 883.550643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:50.610843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.727151Z","time spent":"883.685307ms","remote":"127.0.0.1:54756","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-04-10T03:51:50.610867Z","caller":"traceutil/trace.go:171","msg":"trace[2083452969] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"851.316486ms","start":"2026-04-10T03:51:49.759532Z","end":"2026-04-10T03:51:50.610849Z","steps":["trace[2083452969] 'process raft request' (duration: 850.809021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:50.610971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.75951Z","time spent":"851.413258ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T03:51:51.110913Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995350746861528215,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-10T03:51:51.450199Z","caller":"traceutil/trace.go:171","msg":"trace[784036327] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"924.620224ms","start":"2026-04-10T03:51:50.525556Z","end":"2026-04-10T03:51:51.450176Z","steps":["trace[784036327] 'process raft request' (duration: 924.568592ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:51.450373Z","caller":"traceutil/trace.go:171","msg":"trace[1726934051] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"926.208578ms","start":"2026-04-10T03:51:50.524145Z","end":"2026-04-10T03:51:51.450354Z","steps":["trace[1726934051] 'process raft request' (duration: 925.864278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:51.451424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:50.524115Z","time spent":"927.224326ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T03:51:51.450411Z","caller":"traceutil/trace.go:171","msg":"trace[2065250750] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"931.329821ms","start":"2026-04-10T03:51:50.519059Z","end":"2026-04-10T03:51:51.450389Z","steps":["trace[2065250750] 'process raft request' (duration: 930.897659ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:51.450945Z","caller":"traceutil/trace.go:171","msg":"trace[1826550516] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"931.766833ms","start":"2026-04-10T03:51:50.518943Z","end":"2026-04-10T03:51:51.45071Z","steps":["trace[1826550516] 'process raft request' (duration: 923.630006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:51.452217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:50.518913Z","time spent":"933.257175ms","remote":"127.0.0.1:55014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T03:51:51.45232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:50.519048Z","time spent":"933.167022ms","remote":"127.0.0.1:55014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T03:51:51.452718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:50.525537Z","time spent":"924.725346ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T03:51:51.457356Z","caller":"traceutil/trace.go:171","msg":"trace[886294917] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"841.145615ms","start":"2026-04-10T03:51:50.616174Z","end":"2026-04-10T03:51:51.45732Z","steps":["trace[886294917] 'process raft request' (duration: 839.825339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:51.45757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:50.616146Z","time spent":"841.319409ms","remote":"127.0.0.1:54756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T03:51:51.458326Z","caller":"traceutil/trace.go:171","msg":"trace[659021360] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"825.601358ms","start":"2026-04-10T03:51:50.632704Z","end":"2026-04-10T03:51:51.458305Z","steps":["trace[659021360] 'process raft request' (duration: 823.966673ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:51.458318Z","caller":"traceutil/trace.go:171","msg":"trace[371099278] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"835.947178ms","start":"2026-04-10T03:51:50.622332Z","end":"2026-04-10T03:51:51.458279Z","steps":["trace[371099278] 'process raft request' (duration: 834.256731ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:51.458361Z","caller":"traceutil/trace.go:171","msg":"trace[1802837455] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"836.055121ms","start":"2026-04-10T03:51:50.622284Z","end":"2026-04-10T03:51:51.458339Z","steps":["trace[1802837455] 'process raft request' (duration: 833.936003ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:51.460862Z","caller":"traceutil/trace.go:171","msg":"trace[1945510167] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:564; }","duration":"850.241808ms","start":"2026-04-10T03:51:50.610589Z","end":"2026-04-10T03:51:51.460831Z","steps":["trace[1945510167] 'read index received' (duration: 832.02097ms)","trace[1945510167] 'applied index is now lower than readState.Index' (duration: 18.220178ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:51.460969Z","caller":"traceutil/trace.go:171","msg":"trace[187769779] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"790.565267ms","start":"2026-04-10T03:51:50.670396Z","end":"2026-04-10T03:51:51.460961Z","steps":["trace[187769779] 'process raft request' (duration: 790.355641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:51.461099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:50.670376Z","time spent":"790.652129ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T03:51:51.461146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.635719428s","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-04-10T03:51:51.461199Z","caller":"traceutil/trace.go:171","msg":"trace[1478379670] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:550; }","duration":"1.635783171s","start":"2026-04-10T03:51:49.825384Z","end":"2026-04-10T03:51:51.461167Z","steps":["trace[1478379670] 'agreement among raft nodes before linearized reading' (duration: 1.635641846s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:51.461227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.825358Z","time spent":"1.635863413s","remote":"127.0.0.1:54756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-10T03:51:51.461246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.733276187s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T03:51:51.461273Z","caller":"traceutil/trace.go:171","msg":"trace[194411242] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"1.733324028s","start":"2026-04-10T03:51:49.727941Z","end":"2026-04-10T03:51:51.461265Z","steps":["trace[194411242] 'agreement among raft nodes before linearized reading' (duration: 1.733277496s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:51.461299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.72793Z","time spent":"1.73336426s","remote":"127.0.0.1:54484","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-04-10T03:51:51.460976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:50.622274Z","time spent":"838.591603ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T03:51:51.461551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.629911885s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-10T03:51:51.459293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:50.622329Z","time spent":"836.058862ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T03:51:51.461574Z","caller":"traceutil/trace.go:171","msg":"trace[417449987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:550; }","duration":"1.629980327s","start":"2026-04-10T03:51:49.831587Z","end":"2026-04-10T03:51:51.461568Z","steps":["trace[417449987] 'agreement among raft nodes before linearized reading' (duration: 1.629895775s)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:51.460271Z","caller":"traceutil/trace.go:171","msg":"trace[2008243430] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"808.799928ms","start":"2026-04-10T03:51:50.651458Z","end":"2026-04-10T03:51:51.460258Z","steps":["trace[2008243430] 'process raft request' (duration: 807.159302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:51.461677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:49.831564Z","time spent":"1.630075489s","remote":"127.0.0.1:54756","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-04-10T03:51:51.461695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:50.651421Z","time spent":"810.246898ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T03:51:51.458409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:50.632684Z","time spent":"825.689272ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T03:51:51.461465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"929.256991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T03:51:51.461964Z","caller":"traceutil/trace.go:171","msg":"trace[1733642102] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"929.771985ms","start":"2026-04-10T03:51:50.532181Z","end":"2026-04-10T03:51:51.461953Z","steps":["trace[1733642102] 'agreement among raft nodes before linearized reading' (duration: 929.254561ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:51.462024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:50.532172Z","time spent":"929.845368ms","remote":"127.0.0.1:54478","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-04-10T03:51:51.468671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.425663ms","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-04-10T03:51:51.468705Z","caller":"traceutil/trace.go:171","msg":"trace[8866022] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:550; }","duration":"120.495535ms","start":"2026-04-10T03:51:51.348202Z","end":"2026-04-10T03:51:51.468697Z","steps":["trace[8866022] 'agreement among raft nodes before linearized reading' (duration: 120.421723ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:52.519943Z","caller":"traceutil/trace.go:171","msg":"trace[454019241] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"144.165921ms","start":"2026-04-10T03:51:52.375685Z","end":"2026-04-10T03:51:52.519851Z","steps":["trace[454019241] 'process raft request' (duration: 143.945025ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:52.913882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.82321ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T03:51:52.914062Z","caller":"traceutil/trace.go:171","msg":"trace[283487562] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"538.133127ms","start":"2026-04-10T03:51:52.375893Z","end":"2026-04-10T03:51:52.914026Z","steps":["trace[283487562] 'process raft request' (duration: 432.06666ms)","trace[283487562] 'compare' (duration: 104.781351ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:52.914134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:52.375863Z","time spent":"538.23412ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15664,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T03:51:52.939472Z","caller":"traceutil/trace.go:171","msg":"trace[698755648] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:624; }","duration":"384.258227ms","start":"2026-04-10T03:51:52.555158Z","end":"2026-04-10T03:51:52.939417Z","steps":["trace[698755648] 'read index received' (duration: 252.89025ms)","trace[698755648] 'applied index is now lower than readState.Index' (duration: 131.367247ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:52.939508Z","caller":"traceutil/trace.go:171","msg":"trace[2042239520] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"401.758011ms","start":"2026-04-10T03:51:52.537715Z","end":"2026-04-10T03:51:52.939473Z","steps":["trace[2042239520] 'process raft request' (duration: 401.444313ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:52.939641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.467863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-04-10T03:51:52.939675Z","caller":"traceutil/trace.go:171","msg":"trace[931685486] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:600; }","duration":"384.542074ms","start":"2026-04-10T03:51:52.555121Z","end":"2026-04-10T03:51:52.939664Z","steps":["trace[931685486] 'agreement among raft nodes before linearized reading' (duration: 384.401291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:52.939704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:52.555109Z","time spent":"384.589287ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":29592,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-04-10T03:51:52.93977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:52.537686Z","time spent":"401.897495ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T03:51:55.482311Z","caller":"traceutil/trace.go:171","msg":"trace[430093589] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"216.376267ms","start":"2026-04-10T03:51:55.265908Z","end":"2026-04-10T03:51:55.482284Z","steps":["trace[430093589] 'process raft request' (duration: 214.929917ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:56.101598Z","caller":"traceutil/trace.go:171","msg":"trace[1867133061] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"132.228373ms","start":"2026-04-10T03:51:55.969344Z","end":"2026-04-10T03:51:56.101573Z","steps":["trace[1867133061] 'process raft request' (duration: 130.694012ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:58.170717Z","caller":"traceutil/trace.go:171","msg":"trace[1121485837] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"346.315984ms","start":"2026-04-10T03:51:57.82433Z","end":"2026-04-10T03:51:58.170646Z","steps":["trace[1121485837] 'read index received' (duration: 344.27216ms)","trace[1121485837] 'applied index is now lower than readState.Index' (duration: 2.042264ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:58.174739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.952512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.43\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-10T03:51:58.174773Z","caller":"traceutil/trace.go:171","msg":"trace[85852629] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"450.367154ms","start":"2026-04-10T03:51:57.723888Z","end":"2026-04-10T03:51:58.174255Z","steps":["trace[85852629] 'process raft request' (duration: 445.386601ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:58.174834Z","caller":"traceutil/trace.go:171","msg":"trace[1501142832] range","detail":"{range_begin:/registry/masterleases/162.253.55.43; range_end:; response_count:1; response_revision:631; }","duration":"350.531417ms","start":"2026-04-10T03:51:57.824273Z","end":"2026-04-10T03:51:58.174804Z","steps":["trace[1501142832] 'agreement among raft nodes before linearized reading' (duration: 349.8751ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:58.174893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:57.824244Z","time spent":"350.636191ms","remote":"127.0.0.1:54504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/162.253.55.43\" "} {"level":"warn","ts":"2026-04-10T03:51:58.174955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:57.723862Z","time spent":"451.006222ms","remote":"127.0.0.1:54570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T03:51:58.174963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.425054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nwshn\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-10T03:51:58.175047Z","caller":"traceutil/trace.go:171","msg":"trace[1515089426] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nwshn; range_end:; response_count:1; response_revision:631; }","duration":"237.558677ms","start":"2026-04-10T03:51:57.93747Z","end":"2026-04-10T03:51:58.175029Z","steps":["trace[1515089426] 'agreement among raft nodes before linearized reading' (duration: 236.710134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:59.27909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.154259ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T03:51:59.27933Z","caller":"traceutil/trace.go:171","msg":"trace[1632944771] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:659; }","duration":"745.313136ms","start":"2026-04-10T03:51:58.533999Z","end":"2026-04-10T03:51:59.279312Z","steps":["trace[1632944771] 'read index received' (duration: 40.291µs)","trace[1632944771] 'applied index is now lower than readState.Index' (duration: 745.271825ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:51:59.279401Z","caller":"traceutil/trace.go:171","msg":"trace[305806645] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"1.053197926s","start":"2026-04-10T03:51:58.226178Z","end":"2026-04-10T03:51:59.279375Z","steps":["trace[305806645] 'process raft request' (duration: 1.053092783s)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:51:59.279333Z","caller":"traceutil/trace.go:171","msg":"trace[1944310705] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"1.090022032s","start":"2026-04-10T03:51:58.189274Z","end":"2026-04-10T03:51:59.279296Z","steps":["trace[1944310705] 'process raft request' (duration: 198.247346ms)","trace[1944310705] 'compare' (duration: 891.002086ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:51:59.279473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.47297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T03:51:59.279504Z","caller":"traceutil/trace.go:171","msg":"trace[2090046611] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"745.542532ms","start":"2026-04-10T03:51:58.533952Z","end":"2026-04-10T03:51:59.279494Z","steps":["trace[2090046611] 'agreement among raft nodes before linearized reading' (duration: 745.421749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:59.279545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:58.53393Z","time spent":"745.606164ms","remote":"127.0.0.1:54478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-10T03:51:59.279612Z","caller":"traceutil/trace.go:171","msg":"trace[1438370874] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"1.069654937s","start":"2026-04-10T03:51:58.209943Z","end":"2026-04-10T03:51:59.279598Z","steps":["trace[1438370874] 'process raft request' (duration: 1.069257916s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:51:59.279594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:58.189253Z","time spent":"1.090232687s","remote":"127.0.0.1:54664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T03:51:59.279537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:58.226159Z","time spent":"1.053304218s","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T03:51:59.279689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:58.209931Z","time spent":"1.069715768s","remote":"127.0.0.1:54504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T03:52:01.560178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.994820254s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-10T03:52:01.560739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.024493733s","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-04-10T03:52:01.560774Z","caller":"traceutil/trace.go:171","msg":"trace[473795703] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:634; }","duration":"1.995441329s","start":"2026-04-10T03:51:59.565306Z","end":"2026-04-10T03:52:01.560747Z","steps":["trace[473795703] 'range keys from in-memory index tree' (duration: 1.994725381s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:01.56033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.005888099s","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-04-10T03:52:01.560846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:59.565292Z","time spent":"1.995537204s","remote":"127.0.0.1:54756","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-04-10T03:52:01.560879Z","caller":"traceutil/trace.go:171","msg":"trace[297046370] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:634; }","duration":"2.006505404s","start":"2026-04-10T03:51:59.55436Z","end":"2026-04-10T03:52:01.560865Z","steps":["trace[297046370] 'range keys from in-memory index tree' (duration: 2.005776725s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:01.560925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:59.554348Z","time spent":"2.006562076s","remote":"127.0.0.1:54756","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-04-10T03:52:01.560428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.026060626s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T03:52:01.56104Z","caller":"traceutil/trace.go:171","msg":"trace[181161086] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"2.026691062s","start":"2026-04-10T03:51:59.534337Z","end":"2026-04-10T03:52:01.561028Z","steps":["trace[181161086] 'range keys from in-memory index tree' (duration: 2.026009853s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:01.561081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:59.534314Z","time spent":"2.026754343s","remote":"127.0.0.1:54484","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-04-10T03:52:01.560657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.995787409s","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-04-10T03:52:01.561216Z","caller":"traceutil/trace.go:171","msg":"trace[99855341] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:634; }","duration":"1.996359845s","start":"2026-04-10T03:51:59.564843Z","end":"2026-04-10T03:52:01.561203Z","steps":["trace[99855341] 'range keys from in-memory index tree' (duration: 1.995645675s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:01.561262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:59.564837Z","time spent":"1.996411787s","remote":"127.0.0.1:54756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-10T03:52:01.560825Z","caller":"traceutil/trace.go:171","msg":"trace[575780217] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:634; }","duration":"2.025161341s","start":"2026-04-10T03:51:59.535642Z","end":"2026-04-10T03:52:01.560804Z","steps":["trace[575780217] 'range keys from in-memory index tree' (duration: 2.024338069s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:01.561798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:59.535622Z","time spent":"2.026130667s","remote":"127.0.0.1:54756","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-04-10T03:52:01.563759Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.883555131s","expected-duration":"1s"} {"level":"info","ts":"2026-04-10T03:52:01.565094Z","caller":"traceutil/trace.go:171","msg":"trace[1256152860] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"1.886787306s","start":"2026-04-10T03:51:59.678284Z","end":"2026-04-10T03:52:01.565072Z","steps":["trace[1256152860] 'process raft request' (duration: 1.886001695s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:01.565215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:51:59.678255Z","time spent":"1.88688486s","remote":"127.0.0.1:54570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T03:52:01.58592Z","caller":"traceutil/trace.go:171","msg":"trace[682900901] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"914.679802ms","start":"2026-04-10T03:52:00.67122Z","end":"2026-04-10T03:52:01.5859Z","steps":["trace[682900901] 'process raft request' (duration: 914.381144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:01.586238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:52:00.671193Z","time spent":"914.778946ms","remote":"127.0.0.1:54756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T03:52:02.070316Z","caller":"traceutil/trace.go:171","msg":"trace[1813746158] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"101.127104ms","start":"2026-04-10T03:52:01.969162Z","end":"2026-04-10T03:52:02.070289Z","steps":["trace[1813746158] 'process raft request' (duration: 100.832626ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:52:03.489895Z","caller":"traceutil/trace.go:171","msg":"trace[1719807539] transaction","detail":"{read_only:false; number_of_response:0; response_revision:672; }","duration":"446.787152ms","start":"2026-04-10T03:52:03.043081Z","end":"2026-04-10T03:52:03.489868Z","steps":["trace[1719807539] 'process raft request' (duration: 446.69563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:03.490049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:52:03.043068Z","time spent":"446.915066ms","remote":"127.0.0.1:55014","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:52:03.504244Z","caller":"traceutil/trace.go:171","msg":"trace[1107457691] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"436.70027ms","start":"2026-04-10T03:52:03.067523Z","end":"2026-04-10T03:52:03.504223Z","steps":["trace[1107457691] 'process raft request' (duration: 436.346411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:03.504386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:52:03.067496Z","time spent":"436.811402ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5562,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T03:52:03.504521Z","caller":"traceutil/trace.go:171","msg":"trace[435240815] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"435.314314ms","start":"2026-04-10T03:52:03.069199Z","end":"2026-04-10T03:52:03.504514Z","steps":["trace[435240815] 'process raft request' (duration: 434.985485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:03.504565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:52:03.069188Z","time spent":"435.354514ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4165,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T03:52:03.509894Z","caller":"traceutil/trace.go:171","msg":"trace[167787678] linearizableReadLoop","detail":"{readStateIndex:704; appliedIndex:701; }","duration":"292.498012ms","start":"2026-04-10T03:52:03.217384Z","end":"2026-04-10T03:52:03.509882Z","steps":["trace[167787678] 'read index received' (duration: 272.48674ms)","trace[167787678] 'applied index is now lower than readState.Index' (duration: 20.010442ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:52:03.510061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.672475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T03:52:03.510093Z","caller":"traceutil/trace.go:171","msg":"trace[689050955] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:675; }","duration":"292.746328ms","start":"2026-04-10T03:52:03.217336Z","end":"2026-04-10T03:52:03.510083Z","steps":["trace[689050955] 'agreement among raft nodes before linearized reading' (duration: 292.609185ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:52:05.266809Z","caller":"traceutil/trace.go:171","msg":"trace[1041878992] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"117.396548ms","start":"2026-04-10T03:52:05.149365Z","end":"2026-04-10T03:52:05.266762Z","steps":["trace[1041878992] 'process raft request' (duration: 65.563691ms)","trace[1041878992] 'compare' (duration: 51.618902ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:52:06.188849Z","caller":"traceutil/trace.go:171","msg":"trace[1229234703] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"168.854503ms","start":"2026-04-10T03:52:06.019971Z","end":"2026-04-10T03:52:06.188825Z","steps":["trace[1229234703] 'process raft request' (duration: 166.961505ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:52:06.508521Z","caller":"traceutil/trace.go:171","msg":"trace[1943272613] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"122.00923ms","start":"2026-04-10T03:52:06.386465Z","end":"2026-04-10T03:52:06.508474Z","steps":["trace[1943272613] 'process raft request' (duration: 47.090918ms)","trace[1943272613] 'compare' (duration: 74.585383ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:52:07.037562Z","caller":"traceutil/trace.go:171","msg":"trace[1204777441] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"515.27796ms","start":"2026-04-10T03:52:06.522247Z","end":"2026-04-10T03:52:07.037524Z","steps":["trace[1204777441] 'process raft request' (duration: 417.446324ms)","trace[1204777441] 'compare' (duration: 97.536368ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:52:07.037714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:52:06.522212Z","time spent":"515.439063ms","remote":"127.0.0.1:54560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:52:07.053654Z","caller":"traceutil/trace.go:171","msg":"trace[706299396] linearizableReadLoop","detail":"{readStateIndex:752; appliedIndex:749; }","duration":"236.179254ms","start":"2026-04-10T03:52:06.817444Z","end":"2026-04-10T03:52:07.053623Z","steps":["trace[706299396] 'read index received' (duration: 122.34798ms)","trace[706299396] 'applied index is now lower than readState.Index' (duration: 113.829944ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:52:07.053706Z","caller":"traceutil/trace.go:171","msg":"trace[1085446444] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"407.458109ms","start":"2026-04-10T03:52:06.646225Z","end":"2026-04-10T03:52:07.053683Z","steps":["trace[1085446444] 'process raft request' (duration: 407.305156ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:07.053797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:52:06.646189Z","time spent":"407.571384ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T03:52:07.053717Z","caller":"traceutil/trace.go:171","msg":"trace[241257740] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"455.281308ms","start":"2026-04-10T03:52:06.598374Z","end":"2026-04-10T03:52:07.053655Z","steps":["trace[241257740] 'process raft request' (duration: 454.775185ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:07.054078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.621126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-04-10T03:52:07.054248Z","caller":"traceutil/trace.go:171","msg":"trace[227853919] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:722; }","duration":"236.81138ms","start":"2026-04-10T03:52:06.817374Z","end":"2026-04-10T03:52:07.054185Z","steps":["trace[227853919] 'agreement among raft nodes before linearized reading' (duration: 236.40059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:07.054425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:52:06.598332Z","time spent":"455.751889ms","remote":"127.0.0.1:54524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188480,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T03:52:08.188539Z","caller":"traceutil/trace.go:171","msg":"trace[2113444721] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"162.95214ms","start":"2026-04-10T03:52:08.025555Z","end":"2026-04-10T03:52:08.188507Z","steps":["trace[2113444721] 'process raft request' (duration: 131.283515ms)","trace[2113444721] 'compare' (duration: 31.308026ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:52:08.305421Z","caller":"traceutil/trace.go:171","msg":"trace[1197842484] linearizableReadLoop","detail":"{readStateIndex:765; appliedIndex:764; }","duration":"103.965422ms","start":"2026-04-10T03:52:08.20143Z","end":"2026-04-10T03:52:08.305396Z","steps":["trace[1197842484] 'read index received' (duration: 103.677395ms)","trace[1197842484] 'applied index is now lower than readState.Index' (duration: 286.907µs)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:52:08.30566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.199308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T03:52:08.305747Z","caller":"traceutil/trace.go:171","msg":"trace[2008735565] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:734; }","duration":"104.335611ms","start":"2026-04-10T03:52:08.201391Z","end":"2026-04-10T03:52:08.305727Z","steps":["trace[2008735565] 'agreement among raft nodes before linearized reading' (duration: 104.157976ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:08.305778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.166036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T03:52:08.305871Z","caller":"traceutil/trace.go:171","msg":"trace[1611903350] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:734; }","duration":"104.236218ms","start":"2026-04-10T03:52:08.201579Z","end":"2026-04-10T03:52:08.305815Z","steps":["trace[1611903350] 'agreement among raft nodes before linearized reading' (duration: 104.148396ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:52:08.306119Z","caller":"traceutil/trace.go:171","msg":"trace[1507135301] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"111.094302ms","start":"2026-04-10T03:52:08.194984Z","end":"2026-04-10T03:52:08.306079Z","steps":["trace[1507135301] 'process raft request' (duration: 110.17786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:08.306559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.551816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T03:52:08.306631Z","caller":"traceutil/trace.go:171","msg":"trace[2034459742] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:734; }","duration":"104.68422ms","start":"2026-04-10T03:52:08.20193Z","end":"2026-04-10T03:52:08.306614Z","steps":["trace[2034459742] 'agreement among raft nodes before linearized reading' (duration: 104.505415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:19.66569Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995350746861528787,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-10T03:52:19.674016Z","caller":"traceutil/trace.go:171","msg":"trace[730816052] linearizableReadLoop","detail":"{readStateIndex:845; appliedIndex:844; }","duration":"508.629991ms","start":"2026-04-10T03:52:19.165362Z","end":"2026-04-10T03:52:19.673992Z","steps":["trace[730816052] 'read index received' (duration: 508.405796ms)","trace[730816052] 'applied index is now lower than readState.Index' (duration: 222.845µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:52:19.674138Z","caller":"traceutil/trace.go:171","msg":"trace[1649301046] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"592.774182ms","start":"2026-04-10T03:52:19.081354Z","end":"2026-04-10T03:52:19.674128Z","steps":["trace[1649301046] 'process raft request' (duration: 592.435474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:19.674246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:52:19.081321Z","time spent":"592.846325ms","remote":"127.0.0.1:54718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T03:52:19.674483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.761707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-10T03:52:19.674537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.132014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-10T03:52:19.674608Z","caller":"traceutil/trace.go:171","msg":"trace[1385908128] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:810; }","duration":"509.284497ms","start":"2026-04-10T03:52:19.165302Z","end":"2026-04-10T03:52:19.674587Z","steps":["trace[1385908128] 'agreement among raft nodes before linearized reading' (duration: 508.918268ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:52:19.674609Z","caller":"traceutil/trace.go:171","msg":"trace[179394901] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:810; }","duration":"101.988222ms","start":"2026-04-10T03:52:19.572589Z","end":"2026-04-10T03:52:19.674577Z","steps":["trace[179394901] 'agreement among raft nodes before linearized reading' (duration: 101.658224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:19.674661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:52:19.16528Z","time spent":"509.368849ms","remote":"127.0.0.1:54756","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-04-10T03:52:19.674793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.673305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T03:52:19.674954Z","caller":"traceutil/trace.go:171","msg":"trace[899628312] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:810; }","duration":"106.883921ms","start":"2026-04-10T03:52:19.568038Z","end":"2026-04-10T03:52:19.674922Z","steps":["trace[899628312] 'agreement among raft nodes before linearized reading' (duration: 106.188614ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:52:54.051946Z","caller":"traceutil/trace.go:171","msg":"trace[1197331790] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"130.198511ms","start":"2026-04-10T03:52:53.921716Z","end":"2026-04-10T03:52:54.051914Z","steps":["trace[1197331790] 'process raft request' (duration: 119.149055ms)","trace[1197331790] 'compare' (duration: 10.916263ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:52:54.076835Z","caller":"traceutil/trace.go:171","msg":"trace[882303669] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"153.779723ms","start":"2026-04-10T03:52:53.923027Z","end":"2026-04-10T03:52:54.076807Z","steps":["trace[882303669] 'process raft request' (duration: 153.722641ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:52:54.076947Z","caller":"traceutil/trace.go:171","msg":"trace[981412572] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"154.721003ms","start":"2026-04-10T03:52:53.922191Z","end":"2026-04-10T03:52:54.076912Z","steps":["trace[981412572] 'process raft request' (duration: 154.313315ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:52:54.077042Z","caller":"traceutil/trace.go:171","msg":"trace[1673229502] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"154.735014ms","start":"2026-04-10T03:52:53.922282Z","end":"2026-04-10T03:52:54.077017Z","steps":["trace[1673229502] 'process raft request' (duration: 154.416677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:54.556407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.904392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T03:52:54.556507Z","caller":"traceutil/trace.go:171","msg":"trace[518678176] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1060; }","duration":"321.058614ms","start":"2026-04-10T03:52:54.235413Z","end":"2026-04-10T03:52:54.556472Z","steps":["trace[518678176] 'count revisions from in-memory index tree' (duration: 320.81707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:52:54.556537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:52:54.235389Z","time spent":"321.141436ms","remote":"127.0.0.1:54608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"info","ts":"2026-04-10T03:53:15.868477Z","caller":"traceutil/trace.go:171","msg":"trace[1198018825] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"194.2444ms","start":"2026-04-10T03:53:15.674201Z","end":"2026-04-10T03:53:15.868445Z","steps":["trace[1198018825] 'process raft request' (duration: 194.074617ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:53:48.594554Z","caller":"traceutil/trace.go:171","msg":"trace[424146855] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"188.545445ms","start":"2026-04-10T03:53:48.405987Z","end":"2026-04-10T03:53:48.594532Z","steps":["trace[424146855] 'process raft request' (duration: 179.9443ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:53:48.594615Z","caller":"traceutil/trace.go:171","msg":"trace[622321583] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"187.974033ms","start":"2026-04-10T03:53:48.406586Z","end":"2026-04-10T03:53:48.59456Z","steps":["trace[622321583] 'process raft request' (duration: 187.585735ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:53:59.593026Z","caller":"traceutil/trace.go:171","msg":"trace[1200202530] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"174.904958ms","start":"2026-04-10T03:53:59.418093Z","end":"2026-04-10T03:53:59.592998Z","steps":["trace[1200202530] 'process raft request' (duration: 174.727874ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:54:00.454665Z","caller":"traceutil/trace.go:171","msg":"trace[257963160] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"161.452971ms","start":"2026-04-10T03:54:00.293188Z","end":"2026-04-10T03:54:00.454641Z","steps":["trace[257963160] 'process raft request' (duration: 161.289027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:54:00.629316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.245438ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T03:54:00.62946Z","caller":"traceutil/trace.go:171","msg":"trace[335366030] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"157.760032ms","start":"2026-04-10T03:54:00.471665Z","end":"2026-04-10T03:54:00.629425Z","steps":["trace[335366030] 'process raft request' (duration: 31.31113ms)","trace[335366030] 'compare' (duration: 126.031924ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:54:00.629539Z","caller":"traceutil/trace.go:171","msg":"trace[431212904] linearizableReadLoop","detail":"{readStateIndex:1358; appliedIndex:1357; }","duration":"135.650215ms","start":"2026-04-10T03:54:00.493858Z","end":"2026-04-10T03:54:00.629508Z","steps":["trace[431212904] 'read index received' (duration: 9.070451ms)","trace[431212904] 'applied index is now lower than readState.Index' (duration: 126.576133ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:54:00.629774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.88149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T03:54:00.629825Z","caller":"traceutil/trace.go:171","msg":"trace[2080089114] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1301; }","duration":"135.9783ms","start":"2026-04-10T03:54:00.49383Z","end":"2026-04-10T03:54:00.629809Z","steps":["trace[2080089114] 'agreement among raft nodes before linearized reading' (duration: 135.847478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:54:00.630151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.515583ms","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-04-10T03:54:00.630239Z","caller":"traceutil/trace.go:171","msg":"trace[1000200753] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1301; }","duration":"125.667127ms","start":"2026-04-10T03:54:00.504548Z","end":"2026-04-10T03:54:00.630215Z","steps":["trace[1000200753] 'agreement among raft nodes before linearized reading' (duration: 125.227559ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:54:00.915046Z","caller":"traceutil/trace.go:171","msg":"trace[1767322438] linearizableReadLoop","detail":"{readStateIndex:1362; appliedIndex:1359; }","duration":"256.750716ms","start":"2026-04-10T03:54:00.658272Z","end":"2026-04-10T03:54:00.915022Z","steps":["trace[1767322438] 'read index received' (duration: 14.595334ms)","trace[1767322438] 'applied index is now lower than readState.Index' (duration: 242.154482ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:54:00.915168Z","caller":"traceutil/trace.go:171","msg":"trace[646676212] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"276.321535ms","start":"2026-04-10T03:54:00.638836Z","end":"2026-04-10T03:54:00.915157Z","steps":["trace[646676212] 'process raft request' (duration: 276.108531ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:54:00.915235Z","caller":"traceutil/trace.go:171","msg":"trace[2082571510] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"280.39164ms","start":"2026-04-10T03:54:00.63482Z","end":"2026-04-10T03:54:00.915212Z","steps":["trace[2082571510] 'process raft request' (duration: 268.941685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:54:00.915742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.426408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-10T03:54:00.915768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.507989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-04-10T03:54:00.9158Z","caller":"traceutil/trace.go:171","msg":"trace[899368171] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1304; }","duration":"257.534951ms","start":"2026-04-10T03:54:00.658247Z","end":"2026-04-10T03:54:00.915782Z","steps":["trace[899368171] 'agreement among raft nodes before linearized reading' (duration: 257.313287ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:54:00.915817Z","caller":"traceutil/trace.go:171","msg":"trace[835607895] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1304; }","duration":"232.586671ms","start":"2026-04-10T03:54:00.683218Z","end":"2026-04-10T03:54:00.915804Z","steps":["trace[835607895] 'agreement among raft nodes before linearized reading' (duration: 232.386197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:54:00.916194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.792475ms","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-04-10T03:54:00.916301Z","caller":"traceutil/trace.go:171","msg":"trace[1929935501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1304; }","duration":"257.920488ms","start":"2026-04-10T03:54:00.658367Z","end":"2026-04-10T03:54:00.916287Z","steps":["trace[1929935501] 'agreement among raft nodes before linearized reading' (duration: 257.105333ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:54:01.118427Z","caller":"traceutil/trace.go:171","msg":"trace[30800358] linearizableReadLoop","detail":"{readStateIndex:1364; appliedIndex:1363; }","duration":"130.855902ms","start":"2026-04-10T03:54:00.987541Z","end":"2026-04-10T03:54:01.118397Z","steps":["trace[30800358] 'read index received' (duration: 76.797125ms)","trace[30800358] 'applied index is now lower than readState.Index' (duration: 54.057407ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T03:54:01.11859Z","caller":"traceutil/trace.go:171","msg":"trace[301704696] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"196.144872ms","start":"2026-04-10T03:54:00.922426Z","end":"2026-04-10T03:54:01.118571Z","steps":["trace[301704696] 'process raft request' (duration: 142.008054ms)","trace[301704696] 'compare' (duration: 53.807842ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T03:54:01.119018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.451553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-04-10T03:54:01.119149Z","caller":"traceutil/trace.go:171","msg":"trace[1379806674] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1306; }","duration":"131.633186ms","start":"2026-04-10T03:54:00.987496Z","end":"2026-04-10T03:54:01.119129Z","steps":["trace[1379806674] 'agreement among raft nodes before linearized reading' (duration: 131.34281ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:54:03.559176Z","caller":"traceutil/trace.go:171","msg":"trace[382295186] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"431.646072ms","start":"2026-04-10T03:54:03.127504Z","end":"2026-04-10T03:54:03.55915Z","steps":["trace[382295186] 'process raft request' (duration: 431.5046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:54:03.559377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:54:03.127485Z","time spent":"431.763034ms","remote":"127.0.0.1:54756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T03:54:11.780707Z","caller":"traceutil/trace.go:171","msg":"trace[1262343679] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"174.955848ms","start":"2026-04-10T03:54:11.605727Z","end":"2026-04-10T03:54:11.780683Z","steps":["trace[1262343679] 'process raft request' (duration: 174.828634ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:54:12.309245Z","caller":"traceutil/trace.go:171","msg":"trace[1713737757] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"178.057962ms","start":"2026-04-10T03:54:12.131166Z","end":"2026-04-10T03:54:12.309224Z","steps":["trace[1713737757] 'process raft request' (duration: 177.917239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:54:12.984594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.802185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T03:54:12.984644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.300741ms","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-04-10T03:54:12.984707Z","caller":"traceutil/trace.go:171","msg":"trace[83057515] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1349; }","duration":"450.942708ms","start":"2026-04-10T03:54:12.533751Z","end":"2026-04-10T03:54:12.984694Z","steps":["trace[83057515] 'range keys from in-memory index tree' (duration: 450.757334ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:54:12.984754Z","caller":"traceutil/trace.go:171","msg":"trace[1286098558] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1349; }","duration":"297.463073ms","start":"2026-04-10T03:54:12.687269Z","end":"2026-04-10T03:54:12.984732Z","steps":["trace[1286098558] 'range keys from in-memory index tree' (duration: 297.099017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:54:12.984774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:54:12.533744Z","time spent":"451.020879ms","remote":"127.0.0.1:54484","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-04-10T03:54:12.984796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.376147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-10T03:54:12.984829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.474038ms","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-04-10T03:54:12.984854Z","caller":"traceutil/trace.go:171","msg":"trace[176908300] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1349; }","duration":"257.47199ms","start":"2026-04-10T03:54:12.727369Z","end":"2026-04-10T03:54:12.984841Z","steps":["trace[176908300] 'range keys from in-memory index tree' (duration: 257.234176ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:54:12.9849Z","caller":"traceutil/trace.go:171","msg":"trace[1353281446] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1349; }","duration":"451.565819ms","start":"2026-04-10T03:54:12.533304Z","end":"2026-04-10T03:54:12.98487Z","steps":["trace[1353281446] 'range keys from in-memory index tree' (duration: 451.328135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:54:12.98494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:54:12.533284Z","time spent":"451.646761ms","remote":"127.0.0.1:54756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-10T03:54:12.984995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.533091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T03:54:12.985034Z","caller":"traceutil/trace.go:171","msg":"trace[1658367472] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1349; }","duration":"392.610883ms","start":"2026-04-10T03:54:12.592409Z","end":"2026-04-10T03:54:12.98502Z","steps":["trace[1658367472] 'count revisions from in-memory index tree' (duration: 392.45041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:54:12.985071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T03:54:12.592386Z","time spent":"392.675804ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":54,"response size":29,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-04-10T03:54:26.592707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.127925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:endpoint-controller\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-04-10T03:54:26.592814Z","caller":"traceutil/trace.go:171","msg":"trace[1004391607] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:endpoint-controller; range_end:; response_count:1; response_revision:1401; }","duration":"122.280778ms","start":"2026-04-10T03:54:26.470514Z","end":"2026-04-10T03:54:26.592795Z","steps":["trace[1004391607] 'range keys from in-memory index tree' (duration: 121.92502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T03:54:26.593146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.759091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:node\" ","response":"range_response_count:1 size:1486"} {"level":"info","ts":"2026-04-10T03:54:26.593226Z","caller":"traceutil/trace.go:171","msg":"trace[184211043] range","detail":"{range_begin:/registry/clusterroles/system:node; range_end:; response_count:1; response_revision:1401; }","duration":"113.875463ms","start":"2026-04-10T03:54:26.479332Z","end":"2026-04-10T03:54:26.593207Z","steps":["trace[184211043] 'range keys from in-memory index tree' (duration: 113.249311ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:54:29.42185Z","caller":"traceutil/trace.go:171","msg":"trace[916528869] transaction","detail":"{read_only:false; response_revision:1411; number_of_response:1; }","duration":"104.556448ms","start":"2026-04-10T03:54:29.31727Z","end":"2026-04-10T03:54:29.421827Z","steps":["trace[916528869] 'process raft request' (duration: 104.440306ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T03:54:29.422768Z","caller":"traceutil/trace.go:171","msg":"trace[894447635] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"105.28709ms","start":"2026-04-10T03:54:29.317462Z","end":"2026-04-10T03:54:29.422749Z","steps":["trace[894447635] 'process raft request' (duration: 105.209799ms)"],"step_count":1}