{"level":"warn","ts":"2026-04-08T05:32:11.434631Z","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-08T05:32:11.434738Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.77:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.77:2380","--initial-cluster=instance=https://199.204.45.77:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.77:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.77: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-08T05:32:11.4348Z","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-08T05:32:11.434814Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.77:2380"]} {"level":"info","ts":"2026-04-08T05:32:11.434829Z","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-08T05:32:11.435514Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"]} {"level":"info","ts":"2026-04-08T05:32:11.435589Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.77:2380"],"listen-peer-urls":["https://199.204.45.77:2380"],"advertise-client-urls":["https://199.204.45.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.77: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-08T05:32:11.456991Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"21.128265ms"} {"level":"info","ts":"2026-04-08T05:32:11.530873Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9133559b3198d4ec","cluster-id":"60f1aee33b0786f5"} {"level":"info","ts":"2026-04-08T05:32:11.531015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T05:32:11.531051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became follower at term 0"} {"level":"info","ts":"2026-04-08T05:32:11.531086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9133559b3198d4ec [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T05:32:11.531105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became follower at term 1"} {"level":"info","ts":"2026-04-08T05:32:11.531162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=(10462800484352185580)"} {"level":"warn","ts":"2026-04-08T05:32:11.589276Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T05:32:11.598873Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T05:32:11.604569Z","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-08T05:32:11.647123Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9133559b3198d4ec","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T05:32:11.647589Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9133559b3198d4ec","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T05:32:11.647675Z","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-08T05:32:11.647744Z","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-08T05:32:11.647754Z","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-08T05:32:11.654757Z","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-08T05:32:11.654955Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.77:2380"} {"level":"info","ts":"2026-04-08T05:32:11.654996Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.77:2380"} {"level":"info","ts":"2026-04-08T05:32:11.655202Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9133559b3198d4ec","initial-advertise-peer-urls":["https://199.204.45.77:2380"],"listen-peer-urls":["https://199.204.45.77:2380"],"advertise-client-urls":["https://199.204.45.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T05:32:11.655233Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T05:32:11.768887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=(10462800484352185580)"} {"level":"info","ts":"2026-04-08T05:32:11.769084Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"60f1aee33b0786f5","local-member-id":"9133559b3198d4ec","added-peer-id":"9133559b3198d4ec","added-peer-peer-urls":["https://199.204.45.77:2380"]} {"level":"info","ts":"2026-04-08T05:32:11.769155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T05:32:11.769184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T05:32:11.769212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec received MsgPreVoteResp from 9133559b3198d4ec at term 1"} {"level":"info","ts":"2026-04-08T05:32:11.769232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became candidate at term 2"} {"level":"info","ts":"2026-04-08T05:32:11.76924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec received MsgVoteResp from 9133559b3198d4ec at term 2"} {"level":"info","ts":"2026-04-08T05:32:11.769251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became leader at term 2"} {"level":"info","ts":"2026-04-08T05:32:11.769265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9133559b3198d4ec elected leader 9133559b3198d4ec at term 2"} {"level":"info","ts":"2026-04-08T05:32:11.811111Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T05:32:11.811124Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9133559b3198d4ec","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.77:2379]}","request-path":"/0/members/9133559b3198d4ec/attributes","cluster-id":"60f1aee33b0786f5","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T05:32:11.813374Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T05:32:11.814348Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T05:32:11.814375Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T05:32:11.816453Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T05:32:11.816633Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.77:2379"} {"level":"info","ts":"2026-04-08T05:32:11.810996Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T05:32:11.827737Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"60f1aee33b0786f5","local-member-id":"9133559b3198d4ec","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T05:32:11.827806Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T05:32:11.827826Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T05:32:13.723973Z","caller":"traceutil/trace.go:171","msg":"trace[1359570763] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"191.891454ms","start":"2026-04-08T05:32:13.532055Z","end":"2026-04-08T05:32:13.723946Z","steps":["trace[1359570763] 'read index received' (duration: 66.084679ms)","trace[1359570763] 'applied index is now lower than readState.Index' (duration: 125.805925ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:13.724174Z","caller":"traceutil/trace.go:171","msg":"trace[1980812066] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"192.156135ms","start":"2026-04-08T05:32:13.531786Z","end":"2026-04-08T05:32:13.723942Z","steps":["trace[1980812066] 'process raft request' (duration: 135.644078ms)","trace[1980812066] 'compare' (duration: 56.335816ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:13.724155Z","caller":"traceutil/trace.go:171","msg":"trace[72032287] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"137.044037ms","start":"2026-04-08T05:32:13.58705Z","end":"2026-04-08T05:32:13.724094Z","steps":["trace[72032287] 'process raft request' (duration: 136.853546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:13.724315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.253776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T05:32:13.724385Z","caller":"traceutil/trace.go:171","msg":"trace[537690388] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:4; }","duration":"192.351917ms","start":"2026-04-08T05:32:13.532022Z","end":"2026-04-08T05:32:13.724374Z","steps":["trace[537690388] 'agreement among raft nodes before linearized reading' (duration: 192.057715ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:13.790422Z","caller":"traceutil/trace.go:171","msg":"trace[1123337534] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"172.907364ms","start":"2026-04-08T05:32:13.617471Z","end":"2026-04-08T05:32:13.790378Z","steps":["trace[1123337534] 'process raft request' (duration: 172.769643ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:13.790836Z","caller":"traceutil/trace.go:171","msg":"trace[616654449] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"170.985051ms","start":"2026-04-08T05:32:13.619844Z","end":"2026-04-08T05:32:13.790829Z","steps":["trace[616654449] 'process raft request' (duration: 170.73681ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:13.790688Z","caller":"traceutil/trace.go:171","msg":"trace[1041591740] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"170.86765ms","start":"2026-04-08T05:32:13.619793Z","end":"2026-04-08T05:32:13.790661Z","steps":["trace[1041591740] 'process raft request' (duration: 170.555738ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:13.79062Z","caller":"traceutil/trace.go:171","msg":"trace[10879103] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"170.919491ms","start":"2026-04-08T05:32:13.619634Z","end":"2026-04-08T05:32:13.790553Z","steps":["trace[10879103] 'process raft request' (duration: 170.676769ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:13.791285Z","caller":"traceutil/trace.go:171","msg":"trace[61190989] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"171.417214ms","start":"2026-04-08T05:32:13.619861Z","end":"2026-04-08T05:32:13.791278Z","steps":["trace[61190989] 'process raft request' (duration: 171.173632ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:13.791434Z","caller":"traceutil/trace.go:171","msg":"trace[876720470] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"171.484404ms","start":"2026-04-08T05:32:13.619937Z","end":"2026-04-08T05:32:13.791421Z","steps":["trace[876720470] 'process raft request' (duration: 171.369493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:13.79156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.801169ms","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-08T05:32:13.792479Z","caller":"traceutil/trace.go:171","msg":"trace[768955800] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"173.91453ms","start":"2026-04-08T05:32:13.617693Z","end":"2026-04-08T05:32:13.791608Z","steps":["trace[768955800] 'agreement among raft nodes before linearized reading' (duration: 173.725809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:13.793013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.030391ms","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-08T05:32:13.793065Z","caller":"traceutil/trace.go:171","msg":"trace[350901949] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"125.063101ms","start":"2026-04-08T05:32:13.667973Z","end":"2026-04-08T05:32:13.793036Z","steps":["trace[350901949] 'agreement among raft nodes before linearized reading' (duration: 123.657872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:13.793069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.845848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.77\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T05:32:13.793197Z","caller":"traceutil/trace.go:171","msg":"trace[1243773482] range","detail":"{range_begin:/registry/masterleases/199.204.45.77; range_end:; response_count:0; response_revision:10; }","duration":"178.402048ms","start":"2026-04-08T05:32:13.614765Z","end":"2026-04-08T05:32:13.793167Z","steps":["trace[1243773482] 'agreement among raft nodes before linearized reading' (duration: 176.828268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:13.793781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.363821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T05:32:13.793824Z","caller":"traceutil/trace.go:171","msg":"trace[255687469] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:10; }","duration":"150.433062ms","start":"2026-04-08T05:32:13.643373Z","end":"2026-04-08T05:32:13.793806Z","steps":["trace[255687469] 'agreement among raft nodes before linearized reading' (duration: 150.368162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:13.791583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.932226ms","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-08T05:32:13.794395Z","caller":"traceutil/trace.go:171","msg":"trace[2012044177] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"177.726843ms","start":"2026-04-08T05:32:13.616615Z","end":"2026-04-08T05:32:13.794342Z","steps":["trace[2012044177] 'agreement among raft nodes before linearized reading' (duration: 174.936776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:13.794449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.898049ms","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-08T05:32:13.79466Z","caller":"traceutil/trace.go:171","msg":"trace[539621442] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"209.931138ms","start":"2026-04-08T05:32:13.584683Z","end":"2026-04-08T05:32:13.794614Z","steps":["trace[539621442] 'agreement among raft nodes before linearized reading' (duration: 206.920269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.650347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.416289ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-08T05:32:14.650718Z","caller":"traceutil/trace.go:171","msg":"trace[1822347383] linearizableReadLoop","detail":"{readStateIndex:22; appliedIndex:14; }","duration":"828.193413ms","start":"2026-04-08T05:32:13.822509Z","end":"2026-04-08T05:32:14.650702Z","steps":["trace[1822347383] 'read index received' (duration: 308.948669ms)","trace[1822347383] 'applied index is now lower than readState.Index' (duration: 519.243904ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:14.650822Z","caller":"traceutil/trace.go:171","msg":"trace[582095175] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"850.137222ms","start":"2026-04-08T05:32:13.800667Z","end":"2026-04-08T05:32:14.650804Z","steps":["trace[582095175] 'process raft request' (duration: 849.972461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.650967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:13.800661Z","time spent":"850.236953ms","remote":"127.0.0.1:38456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:32:14.651162Z","caller":"traceutil/trace.go:171","msg":"trace[773626214] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"850.731256ms","start":"2026-04-08T05:32:13.800378Z","end":"2026-04-08T05:32:14.651109Z","steps":["trace[773626214] 'process raft request' (duration: 850.150752ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:14.65124Z","caller":"traceutil/trace.go:171","msg":"trace[497013117] transaction","detail":"{read_only:false; number_of_response:0; response_revision:18; }","duration":"850.469455ms","start":"2026-04-08T05:32:13.80076Z","end":"2026-04-08T05:32:14.65123Z","steps":["trace[497013117] 'process raft request' (duration: 849.912201ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.651298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:13.800728Z","time spent":"850.544265ms","remote":"127.0.0.1:38006","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:32:14.651406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:13.800373Z","time spent":"850.878817ms","remote":"127.0.0.1:38456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:32:14.651485Z","caller":"traceutil/trace.go:171","msg":"trace[536022904] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"851.168138ms","start":"2026-04-08T05:32:13.80031Z","end":"2026-04-08T05:32:14.651478Z","steps":["trace[536022904] 'process raft request' (duration: 850.172362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.651529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:13.800293Z","time spent":"851.212018ms","remote":"127.0.0.1:38456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:32:14.651631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.671724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T05:32:14.651673Z","caller":"traceutil/trace.go:171","msg":"trace[1805066174] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18; }","duration":"853.745185ms","start":"2026-04-08T05:32:13.797918Z","end":"2026-04-08T05:32:14.651663Z","steps":["trace[1805066174] 'agreement among raft nodes before linearized reading' (duration: 853.611194ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:14.651683Z","caller":"traceutil/trace.go:171","msg":"trace[1745380373] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"851.114088ms","start":"2026-04-08T05:32:13.800561Z","end":"2026-04-08T05:32:14.651675Z","steps":["trace[1745380373] 'process raft request' (duration: 849.991411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.651708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:13.7979Z","time spent":"853.799685ms","remote":"127.0.0.1:37916","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-08T05:32:14.651721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:13.800555Z","time spent":"851.145638ms","remote":"127.0.0.1:38456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:32:14.651427Z","caller":"traceutil/trace.go:171","msg":"trace[1139613005] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"852.096734ms","start":"2026-04-08T05:32:13.798559Z","end":"2026-04-08T05:32:14.650656Z","steps":["trace[1139613005] 'process raft request' (duration: 851.874473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.652055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:13.798525Z","time spent":"853.491782ms","remote":"127.0.0.1:38006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:32:14.65208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.541048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"warn","ts":"2026-04-08T05:32:14.651978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.66743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-04-08T05:32:14.652372Z","caller":"traceutil/trace.go:171","msg":"trace[648127987] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:18; }","duration":"855.085402ms","start":"2026-04-08T05:32:13.797269Z","end":"2026-04-08T05:32:14.652355Z","steps":["trace[648127987] 'agreement among raft nodes before linearized reading' (duration: 854.65506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.652451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:13.797249Z","time spent":"855.184724ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-08T05:32:14.652356Z","caller":"traceutil/trace.go:171","msg":"trace[1980896968] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:18; }","duration":"827.711979ms","start":"2026-04-08T05:32:13.824499Z","end":"2026-04-08T05:32:14.652211Z","steps":["trace[1980896968] 'agreement among raft nodes before linearized reading' (duration: 827.526958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.652614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:13.824484Z","time spent":"828.110812ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-08T05:32:14.652894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.369854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-08T05:32:14.652966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.475525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T05:32:14.652975Z","caller":"traceutil/trace.go:171","msg":"trace[1467446383] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:18; }","duration":"137.489535ms","start":"2026-04-08T05:32:14.515465Z","end":"2026-04-08T05:32:14.652955Z","steps":["trace[1467446383] 'agreement among raft nodes before linearized reading' (duration: 137.356073ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:14.65301Z","caller":"traceutil/trace.go:171","msg":"trace[1294279117] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:18; }","duration":"137.543706ms","start":"2026-04-08T05:32:14.515448Z","end":"2026-04-08T05:32:14.652991Z","steps":["trace[1294279117] 'agreement among raft nodes before linearized reading' (duration: 137.497776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.652993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.556263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-04-08T05:32:14.652902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.692027ms","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-08T05:32:14.653269Z","caller":"traceutil/trace.go:171","msg":"trace[2846122] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:18; }","duration":"652.11896ms","start":"2026-04-08T05:32:14.001136Z","end":"2026-04-08T05:32:14.653255Z","steps":["trace[2846122] 'agreement among raft nodes before linearized reading' (duration: 651.695526ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:14.65319Z","caller":"traceutil/trace.go:171","msg":"trace[236852703] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:18; }","duration":"796.751584ms","start":"2026-04-08T05:32:13.856421Z","end":"2026-04-08T05:32:14.653172Z","steps":["trace[236852703] 'agreement among raft nodes before linearized reading' (duration: 796.523063ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.653319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:14.001085Z","time spent":"652.215861ms","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-04-08T05:32:14.653763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:13.856409Z","time spent":"797.332617ms","remote":"127.0.0.1:38006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-08T05:32:14.653126Z","caller":"traceutil/trace.go:171","msg":"trace[1606228097] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"858.407514ms","start":"2026-04-08T05:32:13.794656Z","end":"2026-04-08T05:32:14.653063Z","steps":["trace[1606228097] 'process raft request' (duration: 336.718214ms)","trace[1606228097] 'compare' (duration: 518.249458ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:14.654137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:13.794624Z","time spent":"859.40301ms","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:32:14.650758Z","caller":"traceutil/trace.go:171","msg":"trace[2037410369] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"850.102462ms","start":"2026-04-08T05:32:13.800625Z","end":"2026-04-08T05:32:14.650727Z","steps":["trace[2037410369] 'process raft request' (duration: 849.948801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.655647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.94758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-04-08T05:32:14.655731Z","caller":"traceutil/trace.go:171","msg":"trace[1924724337] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:18; }","duration":"824.830542ms","start":"2026-04-08T05:32:13.830857Z","end":"2026-04-08T05:32:14.655688Z","steps":["trace[1924724337] 'agreement among raft nodes before linearized reading' (duration: 822.90082ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.655804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:13.830845Z","time spent":"824.921793ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-08T05:32:14.655831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:13.800618Z","time spent":"855.010542ms","remote":"127.0.0.1:38456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:32:14.985181Z","caller":"traceutil/trace.go:171","msg":"trace[1882693312] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"325.544307ms","start":"2026-04-08T05:32:14.659568Z","end":"2026-04-08T05:32:14.985112Z","steps":["trace[1882693312] 'process raft request' (duration: 292.486918ms)","trace[1882693312] 'compare' (duration: 32.748927ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:14.985298Z","caller":"traceutil/trace.go:171","msg":"trace[1331042868] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"325.553256ms","start":"2026-04-08T05:32:14.65972Z","end":"2026-04-08T05:32:14.985273Z","steps":["trace[1331042868] 'process raft request' (duration: 325.309425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.985428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:14.659701Z","time spent":"325.651007ms","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:32:14.985487Z","caller":"traceutil/trace.go:171","msg":"trace[1622088717] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"325.596817ms","start":"2026-04-08T05:32:14.659866Z","end":"2026-04-08T05:32:14.985463Z","steps":["trace[1622088717] 'process raft request' (duration: 325.349825ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:14.985499Z","caller":"traceutil/trace.go:171","msg":"trace[1131745564] linearizableReadLoop","detail":"{readStateIndex:33; appliedIndex:23; }","duration":"239.114333ms","start":"2026-04-08T05:32:14.746352Z","end":"2026-04-08T05:32:14.985466Z","steps":["trace[1131745564] 'read index received' (duration: 205.624922ms)","trace[1131745564] 'applied index is now lower than readState.Index' (duration: 33.488101ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:14.985599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:14.659859Z","time spent":"325.681987ms","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:32:14.985687Z","caller":"traceutil/trace.go:171","msg":"trace[1476117958] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"325.821308ms","start":"2026-04-08T05:32:14.659855Z","end":"2026-04-08T05:32:14.985676Z","steps":["trace[1476117958] 'process raft request' (duration: 325.318955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.985745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:14.659843Z","time spent":"325.873178ms","remote":"127.0.0.1:38456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:32:14.985898Z","caller":"traceutil/trace.go:171","msg":"trace[1728400715] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"326.141ms","start":"2026-04-08T05:32:14.659745Z","end":"2026-04-08T05:32:14.985886Z","steps":["trace[1728400715] 'process raft request' (duration: 325.345355ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:14.985907Z","caller":"traceutil/trace.go:171","msg":"trace[118188806] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"326.026309ms","start":"2026-04-08T05:32:14.659868Z","end":"2026-04-08T05:32:14.985894Z","steps":["trace[118188806] 'process raft request' (duration: 325.391305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.985949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:14.659726Z","time spent":"326.20064ms","remote":"127.0.0.1:38456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:32:14.986089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:14.659855Z","time spent":"326.090509ms","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:32:14.986126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.158158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-node-lease\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T05:32:14.986167Z","caller":"traceutil/trace.go:171","msg":"trace[1017880700] range","detail":"{range_begin:/registry/namespaces/kube-node-lease; range_end:; response_count:0; response_revision:29; }","duration":"278.221499ms","start":"2026-04-08T05:32:14.707934Z","end":"2026-04-08T05:32:14.986155Z","steps":["trace[1017880700] 'agreement among raft nodes before linearized reading' (duration: 278.077798ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.986159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.255601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T05:32:14.98621Z","caller":"traceutil/trace.go:171","msg":"trace[1211641038] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:29; }","duration":"237.358122ms","start":"2026-04-08T05:32:14.748839Z","end":"2026-04-08T05:32:14.986197Z","steps":["trace[1211641038] 'agreement among raft nodes before linearized reading' (duration: 237.254961ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:14.986249Z","caller":"traceutil/trace.go:171","msg":"trace[712272929] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"326.23451ms","start":"2026-04-08T05:32:14.659995Z","end":"2026-04-08T05:32:14.986229Z","steps":["trace[712272929] 'process raft request' (duration: 325.372215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.986304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:14.65997Z","time spent":"326.306501ms","remote":"127.0.0.1:38456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:32:14.986346Z","caller":"traceutil/trace.go:171","msg":"trace[141555541] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"326.284602ms","start":"2026-04-08T05:32:14.660051Z","end":"2026-04-08T05:32:14.986335Z","steps":["trace[141555541] 'process raft request' (duration: 325.350315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.98638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.814866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-08T05:32:14.986395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:14.660039Z","time spent":"326.329532ms","remote":"127.0.0.1:38006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:32:14.986408Z","caller":"traceutil/trace.go:171","msg":"trace[541607836] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:29; }","duration":"296.870296ms","start":"2026-04-08T05:32:14.689529Z","end":"2026-04-08T05:32:14.986399Z","steps":["trace[541607836] 'agreement among raft nodes before linearized reading' (duration: 296.828406ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:14.986422Z","caller":"traceutil/trace.go:171","msg":"trace[1621616916] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"326.485403ms","start":"2026-04-08T05:32:14.659928Z","end":"2026-04-08T05:32:14.986413Z","steps":["trace[1621616916] 'process raft request' (duration: 325.369656ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:14.986444Z","caller":"traceutil/trace.go:171","msg":"trace[2120689174] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"326.486823ms","start":"2026-04-08T05:32:14.659937Z","end":"2026-04-08T05:32:14.986424Z","steps":["trace[2120689174] 'process raft request' (duration: 325.396976ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.986465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:14.659898Z","time spent":"326.546483ms","remote":"127.0.0.1:38456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:32:14.986512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:14.659926Z","time spent":"326.553164ms","remote":"127.0.0.1:38456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:32:14.986546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.595534ms","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-08T05:32:14.986578Z","caller":"traceutil/trace.go:171","msg":"trace[1536844705] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:29; }","duration":"326.641264ms","start":"2026-04-08T05:32:14.659925Z","end":"2026-04-08T05:32:14.986566Z","steps":["trace[1536844705] 'agreement among raft nodes before linearized reading' (duration: 326.599534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.986604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:14.659917Z","time spent":"326.680984ms","remote":"127.0.0.1:37996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":27,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"warn","ts":"2026-04-08T05:32:14.986657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.510416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T05:32:14.986689Z","caller":"traceutil/trace.go:171","msg":"trace[130717120] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:29; }","duration":"126.540996ms","start":"2026-04-08T05:32:14.860138Z","end":"2026-04-08T05:32:14.986679Z","steps":["trace[130717120] 'agreement among raft nodes before linearized reading' (duration: 126.493155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:14.988105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:14.659369Z","time spent":"325.896448ms","remote":"127.0.0.1:38300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:32:15.36354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.80249ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-08T05:32:15.36374Z","caller":"traceutil/trace.go:171","msg":"trace[516294080] linearizableReadLoop","detail":"{readStateIndex:43; appliedIndex:41; }","duration":"282.122723ms","start":"2026-04-08T05:32:15.081595Z","end":"2026-04-08T05:32:15.363718Z","steps":["trace[516294080] 'read index received' (duration: 61.074721ms)","trace[516294080] 'applied index is now lower than readState.Index' (duration: 221.047022ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:15.363755Z","caller":"traceutil/trace.go:171","msg":"trace[215521780] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"360.930157ms","start":"2026-04-08T05:32:15.002785Z","end":"2026-04-08T05:32:15.363716Z","steps":["trace[215521780] 'process raft request' (duration: 139.872905ms)","trace[215521780] 'compare' (duration: 220.643929ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:15.363864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:15.002779Z","time spent":"361.035028ms","remote":"127.0.0.1:38300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:32:15.363875Z","caller":"traceutil/trace.go:171","msg":"trace[1310478506] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"360.051311ms","start":"2026-04-08T05:32:15.003794Z","end":"2026-04-08T05:32:15.363845Z","steps":["trace[1310478506] 'process raft request' (duration: 359.85244ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:15.363953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.343864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T05:32:15.364015Z","caller":"traceutil/trace.go:171","msg":"trace[1310375684] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:39; }","duration":"282.434485ms","start":"2026-04-08T05:32:15.081566Z","end":"2026-04-08T05:32:15.364Z","steps":["trace[1310375684] 'agreement among raft nodes before linearized reading' (duration: 282.253464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:15.364021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:15.003726Z","time spent":"360.237281ms","remote":"127.0.0.1:38456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:32:15.367505Z","caller":"traceutil/trace.go:171","msg":"trace[1937644842] transaction","detail":"{read_only:false; response_revision:40; number_of_response:1; }","duration":"284.600589ms","start":"2026-04-08T05:32:15.082887Z","end":"2026-04-08T05:32:15.367487Z","steps":["trace[1937644842] 'process raft request' (duration: 284.474338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:15.367663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.424996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/default/\" range_end:\"/registry/resourcequotas/default0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T05:32:15.367735Z","caller":"traceutil/trace.go:171","msg":"trace[1038565696] range","detail":"{range_begin:/registry/resourcequotas/default/; range_end:/registry/resourcequotas/default0; response_count:0; response_revision:40; }","duration":"282.527156ms","start":"2026-04-08T05:32:15.085188Z","end":"2026-04-08T05:32:15.367716Z","steps":["trace[1038565696] 'agreement among raft nodes before linearized reading' (duration: 282.397766ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:15.565915Z","caller":"traceutil/trace.go:171","msg":"trace[997679806] linearizableReadLoop","detail":"{readStateIndex:50; appliedIndex:48; }","duration":"113.251957ms","start":"2026-04-08T05:32:15.452636Z","end":"2026-04-08T05:32:15.565888Z","steps":["trace[997679806] 'read index received' (duration: 94.643462ms)","trace[997679806] 'applied index is now lower than readState.Index' (duration: 18.607085ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:15.565977Z","caller":"traceutil/trace.go:171","msg":"trace[1093865995] transaction","detail":"{read_only:false; response_revision:45; number_of_response:1; }","duration":"125.605115ms","start":"2026-04-08T05:32:15.440346Z","end":"2026-04-08T05:32:15.565951Z","steps":["trace[1093865995] 'process raft request' (duration: 106.881498ms)","trace[1093865995] 'compare' (duration: 18.424895ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:15.566101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.451268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:discovery\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T05:32:15.566265Z","caller":"traceutil/trace.go:171","msg":"trace[909139750] range","detail":"{range_begin:/registry/clusterroles/system:discovery; range_end:; response_count:0; response_revision:46; }","duration":"113.670761ms","start":"2026-04-08T05:32:15.452582Z","end":"2026-04-08T05:32:15.566252Z","steps":["trace[909139750] 'agreement among raft nodes before linearized reading' (duration: 113.409749ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:15.56615Z","caller":"traceutil/trace.go:171","msg":"trace[2035257290] transaction","detail":"{read_only:false; response_revision:46; number_of_response:1; }","duration":"122.851898ms","start":"2026-04-08T05:32:15.443288Z","end":"2026-04-08T05:32:15.56614Z","steps":["trace[2035257290] 'process raft request' (duration: 122.507855ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:15.704336Z","caller":"traceutil/trace.go:171","msg":"trace[2049619086] linearizableReadLoop","detail":"{readStateIndex:53; appliedIndex:51; }","duration":"122.902728ms","start":"2026-04-08T05:32:15.581404Z","end":"2026-04-08T05:32:15.704307Z","steps":["trace[2049619086] 'read index received' (duration: 113.714841ms)","trace[2049619086] 'applied index is now lower than readState.Index' (duration: 9.186447ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:15.704342Z","caller":"traceutil/trace.go:171","msg":"trace[1056169040] transaction","detail":"{read_only:false; response_revision:48; number_of_response:1; }","duration":"133.614935ms","start":"2026-04-08T05:32:15.570703Z","end":"2026-04-08T05:32:15.704318Z","steps":["trace[1056169040] 'process raft request' (duration: 124.385688ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:15.704635Z","caller":"traceutil/trace.go:171","msg":"trace[286827593] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"132.144086ms","start":"2026-04-08T05:32:15.572446Z","end":"2026-04-08T05:32:15.70459Z","steps":["trace[286827593] 'process raft request' (duration: 131.780954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:15.70488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.415181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:monitoring\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T05:32:15.704948Z","caller":"traceutil/trace.go:171","msg":"trace[639752886] range","detail":"{range_begin:/registry/clusterroles/system:monitoring; range_end:; response_count:0; response_revision:49; }","duration":"123.567712ms","start":"2026-04-08T05:32:15.581362Z","end":"2026-04-08T05:32:15.70493Z","steps":["trace[639752886] 'agreement among raft nodes before linearized reading' (duration: 123.405641ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:15.880447Z","caller":"traceutil/trace.go:171","msg":"trace[1062510361] linearizableReadLoop","detail":"{readStateIndex:58; appliedIndex:57; }","duration":"122.967319ms","start":"2026-04-08T05:32:15.757442Z","end":"2026-04-08T05:32:15.880409Z","steps":["trace[1062510361] 'read index received' (duration: 26.627876ms)","trace[1062510361] 'applied index is now lower than readState.Index' (duration: 96.335273ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:15.880558Z","caller":"traceutil/trace.go:171","msg":"trace[1725534010] transaction","detail":"{read_only:false; response_revision:54; number_of_response:1; }","duration":"123.870475ms","start":"2026-04-08T05:32:15.75666Z","end":"2026-04-08T05:32:15.88053Z","steps":["trace[1725534010] 'process raft request' (duration: 58.170484ms)","trace[1725534010] 'compare' (duration: 65.229588ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:15.880809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.196631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-08T05:32:15.880876Z","caller":"traceutil/trace.go:171","msg":"trace[1028875805] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:55; }","duration":"120.278791ms","start":"2026-04-08T05:32:15.76058Z","end":"2026-04-08T05:32:15.880859Z","steps":["trace[1028875805] 'agreement among raft nodes before linearized reading' (duration: 120.02884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:15.88081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.296131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/probes\" ","response":"range_response_count:1 size:1071"} {"level":"info","ts":"2026-04-08T05:32:15.88108Z","caller":"traceutil/trace.go:171","msg":"trace[1711441160] range","detail":"{range_begin:/registry/flowschemas/probes; range_end:; response_count:1; response_revision:55; }","duration":"123.633133ms","start":"2026-04-08T05:32:15.757408Z","end":"2026-04-08T05:32:15.881041Z","steps":["trace[1711441160] 'agreement among raft nodes before linearized reading' (duration: 123.17338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:16.135233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.283189ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-08T05:32:16.135545Z","caller":"traceutil/trace.go:171","msg":"trace[1711458529] transaction","detail":"{read_only:false; response_revision:61; number_of_response:1; }","duration":"171.942721ms","start":"2026-04-08T05:32:15.963574Z","end":"2026-04-08T05:32:16.135517Z","steps":["trace[1711458529] 'process raft request' (duration: 67.31843ms)","trace[1711458529] 'compare' (duration: 103.923797ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:16.13577Z","caller":"traceutil/trace.go:171","msg":"trace[306903639] transaction","detail":"{read_only:false; response_revision:62; number_of_response:1; }","duration":"172.042601ms","start":"2026-04-08T05:32:15.963693Z","end":"2026-04-08T05:32:16.135736Z","steps":["trace[306903639] 'process raft request' (duration: 171.76933ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:16.135825Z","caller":"traceutil/trace.go:171","msg":"trace[865802149] transaction","detail":"{read_only:false; response_revision:63; number_of_response:1; }","duration":"158.041344ms","start":"2026-04-08T05:32:15.977765Z","end":"2026-04-08T05:32:16.135806Z","steps":["trace[865802149] 'process raft request' (duration: 157.836732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:16.565141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.662767ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-04-08T05:32:16.565408Z","caller":"traceutil/trace.go:171","msg":"trace[1009114900] transaction","detail":"{read_only:false; response_revision:67; number_of_response:1; }","duration":"361.771399ms","start":"2026-04-08T05:32:16.203625Z","end":"2026-04-08T05:32:16.565397Z","steps":["trace[1009114900] 'process raft request' (duration: 361.731079ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:16.56548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:16.203607Z","time spent":"361.83724ms","remote":"127.0.0.1:38374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":702,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:32:16.565829Z","caller":"traceutil/trace.go:171","msg":"trace[61553720] transaction","detail":"{read_only:false; response_revision:65; number_of_response:1; }","duration":"425.990269ms","start":"2026-04-08T05:32:16.139828Z","end":"2026-04-08T05:32:16.565819Z","steps":["trace[61553720] 'process raft request' (duration: 192.497897ms)","trace[61553720] 'compare' (duration: 232.568396ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:16.565889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:16.139804Z","time spent":"426.054039ms","remote":"127.0.0.1:38374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1116,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:32:16.566083Z","caller":"traceutil/trace.go:171","msg":"trace[660408859] transaction","detail":"{read_only:false; response_revision:66; number_of_response:1; }","duration":"426.010058ms","start":"2026-04-08T05:32:16.140064Z","end":"2026-04-08T05:32:16.566074Z","steps":["trace[660408859] 'process raft request' (duration: 425.146873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:16.566131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:16.14004Z","time spent":"426.071169ms","remote":"127.0.0.1:38274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":710,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:32:16.566246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:16.145436Z","time spent":"420.809067ms","remote":"127.0.0.1:37976","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-08T05:32:16.707216Z","caller":"traceutil/trace.go:171","msg":"trace[760377967] transaction","detail":"{read_only:false; response_revision:69; number_of_response:1; }","duration":"138.140628ms","start":"2026-04-08T05:32:16.56905Z","end":"2026-04-08T05:32:16.70719Z","steps":["trace[760377967] 'process raft request' (duration: 111.876424ms)","trace[760377967] 'compare' (duration: 25.841292ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:16.707199Z","caller":"traceutil/trace.go:171","msg":"trace[769699424] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"136.572759ms","start":"2026-04-08T05:32:16.570597Z","end":"2026-04-08T05:32:16.707169Z","steps":["trace[769699424] 'process raft request' (duration: 136.441548ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:16.707463Z","caller":"traceutil/trace.go:171","msg":"trace[245148471] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"118.710908ms","start":"2026-04-08T05:32:16.588721Z","end":"2026-04-08T05:32:16.707432Z","steps":["trace[245148471] 'process raft request' (duration: 118.405006ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:16.708335Z","caller":"traceutil/trace.go:171","msg":"trace[106969824] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"119.498373ms","start":"2026-04-08T05:32:16.588812Z","end":"2026-04-08T05:32:16.70831Z","steps":["trace[106969824] 'process raft request' (duration: 118.502967ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:16.856791Z","caller":"traceutil/trace.go:171","msg":"trace[1412805314] transaction","detail":"{read_only:false; response_revision:79; number_of_response:1; }","duration":"123.78197ms","start":"2026-04-08T05:32:16.732927Z","end":"2026-04-08T05:32:16.856709Z","steps":["trace[1412805314] 'process raft request' (duration: 96.52145ms)","trace[1412805314] 'compare' (duration: 26.956968ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:16.857127Z","caller":"traceutil/trace.go:171","msg":"trace[349242903] transaction","detail":"{read_only:false; response_revision:80; number_of_response:1; }","duration":"123.370527ms","start":"2026-04-08T05:32:16.733723Z","end":"2026-04-08T05:32:16.857093Z","steps":["trace[349242903] 'process raft request' (duration: 122.873964ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:16.85735Z","caller":"traceutil/trace.go:171","msg":"trace[1992669349] transaction","detail":"{read_only:false; response_revision:81; number_of_response:1; }","duration":"123.330397ms","start":"2026-04-08T05:32:16.733802Z","end":"2026-04-08T05:32:16.857132Z","steps":["trace[1992669349] 'process raft request' (duration: 122.867414ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:17.773499Z","caller":"traceutil/trace.go:171","msg":"trace[2116688409] linearizableReadLoop","detail":"{readStateIndex:135; appliedIndex:133; }","duration":"211.307126ms","start":"2026-04-08T05:32:17.56217Z","end":"2026-04-08T05:32:17.773477Z","steps":["trace[2116688409] 'read index received' (duration: 173.460702ms)","trace[2116688409] 'applied index is now lower than readState.Index' (duration: 37.845344ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:17.773609Z","caller":"traceutil/trace.go:171","msg":"trace[1631911752] transaction","detail":"{read_only:false; response_revision:129; number_of_response:1; }","duration":"231.837293ms","start":"2026-04-08T05:32:17.541743Z","end":"2026-04-08T05:32:17.77358Z","steps":["trace[1631911752] 'process raft request' (duration: 193.782838ms)","trace[1631911752] 'compare' (duration: 37.661532ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:17.773874Z","caller":"traceutil/trace.go:171","msg":"trace[766549389] transaction","detail":"{read_only:false; response_revision:130; number_of_response:1; }","duration":"232.071955ms","start":"2026-04-08T05:32:17.541749Z","end":"2026-04-08T05:32:17.773821Z","steps":["trace[766549389] 'process raft request' (duration: 231.654801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:17.77413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.937311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5890"} {"level":"info","ts":"2026-04-08T05:32:17.774207Z","caller":"traceutil/trace.go:171","msg":"trace[679205994] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:130; }","duration":"212.063832ms","start":"2026-04-08T05:32:17.562126Z","end":"2026-04-08T05:32:17.774189Z","steps":["trace[679205994] 'agreement among raft nodes before linearized reading' (duration: 211.841591ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:18.036078Z","caller":"traceutil/trace.go:171","msg":"trace[1331608209] linearizableReadLoop","detail":"{readStateIndex:144; appliedIndex:141; }","duration":"176.30056ms","start":"2026-04-08T05:32:17.85976Z","end":"2026-04-08T05:32:18.03606Z","steps":["trace[1331608209] 'read index received' (duration: 124.017108ms)","trace[1331608209] 'applied index is now lower than readState.Index' (duration: 52.282722ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:18.036069Z","caller":"traceutil/trace.go:171","msg":"trace[431456158] transaction","detail":"{read_only:false; response_revision:137; number_of_response:1; }","duration":"215.440542ms","start":"2026-04-08T05:32:17.820593Z","end":"2026-04-08T05:32:18.036034Z","steps":["trace[431456158] 'process raft request' (duration: 163.15897ms)","trace[431456158] 'compare' (duration: 51.769839ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:18.03619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.423941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:18.036215Z","caller":"traceutil/trace.go:171","msg":"trace[752800420] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:139; }","duration":"176.492031ms","start":"2026-04-08T05:32:17.859714Z","end":"2026-04-08T05:32:18.036207Z","steps":["trace[752800420] 'agreement among raft nodes before linearized reading' (duration: 176.426ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:18.036469Z","caller":"traceutil/trace.go:171","msg":"trace[9590074] transaction","detail":"{read_only:false; response_revision:138; number_of_response:1; }","duration":"209.844207ms","start":"2026-04-08T05:32:17.826617Z","end":"2026-04-08T05:32:18.036461Z","steps":["trace[9590074] 'process raft request' (duration: 209.348924ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:18.036438Z","caller":"traceutil/trace.go:171","msg":"trace[1971759705] transaction","detail":"{read_only:false; response_revision:139; number_of_response:1; }","duration":"206.527756ms","start":"2026-04-08T05:32:17.829888Z","end":"2026-04-08T05:32:18.036416Z","steps":["trace[1971759705] 'process raft request' (duration: 206.137444ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:18.270549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.727906ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:18.270778Z","caller":"traceutil/trace.go:171","msg":"trace[1678266951] transaction","detail":"{read_only:false; response_revision:142; number_of_response:1; }","duration":"185.605032ms","start":"2026-04-08T05:32:18.08515Z","end":"2026-04-08T05:32:18.270755Z","steps":["trace[1678266951] 'process raft request' (duration: 185.525262ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:18.271033Z","caller":"traceutil/trace.go:171","msg":"trace[1445770020] transaction","detail":"{read_only:false; response_revision:141; number_of_response:1; }","duration":"227.189848ms","start":"2026-04-08T05:32:18.043826Z","end":"2026-04-08T05:32:18.271016Z","steps":["trace[1445770020] 'process raft request' (duration: 111.912489ms)","trace[1445770020] 'compare' (duration: 114.568345ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:18.48424Z","caller":"traceutil/trace.go:171","msg":"trace[368639222] transaction","detail":"{read_only:false; response_revision:147; number_of_response:1; }","duration":"120.658322ms","start":"2026-04-08T05:32:18.363557Z","end":"2026-04-08T05:32:18.484215Z","steps":["trace[368639222] 'process raft request' (duration: 120.600522ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:18.484253Z","caller":"traceutil/trace.go:171","msg":"trace[161798002] transaction","detail":"{read_only:false; response_revision:146; number_of_response:1; }","duration":"121.171995ms","start":"2026-04-08T05:32:18.363059Z","end":"2026-04-08T05:32:18.484231Z","steps":["trace[161798002] 'process raft request' (duration: 27.756781ms)","trace[161798002] 'compare' (duration: 93.195543ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:18.704323Z","caller":"traceutil/trace.go:171","msg":"trace[1038577050] linearizableReadLoop","detail":"{readStateIndex:155; appliedIndex:154; }","duration":"175.615451ms","start":"2026-04-08T05:32:18.528679Z","end":"2026-04-08T05:32:18.704295Z","steps":["trace[1038577050] 'read index received' (duration: 164.575893ms)","trace[1038577050] 'applied index is now lower than readState.Index' (duration: 11.038128ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:18.704417Z","caller":"traceutil/trace.go:171","msg":"trace[1306063370] transaction","detail":"{read_only:false; response_revision:150; number_of_response:1; }","duration":"203.486062ms","start":"2026-04-08T05:32:18.500884Z","end":"2026-04-08T05:32:18.70437Z","steps":["trace[1306063370] 'process raft request' (duration: 192.405604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:18.704526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.824602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:daemon-set-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:18.704637Z","caller":"traceutil/trace.go:171","msg":"trace[1112027972] range","detail":"{range_begin:/registry/clusterroles/system:controller:daemon-set-controller; range_end:; response_count:0; response_revision:150; }","duration":"175.978242ms","start":"2026-04-08T05:32:18.528624Z","end":"2026-04-08T05:32:18.704602Z","steps":["trace[1112027972] 'agreement among raft nodes before linearized reading' (duration: 175.778941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:19.377097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.497733ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:19.377206Z","caller":"traceutil/trace.go:171","msg":"trace[1882163426] linearizableReadLoop","detail":"{readStateIndex:162; appliedIndex:161; }","duration":"423.120681ms","start":"2026-04-08T05:32:18.954065Z","end":"2026-04-08T05:32:19.377185Z","steps":["trace[1882163426] 'read index received' (duration: 38.463487ms)","trace[1882163426] 'applied index is now lower than readState.Index' (duration: 384.655834ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:19.377335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.461238ms","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-08T05:32:19.377366Z","caller":"traceutil/trace.go:171","msg":"trace[1535962152] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:157; }","duration":"492.530328ms","start":"2026-04-08T05:32:18.884824Z","end":"2026-04-08T05:32:19.377354Z","steps":["trace[1535962152] 'agreement among raft nodes before linearized reading' (duration: 492.437138ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:19.37733Z","caller":"traceutil/trace.go:171","msg":"trace[1016598269] transaction","detail":"{read_only:false; response_revision:157; number_of_response:1; }","duration":"491.057759ms","start":"2026-04-08T05:32:18.886231Z","end":"2026-04-08T05:32:19.377289Z","steps":["trace[1016598269] 'process raft request' (duration: 106.288314ms)","trace[1016598269] 'compare' (duration: 384.348742ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:19.377416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:18.884807Z","time spent":"492.601299ms","remote":"127.0.0.1:38180","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-08T05:32:19.377506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:18.886192Z","time spent":"491.23417ms","remote":"127.0.0.1:38274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:32:19.383477Z","caller":"traceutil/trace.go:171","msg":"trace[1905068611] transaction","detail":"{read_only:false; response_revision:158; number_of_response:1; }","duration":"425.073144ms","start":"2026-04-08T05:32:18.95838Z","end":"2026-04-08T05:32:19.383453Z","steps":["trace[1905068611] 'process raft request' (duration: 424.930613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:19.383649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:18.958362Z","time spent":"425.184534ms","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:32:19.383862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.70829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:19.384014Z","caller":"traceutil/trace.go:171","msg":"trace[288765921] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:158; }","duration":"424.902501ms","start":"2026-04-08T05:32:18.95906Z","end":"2026-04-08T05:32:19.383962Z","steps":["trace[288765921] 'agreement among raft nodes before linearized reading' (duration: 424.63425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:19.384186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:18.959051Z","time spent":"425.088882ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-08T05:32:19.602038Z","caller":"traceutil/trace.go:171","msg":"trace[616678298] transaction","detail":"{read_only:false; response_revision:163; number_of_response:1; }","duration":"130.396857ms","start":"2026-04-08T05:32:19.471603Z","end":"2026-04-08T05:32:19.602Z","steps":["trace[616678298] 'process raft request' (duration: 68.70205ms)","trace[616678298] 'compare' (duration: 61.501566ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:19.765351Z","caller":"traceutil/trace.go:171","msg":"trace[802644263] linearizableReadLoop","detail":"{readStateIndex:170; appliedIndex:169; }","duration":"125.390247ms","start":"2026-04-08T05:32:19.639907Z","end":"2026-04-08T05:32:19.765298Z","steps":["trace[802644263] 'read index received' (duration: 84.736208ms)","trace[802644263] 'applied index is now lower than readState.Index' (duration: 40.643308ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:19.765976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.047311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:generic-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:19.766046Z","caller":"traceutil/trace.go:171","msg":"trace[2108032156] range","detail":"{range_begin:/registry/clusterroles/system:controller:generic-garbage-collector; range_end:; response_count:0; response_revision:165; }","duration":"126.154543ms","start":"2026-04-08T05:32:19.639873Z","end":"2026-04-08T05:32:19.766027Z","steps":["trace[2108032156] 'agreement among raft nodes before linearized reading' (duration: 125.534299ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:19.766119Z","caller":"traceutil/trace.go:171","msg":"trace[1188391383] transaction","detail":"{read_only:false; response_revision:165; number_of_response:1; }","duration":"137.164179ms","start":"2026-04-08T05:32:19.628302Z","end":"2026-04-08T05:32:19.765466Z","steps":["trace[1188391383] 'process raft request' (duration: 96.40232ms)","trace[1188391383] 'compare' (duration: 39.545581ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:20.086206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.035013ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:20.086337Z","caller":"traceutil/trace.go:171","msg":"trace[1882259465] linearizableReadLoop","detail":"{readStateIndex:173; appliedIndex:172; }","duration":"126.643392ms","start":"2026-04-08T05:32:19.959671Z","end":"2026-04-08T05:32:20.086314Z","steps":["trace[1882259465] 'read index received' (duration: 55.75µs)","trace[1882259465] 'applied index is now lower than readState.Index' (duration: 126.585362ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:20.086385Z","caller":"traceutil/trace.go:171","msg":"trace[1554324918] transaction","detail":"{read_only:false; response_revision:168; number_of_response:1; }","duration":"263.748811ms","start":"2026-04-08T05:32:19.82261Z","end":"2026-04-08T05:32:20.086359Z","steps":["trace[1554324918] 'process raft request' (duration: 71.464557ms)","trace[1554324918] 'compare' (duration: 191.858272ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:20.086642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.799054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:20.086701Z","caller":"traceutil/trace.go:171","msg":"trace[555918051] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:168; }","duration":"127.074885ms","start":"2026-04-08T05:32:19.959608Z","end":"2026-04-08T05:32:20.086683Z","steps":["trace[555918051] 'agreement among raft nodes before linearized reading' (duration: 126.769473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:20.412491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.652678ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:20.412832Z","caller":"traceutil/trace.go:171","msg":"trace[536125442] transaction","detail":"{read_only:false; response_revision:171; number_of_response:1; }","duration":"229.613738ms","start":"2026-04-08T05:32:20.183187Z","end":"2026-04-08T05:32:20.412801Z","steps":["trace[536125442] 'process raft request' (duration: 37.582448ms)","trace[536125442] 'compare' (duration: 191.541416ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:20.585401Z","caller":"traceutil/trace.go:171","msg":"trace[988343206] linearizableReadLoop","detail":"{readStateIndex:177; appliedIndex:176; }","duration":"125.950737ms","start":"2026-04-08T05:32:20.459416Z","end":"2026-04-08T05:32:20.585366Z","steps":["trace[988343206] 'read index received' (duration: 85.089109ms)","trace[988343206] 'applied index is now lower than readState.Index' (duration: 40.860588ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:20.58551Z","caller":"traceutil/trace.go:171","msg":"trace[724411749] transaction","detail":"{read_only:false; response_revision:172; number_of_response:1; }","duration":"167.326278ms","start":"2026-04-08T05:32:20.418138Z","end":"2026-04-08T05:32:20.585464Z","steps":["trace[724411749] 'process raft request' (duration: 126.358019ms)","trace[724411749] 'compare' (duration: 40.710387ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:20.585594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.146318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:20.585654Z","caller":"traceutil/trace.go:171","msg":"trace[1371745224] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:172; }","duration":"126.266829ms","start":"2026-04-08T05:32:20.459376Z","end":"2026-04-08T05:32:20.585643Z","steps":["trace[1371745224] 'agreement among raft nodes before linearized reading' (duration: 126.107928ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:20.951606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.228099ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:20.951753Z","caller":"traceutil/trace.go:171","msg":"trace[230676679] transaction","detail":"{read_only:false; response_revision:176; number_of_response:1; }","duration":"277.259059ms","start":"2026-04-08T05:32:20.674478Z","end":"2026-04-08T05:32:20.951737Z","steps":["trace[230676679] 'process raft request' (duration: 40.845039ms)","trace[230676679] 'compare' (duration: 236.099698ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:21.131483Z","caller":"traceutil/trace.go:171","msg":"trace[1206894639] transaction","detail":"{read_only:false; response_revision:178; number_of_response:1; }","duration":"115.837522ms","start":"2026-04-08T05:32:21.015552Z","end":"2026-04-08T05:32:21.13139Z","steps":["trace[1206894639] 'process raft request' (duration: 96.876267ms)","trace[1206894639] 'compare' (duration: 18.646533ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:21.441655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.226553ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:21.441853Z","caller":"traceutil/trace.go:171","msg":"trace[112110789] transaction","detail":"{read_only:false; response_revision:184; number_of_response:1; }","duration":"242.543111ms","start":"2026-04-08T05:32:21.199289Z","end":"2026-04-08T05:32:21.441832Z","steps":["trace[112110789] 'process raft request' (duration: 47.055006ms)","trace[112110789] 'compare' (duration: 195.062182ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:22.181812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.568313ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:22.181964Z","caller":"traceutil/trace.go:171","msg":"trace[784808820] linearizableReadLoop","detail":"{readStateIndex:210; appliedIndex:209; }","duration":"121.736183ms","start":"2026-04-08T05:32:22.060181Z","end":"2026-04-08T05:32:22.181917Z","steps":["trace[784808820] 'read index received' (duration: 4.676407ms)","trace[784808820] 'applied index is now lower than readState.Index' (duration: 117.058256ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:22.182025Z","caller":"traceutil/trace.go:171","msg":"trace[212437281] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"209.738637ms","start":"2026-04-08T05:32:21.972202Z","end":"2026-04-08T05:32:22.181941Z","steps":["trace[212437281] 'process raft request' (duration: 92.725461ms)","trace[212437281] 'compare' (duration: 116.374122ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:22.182093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.912005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:22.182244Z","caller":"traceutil/trace.go:171","msg":"trace[1176893798] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:205; }","duration":"122.109516ms","start":"2026-04-08T05:32:22.060112Z","end":"2026-04-08T05:32:22.182222Z","steps":["trace[1176893798] 'agreement among raft nodes before linearized reading' (duration: 121.902535ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:22.413925Z","caller":"traceutil/trace.go:171","msg":"trace[2025330758] linearizableReadLoop","detail":"{readStateIndex:211; appliedIndex:210; }","duration":"176.761976ms","start":"2026-04-08T05:32:22.237135Z","end":"2026-04-08T05:32:22.413897Z","steps":["trace[2025330758] 'read index received' (duration: 133.442935ms)","trace[2025330758] 'applied index is now lower than readState.Index' (duration: 43.317701ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:22.414116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.958957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:22.414089Z","caller":"traceutil/trace.go:171","msg":"trace[1442114861] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"225.176768ms","start":"2026-04-08T05:32:22.188823Z","end":"2026-04-08T05:32:22.414Z","steps":["trace[1442114861] 'process raft request' (duration: 181.749496ms)","trace[1442114861] 'compare' (duration: 43.14297ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:22.414393Z","caller":"traceutil/trace.go:171","msg":"trace[781345019] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:206; }","duration":"177.117658ms","start":"2026-04-08T05:32:22.237082Z","end":"2026-04-08T05:32:22.414199Z","steps":["trace[781345019] 'agreement among raft nodes before linearized reading' (duration: 176.923427ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:22.572803Z","caller":"traceutil/trace.go:171","msg":"trace[1918404246] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"153.280815ms","start":"2026-04-08T05:32:22.419491Z","end":"2026-04-08T05:32:22.572772Z","steps":["trace[1918404246] 'process raft request' (duration: 103.040872ms)","trace[1918404246] 'compare' (duration: 50.014272ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:22.728078Z","caller":"traceutil/trace.go:171","msg":"trace[1663986830] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"150.025914ms","start":"2026-04-08T05:32:22.578029Z","end":"2026-04-08T05:32:22.728055Z","steps":["trace[1663986830] 'process raft request' (duration: 99.332339ms)","trace[1663986830] 'compare' (duration: 50.409854ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:23.093755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.080362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3974"} {"level":"info","ts":"2026-04-08T05:32:23.093838Z","caller":"traceutil/trace.go:171","msg":"trace[1214289802] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:217; }","duration":"115.233902ms","start":"2026-04-08T05:32:22.978585Z","end":"2026-04-08T05:32:23.093818Z","steps":["trace[1214289802] 'range keys from in-memory index tree' (duration: 114.948441ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:23.093797Z","caller":"traceutil/trace.go:171","msg":"trace[326331026] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"113.987905ms","start":"2026-04-08T05:32:22.979785Z","end":"2026-04-08T05:32:23.093773Z","steps":["trace[326331026] 'process raft request' (duration: 32.699147ms)","trace[326331026] 'compare' (duration: 81.185698ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:23.103254Z","caller":"traceutil/trace.go:171","msg":"trace[1870819115] transaction","detail":"{read_only:false; response_revision:219; number_of_response:1; }","duration":"123.407101ms","start":"2026-04-08T05:32:22.979824Z","end":"2026-04-08T05:32:23.103232Z","steps":["trace[1870819115] 'process raft request' (duration: 123.305601ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:23.378418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.450139ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:23.378534Z","caller":"traceutil/trace.go:171","msg":"trace[1628670153] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"194.662078ms","start":"2026-04-08T05:32:23.183848Z","end":"2026-04-08T05:32:23.37851Z","steps":["trace[1628670153] 'process raft request' (duration: 18.023508ms)","trace[1628670153] 'compare' (duration: 176.267828ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:23.388641Z","caller":"traceutil/trace.go:171","msg":"trace[1776768091] transaction","detail":"{read_only:false; response_revision:223; number_of_response:1; }","duration":"204.234097ms","start":"2026-04-08T05:32:23.184388Z","end":"2026-04-08T05:32:23.388622Z","steps":["trace[1776768091] 'process raft request' (duration: 204.063486ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:23.586253Z","caller":"traceutil/trace.go:171","msg":"trace[2125364514] linearizableReadLoop","detail":"{readStateIndex:231; appliedIndex:230; }","duration":"159.059505ms","start":"2026-04-08T05:32:23.42717Z","end":"2026-04-08T05:32:23.586229Z","steps":["trace[2125364514] 'read index received' (duration: 77.647646ms)","trace[2125364514] 'applied index is now lower than readState.Index' (duration: 81.410369ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:23.586421Z","caller":"traceutil/trace.go:171","msg":"trace[528188886] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"172.493766ms","start":"2026-04-08T05:32:23.413858Z","end":"2026-04-08T05:32:23.586352Z","steps":["trace[528188886] 'process raft request' (duration: 91.042756ms)","trace[528188886] 'compare' (duration: 81.214128ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:23.586439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.254337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:replicaset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:23.586682Z","caller":"traceutil/trace.go:171","msg":"trace[734967134] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:replicaset-controller; range_end:; response_count:0; response_revision:226; }","duration":"159.546288ms","start":"2026-04-08T05:32:23.427118Z","end":"2026-04-08T05:32:23.586664Z","steps":["trace[734967134] 'agreement among raft nodes before linearized reading' (duration: 159.242126ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:23.791982Z","caller":"traceutil/trace.go:171","msg":"trace[934658778] transaction","detail":"{read_only:false; response_revision:231; number_of_response:1; }","duration":"104.517568ms","start":"2026-04-08T05:32:23.687436Z","end":"2026-04-08T05:32:23.791954Z","steps":["trace[934658778] 'process raft request' (duration: 74.464867ms)","trace[934658778] 'compare' (duration: 29.735569ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:23.978635Z","caller":"traceutil/trace.go:171","msg":"trace[1279901314] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"137.506847ms","start":"2026-04-08T05:32:23.841004Z","end":"2026-04-08T05:32:23.978511Z","steps":["trace[1279901314] 'process raft request' (duration: 78.586972ms)","trace[1279901314] 'compare' (duration: 58.706312ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:24.122358Z","caller":"traceutil/trace.go:171","msg":"trace[815081836] transaction","detail":"{read_only:false; response_revision:235; number_of_response:1; }","duration":"128.462529ms","start":"2026-04-08T05:32:23.993866Z","end":"2026-04-08T05:32:24.122328Z","steps":["trace[815081836] 'process raft request' (duration: 86.467498ms)","trace[815081836] 'compare' (duration: 41.87346ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:24.56793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.508141ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:24.568039Z","caller":"traceutil/trace.go:171","msg":"trace[1802944997] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"204.553783ms","start":"2026-04-08T05:32:24.363463Z","end":"2026-04-08T05:32:24.568017Z","steps":["trace[1802944997] 'process raft request' (duration: 46.881051ms)","trace[1802944997] 'compare' (duration: 157.391961ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:24.818477Z","caller":"traceutil/trace.go:171","msg":"trace[768042515] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"109.627195ms","start":"2026-04-08T05:32:24.708825Z","end":"2026-04-08T05:32:24.818452Z","steps":["trace[768042515] 'process raft request' (duration: 109.438734ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:25.002431Z","caller":"traceutil/trace.go:171","msg":"trace[1892889614] linearizableReadLoop","detail":"{readStateIndex:255; appliedIndex:254; }","duration":"178.650919ms","start":"2026-04-08T05:32:24.823755Z","end":"2026-04-08T05:32:25.002406Z","steps":["trace[1892889614] 'read index received' (duration: 118.245217ms)","trace[1892889614] 'applied index is now lower than readState.Index' (duration: 60.404542ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:25.002466Z","caller":"traceutil/trace.go:171","msg":"trace[218420207] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"256.406744ms","start":"2026-04-08T05:32:24.746038Z","end":"2026-04-08T05:32:25.002444Z","steps":["trace[218420207] 'process raft request' (duration: 195.897291ms)","trace[218420207] 'compare' (duration: 60.348842ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:25.002614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.649314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:25.00266Z","caller":"traceutil/trace.go:171","msg":"trace[1941860656] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:250; }","duration":"142.726804ms","start":"2026-04-08T05:32:24.859918Z","end":"2026-04-08T05:32:25.002645Z","steps":["trace[1941860656] 'agreement among raft nodes before linearized reading' (duration: 142.628333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:25.002833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.054361ms","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-08T05:32:25.00294Z","caller":"traceutil/trace.go:171","msg":"trace[1727503221] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:250; }","duration":"179.134471ms","start":"2026-04-08T05:32:24.82375Z","end":"2026-04-08T05:32:25.002885Z","steps":["trace[1727503221] 'agreement among raft nodes before linearized reading' (duration: 178.779549ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:25.178853Z","caller":"traceutil/trace.go:171","msg":"trace[1365782034] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"107.370729ms","start":"2026-04-08T05:32:25.071446Z","end":"2026-04-08T05:32:25.178817Z","steps":["trace[1365782034] 'process raft request' (duration: 60.785722ms)","trace[1365782034] 'compare' (duration: 46.310366ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:25.580836Z","caller":"traceutil/trace.go:171","msg":"trace[40289954] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"118.788567ms","start":"2026-04-08T05:32:25.462007Z","end":"2026-04-08T05:32:25.580795Z","steps":["trace[40289954] 'process raft request' (duration: 39.605126ms)","trace[40289954] 'compare' (duration: 78.823879ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:25.797019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.875107ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:25.797317Z","caller":"traceutil/trace.go:171","msg":"trace[963623543] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"167.000204ms","start":"2026-04-08T05:32:25.630293Z","end":"2026-04-08T05:32:25.797294Z","steps":["trace[963623543] 'process raft request' (duration: 166.941114ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:25.7974Z","caller":"traceutil/trace.go:171","msg":"trace[37376175] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"168.566024ms","start":"2026-04-08T05:32:25.628771Z","end":"2026-04-08T05:32:25.797337Z","steps":["trace[37376175] 'process raft request' (duration: 168.373502ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:25.797874Z","caller":"traceutil/trace.go:171","msg":"trace[1691877963] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"170.488735ms","start":"2026-04-08T05:32:25.627355Z","end":"2026-04-08T05:32:25.797844Z","steps":["trace[1691877963] 'process raft request' (duration: 62.665903ms)","trace[1691877963] 'compare' (duration: 106.750766ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:25.804191Z","caller":"traceutil/trace.go:171","msg":"trace[1746935899] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"110.89734ms","start":"2026-04-08T05:32:25.693281Z","end":"2026-04-08T05:32:25.804178Z","steps":["trace[1746935899] 'process raft request' (duration: 110.714999ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:25.965678Z","caller":"traceutil/trace.go:171","msg":"trace[1030319394] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"113.947928ms","start":"2026-04-08T05:32:25.851703Z","end":"2026-04-08T05:32:25.965651Z","steps":["trace[1030319394] 'process raft request' (duration: 113.897168ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:25.965715Z","caller":"traceutil/trace.go:171","msg":"trace[1201556001] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"114.075269ms","start":"2026-04-08T05:32:25.851602Z","end":"2026-04-08T05:32:25.965677Z","steps":["trace[1201556001] 'process raft request' (duration: 72.070799ms)","trace[1201556001] 'compare' (duration: 41.749779ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:26.493381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.251363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:26.493449Z","caller":"traceutil/trace.go:171","msg":"trace[896928821] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:0; response_revision:284; }","duration":"105.366884ms","start":"2026-04-08T05:32:26.388066Z","end":"2026-04-08T05:32:26.493433Z","steps":["trace[896928821] 'range keys from in-memory index tree' (duration: 105.108212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:26.75873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.743138ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:26.758917Z","caller":"traceutil/trace.go:171","msg":"trace[1374165711] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"206.908016ms","start":"2026-04-08T05:32:26.551992Z","end":"2026-04-08T05:32:26.7589Z","steps":["trace[1374165711] 'process raft request' (duration: 206.841176ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:26.758957Z","caller":"traceutil/trace.go:171","msg":"trace[989229006] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"208.143564ms","start":"2026-04-08T05:32:26.550782Z","end":"2026-04-08T05:32:26.758925Z","steps":["trace[989229006] 'process raft request' (duration: 90.110074ms)","trace[989229006] 'compare' (duration: 117.596837ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:27.089945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.727923ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:27.090374Z","caller":"traceutil/trace.go:171","msg":"trace[944795101] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"323.733817ms","start":"2026-04-08T05:32:26.766597Z","end":"2026-04-08T05:32:27.09033Z","steps":["trace[944795101] 'process raft request' (duration: 155.517381ms)","trace[944795101] 'compare' (duration: 167.480482ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:27.090467Z","caller":"traceutil/trace.go:171","msg":"trace[1818078270] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"320.465408ms","start":"2026-04-08T05:32:26.769932Z","end":"2026-04-08T05:32:27.090397Z","steps":["trace[1818078270] 'process raft request' (duration: 320.217286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:27.090542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:26.766581Z","time spent":"323.874248ms","remote":"127.0.0.1:37990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":525,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:32:27.090633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:26.7699Z","time spent":"320.664858ms","remote":"127.0.0.1:38100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":217,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:32:27.413817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.094217ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:27.413938Z","caller":"traceutil/trace.go:171","msg":"trace[1930222562] linearizableReadLoop","detail":"{readStateIndex:297; appliedIndex:296; }","duration":"283.010911ms","start":"2026-04-08T05:32:27.130908Z","end":"2026-04-08T05:32:27.413919Z","steps":["trace[1930222562] 'read index received' (duration: 115.612563ms)","trace[1930222562] 'applied index is now lower than readState.Index' (duration: 167.396158ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:27.414004Z","caller":"traceutil/trace.go:171","msg":"trace[546746288] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"315.689225ms","start":"2026-04-08T05:32:27.098285Z","end":"2026-04-08T05:32:27.413975Z","steps":["trace[546746288] 'process raft request' (duration: 148.357476ms)","trace[546746288] 'compare' (duration: 166.914766ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:27.414158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:27.098267Z","time spent":"315.823875ms","remote":"127.0.0.1:37990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11440,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:32:27.414253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.329253ms","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-08T05:32:27.414297Z","caller":"traceutil/trace.go:171","msg":"trace[839612279] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:291; }","duration":"283.378123ms","start":"2026-04-08T05:32:27.130903Z","end":"2026-04-08T05:32:27.414281Z","steps":["trace[839612279] 'agreement among raft nodes before linearized reading' (duration: 283.183312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:27.41439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.789138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:27.414549Z","caller":"traceutil/trace.go:171","msg":"trace[183355944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:291; }","duration":"132.03042ms","start":"2026-04-08T05:32:27.282494Z","end":"2026-04-08T05:32:27.414525Z","steps":["trace[183355944] 'agreement among raft nodes before linearized reading' (duration: 131.737088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:27.7077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.165224ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:27.707889Z","caller":"traceutil/trace.go:171","msg":"trace[376502547] linearizableReadLoop","detail":"{readStateIndex:299; appliedIndex:297; }","duration":"284.061468ms","start":"2026-04-08T05:32:27.423811Z","end":"2026-04-08T05:32:27.707873Z","steps":["trace[376502547] 'read index received' (duration: 30.252049ms)","trace[376502547] 'applied index is now lower than readState.Index' (duration: 253.808539ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:27.70799Z","caller":"traceutil/trace.go:171","msg":"trace[10808554] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"282.952551ms","start":"2026-04-08T05:32:27.425027Z","end":"2026-04-08T05:32:27.70798Z","steps":["trace[10808554] 'process raft request' (duration: 282.77988ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:27.707991Z","caller":"traceutil/trace.go:171","msg":"trace[125219519] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"288.441233ms","start":"2026-04-08T05:32:27.41948Z","end":"2026-04-08T05:32:27.707922Z","steps":["trace[125219519] 'process raft request' (duration: 180.988118ms)","trace[125219519] 'compare' (duration: 107.000383ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:27.708165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.34257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:27.708202Z","caller":"traceutil/trace.go:171","msg":"trace[376086858] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:294; }","duration":"284.40669ms","start":"2026-04-08T05:32:27.423785Z","end":"2026-04-08T05:32:27.708191Z","steps":["trace[376086858] 'agreement among raft nodes before linearized reading' (duration: 284.344709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:27.708319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.56416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-04-08T05:32:27.708419Z","caller":"traceutil/trace.go:171","msg":"trace[1062303517] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:294; }","duration":"250.692371ms","start":"2026-04-08T05:32:27.457707Z","end":"2026-04-08T05:32:27.7084Z","steps":["trace[1062303517] 'agreement among raft nodes before linearized reading' (duration: 250.294849ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:27.854491Z","caller":"traceutil/trace.go:171","msg":"trace[1741481141] linearizableReadLoop","detail":"{readStateIndex:302; appliedIndex:301; }","duration":"138.357366ms","start":"2026-04-08T05:32:27.716107Z","end":"2026-04-08T05:32:27.854464Z","steps":["trace[1741481141] 'read index received' (duration: 82.551216ms)","trace[1741481141] 'applied index is now lower than readState.Index' (duration: 55.80471ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:27.854728Z","caller":"traceutil/trace.go:171","msg":"trace[1762212930] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"139.945136ms","start":"2026-04-08T05:32:27.71475Z","end":"2026-04-08T05:32:27.854695Z","steps":["trace[1762212930] 'process raft request' (duration: 124.853267ms)","trace[1762212930] 'compare' (duration: 14.169734ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:27.854935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.789568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-04-08T05:32:27.855039Z","caller":"traceutil/trace.go:171","msg":"trace[236316222] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:297; }","duration":"138.931399ms","start":"2026-04-08T05:32:27.716086Z","end":"2026-04-08T05:32:27.855017Z","steps":["trace[236316222] 'agreement among raft nodes before linearized reading' (duration: 138.636007ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:27.855175Z","caller":"traceutil/trace.go:171","msg":"trace[2011923921] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"133.620798ms","start":"2026-04-08T05:32:27.721521Z","end":"2026-04-08T05:32:27.855142Z","steps":["trace[2011923921] 'process raft request' (duration: 132.853193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:28.999289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.512904ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:28.999479Z","caller":"traceutil/trace.go:171","msg":"trace[1753655304] linearizableReadLoop","detail":"{readStateIndex:314; appliedIndex:313; }","duration":"588.915074ms","start":"2026-04-08T05:32:28.410549Z","end":"2026-04-08T05:32:28.999464Z","steps":["trace[1753655304] 'read index received' (duration: 241.178379ms)","trace[1753655304] 'applied index is now lower than readState.Index' (duration: 347.733965ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:28.99958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.023814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:28.999625Z","caller":"traceutil/trace.go:171","msg":"trace[791035240] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:0; response_revision:308; }","duration":"589.099115ms","start":"2026-04-08T05:32:28.410517Z","end":"2026-04-08T05:32:28.999617Z","steps":["trace[791035240] 'agreement among raft nodes before linearized reading' (duration: 589.006594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:28.999681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:28.410506Z","time spent":"589.153485ms","remote":"127.0.0.1:38100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" "} {"level":"info","ts":"2026-04-08T05:32:28.999852Z","caller":"traceutil/trace.go:171","msg":"trace[2002700424] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"590.723995ms","start":"2026-04-08T05:32:28.409118Z","end":"2026-04-08T05:32:28.999842Z","steps":["trace[2002700424] 'process raft request' (duration: 242.608398ms)","trace[2002700424] 'compare' (duration: 347.284352ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:28.999923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:28.409094Z","time spent":"590.809005ms","remote":"127.0.0.1:37990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":677,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:32:31.143176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.523879865s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:31.143394Z","caller":"traceutil/trace.go:171","msg":"trace[1939783919] linearizableReadLoop","detail":"{readStateIndex:316; appliedIndex:314; }","duration":"2.0109197s","start":"2026-04-08T05:32:29.132457Z","end":"2026-04-08T05:32:31.143377Z","steps":["trace[1939783919] 'read index received' (duration: 486.912363ms)","trace[1939783919] 'applied index is now lower than readState.Index' (duration: 1.524006467s)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:31.143486Z","caller":"traceutil/trace.go:171","msg":"trace[1759076340] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"2.137556316s","start":"2026-04-08T05:32:29.005919Z","end":"2026-04-08T05:32:31.143475Z","steps":["trace[1759076340] 'process raft request' (duration: 2.137375757s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:31.143546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:29.005894Z","time spent":"2.137624298s","remote":"127.0.0.1:38100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":209,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:32:31.14358Z","caller":"traceutil/trace.go:171","msg":"trace[155927947] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"2.138903396s","start":"2026-04-08T05:32:29.004634Z","end":"2026-04-08T05:32:31.143538Z","steps":["trace[155927947] 'process raft request' (duration: 614.59984ms)","trace[155927947] 'compare' (duration: 1.523480916s)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:31.143716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.874641274s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T05:32:31.143762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.011297298s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-04-08T05:32:31.143782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:29.004614Z","time spent":"2.139077953s","remote":"127.0.0.1:38274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":290,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:32:31.143813Z","caller":"traceutil/trace.go:171","msg":"trace[151380886] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:310; }","duration":"2.011354801s","start":"2026-04-08T05:32:29.132446Z","end":"2026-04-08T05:32:31.1438Z","steps":["trace[151380886] 'agreement among raft nodes before linearized reading' (duration: 2.01114071s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:31.143814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.215961471s","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-08T05:32:31.143858Z","caller":"traceutil/trace.go:171","msg":"trace[1168906090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:310; }","duration":"1.216013933s","start":"2026-04-08T05:32:29.927832Z","end":"2026-04-08T05:32:31.143846Z","steps":["trace[1168906090] 'agreement among raft nodes before linearized reading' (duration: 1.215930809s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:31.143877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.283219658s","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-08T05:32:31.143902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:29.927749Z","time spent":"1.216146036s","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-08T05:32:31.143916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.919705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"} {"level":"info","ts":"2026-04-08T05:32:31.143943Z","caller":"traceutil/trace.go:171","msg":"trace[1591791271] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:310; }","duration":"191.995906ms","start":"2026-04-08T05:32:30.951939Z","end":"2026-04-08T05:32:31.143935Z","steps":["trace[1591791271] 'agreement among raft nodes before linearized reading' (duration: 191.946274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:31.143938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.518233437s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:31.143905Z","caller":"traceutil/trace.go:171","msg":"trace[882721206] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:310; }","duration":"1.283283999s","start":"2026-04-08T05:32:29.860612Z","end":"2026-04-08T05:32:31.143896Z","steps":["trace[882721206] 'agreement among raft nodes before linearized reading' (duration: 1.283225857s)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:31.144011Z","caller":"traceutil/trace.go:171","msg":"trace[540038283] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:310; }","duration":"1.518308701s","start":"2026-04-08T05:32:29.625694Z","end":"2026-04-08T05:32:31.144003Z","steps":["trace[540038283] 'agreement among raft nodes before linearized reading' (duration: 1.518227277s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:31.144072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:29.860552Z","time spent":"1.283497287s","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-08T05:32:31.143858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:29.132339Z","time spent":"2.011509943s","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-08T05:32:31.143811Z","caller":"traceutil/trace.go:171","msg":"trace[205660998] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:310; }","duration":"1.8747967s","start":"2026-04-08T05:32:29.268991Z","end":"2026-04-08T05:32:31.143788Z","steps":["trace[205660998] 'agreement among raft nodes before linearized reading' (duration: 1.874602251s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:31.144443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:29.268959Z","time spent":"1.87541736s","remote":"127.0.0.1:37916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-08T05:32:33.152492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000234029s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-08T05:32:33.152574Z","caller":"traceutil/trace.go:171","msg":"trace[811619580] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000353115s","start":"2026-04-08T05:32:31.152204Z","end":"2026-04-08T05:32:33.152557Z","steps":["trace[811619580] 'agreement among raft nodes before linearized reading' (duration: 2.00024896s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:33.152621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:31.152196Z","time spent":"2.000415577s","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-08T05:32:33.265339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.10312019s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:33.265462Z","caller":"traceutil/trace.go:171","msg":"trace[689814153] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:310; }","duration":"1.103251906s","start":"2026-04-08T05:32:32.16219Z","end":"2026-04-08T05:32:33.265442Z","steps":["trace[689814153] 'range keys from in-memory index tree' (duration: 1.10310706s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:33.265677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.476118277s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:33.265776Z","caller":"traceutil/trace.go:171","msg":"trace[1535003000] linearizableReadLoop","detail":"{readStateIndex:317; appliedIndex:316; }","duration":"2.115987106s","start":"2026-04-08T05:32:31.14977Z","end":"2026-04-08T05:32:33.265757Z","steps":["trace[1535003000] 'read index received' (duration: 92.314µs)","trace[1535003000] 'applied index is now lower than readState.Index' (duration: 2.115893462s)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:33.265865Z","caller":"traceutil/trace.go:171","msg":"trace[1936145338] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"2.116096822s","start":"2026-04-08T05:32:31.14975Z","end":"2026-04-08T05:32:33.265847Z","steps":["trace[1936145338] 'process raft request' (duration: 639.762505ms)","trace[1936145338] 'compare' (duration: 1.475650294s)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:33.265924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:31.149731Z","time spent":"2.116168195s","remote":"127.0.0.1:38290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":454,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:32:33.266393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.116573054s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:33.266589Z","caller":"traceutil/trace.go:171","msg":"trace[64920657] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:0; response_revision:311; }","duration":"2.116802385s","start":"2026-04-08T05:32:31.149739Z","end":"2026-04-08T05:32:33.266542Z","steps":["trace[64920657] 'agreement among raft nodes before linearized reading' (duration: 2.116319213s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:33.266705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:31.149725Z","time spent":"2.116959672s","remote":"127.0.0.1:38100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-04-08T05:32:33.766122Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15342811115908599258,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-08T05:32:33.827258Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.0377497s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-08T05:32:34.152411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.91616ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:34.152784Z","caller":"traceutil/trace.go:171","msg":"trace[1129838659] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"3.002516827s","start":"2026-04-08T05:32:31.150187Z","end":"2026-04-08T05:32:34.152703Z","steps":["trace[1129838659] 'process raft request' (duration: 2.67723467s)","trace[1129838659] 'compare' (duration: 324.738062ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:34.15288Z","caller":"traceutil/trace.go:171","msg":"trace[1197229805] linearizableReadLoop","detail":"{readStateIndex:323; appliedIndex:317; }","duration":"887.051067ms","start":"2026-04-08T05:32:33.265811Z","end":"2026-04-08T05:32:34.152862Z","steps":["trace[1197229805] 'read index received' (duration: 561.616442ms)","trace[1197229805] 'applied index is now lower than readState.Index' (duration: 325.433755ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:34.152928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:31.150179Z","time spent":"3.002673344s","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:32:34.152973Z","caller":"traceutil/trace.go:171","msg":"trace[741730188] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"3.00236108s","start":"2026-04-08T05:32:31.150602Z","end":"2026-04-08T05:32:34.152963Z","steps":["trace[741730188] 'process raft request' (duration: 3.002006303s)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:34.153009Z","caller":"traceutil/trace.go:171","msg":"trace[503006654] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"883.028276ms","start":"2026-04-08T05:32:33.269959Z","end":"2026-04-08T05:32:34.152988Z","steps":["trace[503006654] 'process raft request' (duration: 882.848557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:34.153037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:31.150594Z","time spent":"3.002404731s","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:32:34.153103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:33.269931Z","time spent":"883.126091ms","remote":"127.0.0.1:38290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:32:34.153185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.388912224s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T05:32:34.153227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"999.666912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:32:34.15327Z","caller":"traceutil/trace.go:171","msg":"trace[581608920] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:317; }","duration":"999.766006ms","start":"2026-04-08T05:32:33.153489Z","end":"2026-04-08T05:32:34.153255Z","steps":["trace[581608920] 'agreement among raft nodes before linearized reading' (duration: 999.709194ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:34.153272Z","caller":"traceutil/trace.go:171","msg":"trace[749449588] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:317; }","duration":"2.389044559s","start":"2026-04-08T05:32:31.764209Z","end":"2026-04-08T05:32:34.153254Z","steps":["trace[749449588] 'agreement among raft nodes before linearized reading' (duration: 2.388891822s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:34.153288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.463916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"warn","ts":"2026-04-08T05:32:34.153304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:33.153465Z","time spent":"999.833029ms","remote":"127.0.0.1:37916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-08T05:32:34.153319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:31.764191Z","time spent":"2.389119753s","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-08T05:32:34.153323Z","caller":"traceutil/trace.go:171","msg":"trace[1864872682] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:317; }","duration":"883.52748ms","start":"2026-04-08T05:32:33.269783Z","end":"2026-04-08T05:32:34.153311Z","steps":["trace[1864872682] 'agreement among raft nodes before linearized reading' (duration: 883.464987ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:34.153429Z","caller":"traceutil/trace.go:171","msg":"trace[880484357] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"2.999775463s","start":"2026-04-08T05:32:31.153638Z","end":"2026-04-08T05:32:34.153413Z","steps":["trace[880484357] 'process raft request' (duration: 2.999018996s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:34.153445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:33.269767Z","time spent":"883.653616ms","remote":"127.0.0.1:38006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-08T05:32:34.153517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:31.15363Z","time spent":"2.999840136s","remote":"127.0.0.1:38086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4307,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:32:34.153601Z","caller":"traceutil/trace.go:171","msg":"trace[1498949991] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"2.382271388s","start":"2026-04-08T05:32:31.771319Z","end":"2026-04-08T05:32:34.15359Z","steps":["trace[1498949991] 'process raft request' (duration: 2.381389086s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:34.153691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:31.771291Z","time spent":"2.382345611s","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:32:34.154478Z","caller":"traceutil/trace.go:171","msg":"trace[1331524733] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"3.004166805s","start":"2026-04-08T05:32:31.150264Z","end":"2026-04-08T05:32:34.154431Z","steps":["trace[1331524733] 'process raft request' (duration: 3.002241324s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:34.154589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:31.150259Z","time spent":"3.00427246s","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:32:35.11541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.802642ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:35.115814Z","caller":"traceutil/trace.go:171","msg":"trace[540065333] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"861.530653ms","start":"2026-04-08T05:32:34.254265Z","end":"2026-04-08T05:32:35.115796Z","steps":["trace[540065333] 'process raft request' (duration: 861.46203ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:35.115838Z","caller":"traceutil/trace.go:171","msg":"trace[1742883821] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"862.71143ms","start":"2026-04-08T05:32:34.253078Z","end":"2026-04-08T05:32:35.115789Z","steps":["trace[1742883821] 'process raft request' (duration: 96.456747ms)","trace[1742883821] 'compare' (duration: 765.354232ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:35.115894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:34.254239Z","time spent":"861.624488ms","remote":"127.0.0.1:37996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1943,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:32:35.115973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:32:34.253067Z","time spent":"862.849387ms","remote":"127.0.0.1:38100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:32:36.739666Z","caller":"traceutil/trace.go:171","msg":"trace[800561015] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"180.216067ms","start":"2026-04-08T05:32:36.559399Z","end":"2026-04-08T05:32:36.739615Z","steps":["trace[800561015] 'process raft request' (duration: 180.024779ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:36.77424Z","caller":"traceutil/trace.go:171","msg":"trace[1471856373] linearizableReadLoop","detail":"{readStateIndex:427; appliedIndex:425; }","duration":"111.310919ms","start":"2026-04-08T05:32:36.662913Z","end":"2026-04-08T05:32:36.774224Z","steps":["trace[1471856373] 'read index received' (duration: 76.476717ms)","trace[1471856373] 'applied index is now lower than readState.Index' (duration: 34.833132ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:36.774357Z","caller":"traceutil/trace.go:171","msg":"trace[1493270303] transaction","detail":"{read_only:false; number_of_response:0; response_revision:413; }","duration":"179.796448ms","start":"2026-04-08T05:32:36.594547Z","end":"2026-04-08T05:32:36.774344Z","steps":["trace[1493270303] 'process raft request' (duration: 179.62226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:36.774609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.675236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-04-08T05:32:36.774656Z","caller":"traceutil/trace.go:171","msg":"trace[1484301038] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:413; }","duration":"111.785791ms","start":"2026-04-08T05:32:36.662859Z","end":"2026-04-08T05:32:36.774644Z","steps":["trace[1484301038] 'agreement among raft nodes before linearized reading' (duration: 111.665745ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:37.842852Z","caller":"traceutil/trace.go:171","msg":"trace[1166970917] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"204.952711ms","start":"2026-04-08T05:32:37.637874Z","end":"2026-04-08T05:32:37.842826Z","steps":["trace[1166970917] 'process raft request' (duration: 204.318411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:38.5028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.550562ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:38.502947Z","caller":"traceutil/trace.go:171","msg":"trace[367224714] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"233.829542ms","start":"2026-04-08T05:32:38.269097Z","end":"2026-04-08T05:32:38.502927Z","steps":["trace[367224714] 'process raft request' (duration: 94.029339ms)","trace[367224714] 'compare' (duration: 139.399016ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:40.719525Z","caller":"traceutil/trace.go:171","msg":"trace[2014564800] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"108.820464ms","start":"2026-04-08T05:32:40.610682Z","end":"2026-04-08T05:32:40.719502Z","steps":["trace[2014564800] 'process raft request' (duration: 97.994861ms)","trace[2014564800] 'compare' (duration: 10.687207ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:40.820782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.287207ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-08T05:32:42.433129Z","caller":"traceutil/trace.go:171","msg":"trace[309942274] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"130.58418ms","start":"2026-04-08T05:32:42.302521Z","end":"2026-04-08T05:32:42.433105Z","steps":["trace[309942274] 'process raft request' (duration: 62.158867ms)","trace[309942274] 'compare' (duration: 68.321519ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:42.661759Z","caller":"traceutil/trace.go:171","msg":"trace[271820422] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"190.618098ms","start":"2026-04-08T05:32:42.471101Z","end":"2026-04-08T05:32:42.661719Z","steps":["trace[271820422] 'process raft request' (duration: 108.188034ms)","trace[271820422] 'compare' (duration: 82.230585ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:44.550157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.843198ms","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-08T05:32:44.550251Z","caller":"traceutil/trace.go:171","msg":"trace[779631927] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:448; }","duration":"112.997865ms","start":"2026-04-08T05:32:44.437229Z","end":"2026-04-08T05:32:44.550227Z","steps":["trace[779631927] 'range keys from in-memory index tree' (duration: 112.673501ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:44.774923Z","caller":"traceutil/trace.go:171","msg":"trace[131636587] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"214.170207ms","start":"2026-04-08T05:32:44.560717Z","end":"2026-04-08T05:32:44.774887Z","steps":["trace[131636587] 'process raft request' (duration: 213.943567ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:48.801497Z","caller":"traceutil/trace.go:171","msg":"trace[651763206] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"113.232625ms","start":"2026-04-08T05:32:48.688244Z","end":"2026-04-08T05:32:48.801477Z","steps":["trace[651763206] 'process raft request' (duration: 113.09591ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:52.642015Z","caller":"traceutil/trace.go:171","msg":"trace[392259874] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:486; }","duration":"212.541121ms","start":"2026-04-08T05:32:52.429378Z","end":"2026-04-08T05:32:52.641919Z","steps":["trace[392259874] 'read index received' (duration: 211.99602ms)","trace[392259874] 'applied index is now lower than readState.Index' (duration: 542.881µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:52.642331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.929175ms","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-08T05:32:52.642457Z","caller":"traceutil/trace.go:171","msg":"trace[1266396242] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:469; }","duration":"213.126433ms","start":"2026-04-08T05:32:52.429301Z","end":"2026-04-08T05:32:52.642428Z","steps":["trace[1266396242] 'agreement among raft nodes before linearized reading' (duration: 212.871194ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:52.64302Z","caller":"traceutil/trace.go:171","msg":"trace[213150575] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"272.724457ms","start":"2026-04-08T05:32:52.370261Z","end":"2026-04-08T05:32:52.642986Z","steps":["trace[213150575] 'process raft request' (duration: 271.155957ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:52.942113Z","caller":"traceutil/trace.go:171","msg":"trace[139287366] linearizableReadLoop","detail":"{readStateIndex:489; appliedIndex:488; }","duration":"128.472777ms","start":"2026-04-08T05:32:52.813615Z","end":"2026-04-08T05:32:52.942087Z","steps":["trace[139287366] 'read index received' (duration: 128.237539ms)","trace[139287366] 'applied index is now lower than readState.Index' (duration: 233.788µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:52.942219Z","caller":"traceutil/trace.go:171","msg":"trace[1242917524] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"132.987989ms","start":"2026-04-08T05:32:52.809176Z","end":"2026-04-08T05:32:52.942164Z","steps":["trace[1242917524] 'process raft request' (duration: 132.759871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:52.942322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.680736ms","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-08T05:32:52.942373Z","caller":"traceutil/trace.go:171","msg":"trace[687933951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:471; }","duration":"128.76596ms","start":"2026-04-08T05:32:52.813594Z","end":"2026-04-08T05:32:52.94236Z","steps":["trace[687933951] 'agreement among raft nodes before linearized reading' (duration: 128.641025ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:32:53.124719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.838765ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:32:53.124905Z","caller":"traceutil/trace.go:171","msg":"trace[78071637] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:489; }","duration":"175.523372ms","start":"2026-04-08T05:32:52.949366Z","end":"2026-04-08T05:32:53.12489Z","steps":["trace[78071637] 'read index received' (duration: 44.286212ms)","trace[78071637] 'applied index is now lower than readState.Index' (duration: 131.23616ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:32:53.125012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.651736ms","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:5"} {"level":"info","ts":"2026-04-08T05:32:53.125Z","caller":"traceutil/trace.go:171","msg":"trace[1005705296] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"178.651541ms","start":"2026-04-08T05:32:52.94631Z","end":"2026-04-08T05:32:53.124961Z","steps":["trace[1005705296] 'process raft request' (duration: 47.459093ms)","trace[1005705296] 'compare' (duration: 130.646737ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:32:53.12505Z","caller":"traceutil/trace.go:171","msg":"trace[1288517761] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:473; }","duration":"175.739819ms","start":"2026-04-08T05:32:52.949298Z","end":"2026-04-08T05:32:53.125038Z","steps":["trace[1288517761] 'agreement among raft nodes before linearized reading' (duration: 175.655956ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:53.125205Z","caller":"traceutil/trace.go:171","msg":"trace[281323177] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"178.66594ms","start":"2026-04-08T05:32:52.946529Z","end":"2026-04-08T05:32:53.125195Z","steps":["trace[281323177] 'process raft request' (duration: 178.311147ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:32:53.30904Z","caller":"traceutil/trace.go:171","msg":"trace[712582773] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"182.002852ms","start":"2026-04-08T05:32:53.127006Z","end":"2026-04-08T05:32:53.309009Z","steps":["trace[712582773] 'process raft request' (duration: 122.741248ms)","trace[712582773] 'compare' (duration: 59.007975ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:33:05.756922Z","caller":"traceutil/trace.go:171","msg":"trace[1957739985] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"366.75205ms","start":"2026-04-08T05:33:05.39015Z","end":"2026-04-08T05:33:05.756902Z","steps":["trace[1957739985] 'process raft request' (duration: 365.944883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:05.75708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:05.390117Z","time spent":"366.885384ms","remote":"127.0.0.1:37936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:33:05.75724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.53466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:33:05.75731Z","caller":"traceutil/trace.go:171","msg":"trace[781054008] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:564; }","duration":"340.641283ms","start":"2026-04-08T05:33:05.416651Z","end":"2026-04-08T05:33:05.757292Z","steps":["trace[781054008] 'agreement among raft nodes before linearized reading' (duration: 340.489938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:05.757339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:05.416635Z","time spent":"340.697215ms","remote":"127.0.0.1:37990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-04-08T05:33:05.756871Z","caller":"traceutil/trace.go:171","msg":"trace[1144144681] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:586; }","duration":"340.163958ms","start":"2026-04-08T05:33:05.416685Z","end":"2026-04-08T05:33:05.756849Z","steps":["trace[1144144681] 'read index received' (duration: 339.322781ms)","trace[1144144681] 'applied index is now lower than readState.Index' (duration: 840.117µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:33:05.757489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.842685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:33:05.757524Z","caller":"traceutil/trace.go:171","msg":"trace[319429454] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:564; }","duration":"153.909497ms","start":"2026-04-08T05:33:05.603604Z","end":"2026-04-08T05:33:05.757514Z","steps":["trace[319429454] 'agreement among raft nodes before linearized reading' (duration: 153.856046ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:33:06.392994Z","caller":"traceutil/trace.go:171","msg":"trace[901789483] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"439.132046ms","start":"2026-04-08T05:33:05.953839Z","end":"2026-04-08T05:33:06.392971Z","steps":["trace[901789483] 'process raft request' (duration: 438.95464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:06.393143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:05.95382Z","time spent":"439.256249ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:33:06.402033Z","caller":"traceutil/trace.go:171","msg":"trace[1537373546] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"447.029391ms","start":"2026-04-08T05:33:05.954951Z","end":"2026-04-08T05:33:06.401981Z","steps":["trace[1537373546] 'process raft request' (duration: 446.797603ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:33:06.402076Z","caller":"traceutil/trace.go:171","msg":"trace[33050911] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"437.813538ms","start":"2026-04-08T05:33:05.964222Z","end":"2026-04-08T05:33:06.402036Z","steps":["trace[33050911] 'process raft request' (duration: 437.635062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:06.402207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:05.954931Z","time spent":"447.193496ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:33:06.402278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:05.964214Z","time spent":"437.959843ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:33:06.402414Z","caller":"traceutil/trace.go:171","msg":"trace[1618389219] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"432.987599ms","start":"2026-04-08T05:33:05.969404Z","end":"2026-04-08T05:33:06.402391Z","steps":["trace[1618389219] 'process raft request' (duration: 432.646178ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:33:06.402461Z","caller":"traceutil/trace.go:171","msg":"trace[466839325] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"447.087033ms","start":"2026-04-08T05:33:05.955355Z","end":"2026-04-08T05:33:06.402442Z","steps":["trace[466839325] 'process raft request' (duration: 446.465853ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:06.402518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:05.969397Z","time spent":"433.073053ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:33:06.402535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:05.955348Z","time spent":"447.154805ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:33:06.402606Z","caller":"traceutil/trace.go:171","msg":"trace[158441510] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"287.92418ms","start":"2026-04-08T05:33:06.114663Z","end":"2026-04-08T05:33:06.402587Z","steps":["trace[158441510] 'process raft request' (duration: 287.817577ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:33:06.402653Z","caller":"traceutil/trace.go:171","msg":"trace[279567406] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"438.221891ms","start":"2026-04-08T05:33:05.964415Z","end":"2026-04-08T05:33:06.402636Z","steps":["trace[279567406] 'process raft request' (duration: 437.527389ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:33:06.402714Z","caller":"traceutil/trace.go:171","msg":"trace[324488950] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"404.161194ms","start":"2026-04-08T05:33:05.998547Z","end":"2026-04-08T05:33:06.402708Z","steps":["trace[324488950] 'process raft request' (duration: 403.536844ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:06.402726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:05.964389Z","time spent":"438.302034ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:33:06.402777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:05.998471Z","time spent":"404.263748ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:33:06.402785Z","caller":"traceutil/trace.go:171","msg":"trace[693258809] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"436.096411ms","start":"2026-04-08T05:33:05.96667Z","end":"2026-04-08T05:33:06.402766Z","steps":["trace[693258809] 'process raft request' (duration: 435.314396ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:33:06.40285Z","caller":"traceutil/trace.go:171","msg":"trace[931426701] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"436.112391ms","start":"2026-04-08T05:33:05.966721Z","end":"2026-04-08T05:33:06.402834Z","steps":["trace[931426701] 'process raft request' (duration: 435.296605ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:33:06.402871Z","caller":"traceutil/trace.go:171","msg":"trace[51554160] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"404.389751ms","start":"2026-04-08T05:33:05.998474Z","end":"2026-04-08T05:33:06.402864Z","steps":["trace[51554160] 'process raft request' (duration: 403.655358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:06.402861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:05.966652Z","time spent":"436.174124ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:33:06.402905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:05.998444Z","time spent":"404.446643ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:33:06.402922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:05.966718Z","time spent":"436.170324ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:33:06.403044Z","caller":"traceutil/trace.go:171","msg":"trace[1001028276] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"390.467249ms","start":"2026-04-08T05:33:06.012562Z","end":"2026-04-08T05:33:06.403029Z","steps":["trace[1001028276] 'process raft request' (duration: 389.855448ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:33:06.403081Z","caller":"traceutil/trace.go:171","msg":"trace[1318021372] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"401.973763ms","start":"2026-04-08T05:33:06.001094Z","end":"2026-04-08T05:33:06.403067Z","steps":["trace[1318021372] 'process raft request' (duration: 401.071323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:06.403116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:06.012541Z","time spent":"390.544481ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:33:06.403193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:06.001086Z","time spent":"402.039956ms","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:33:12.753826Z","caller":"traceutil/trace.go:171","msg":"trace[359156142] linearizableReadLoop","detail":"{readStateIndex:697; appliedIndex:696; }","duration":"251.304905ms","start":"2026-04-08T05:33:12.502493Z","end":"2026-04-08T05:33:12.753798Z","steps":["trace[359156142] 'read index received' (duration: 250.201911ms)","trace[359156142] 'applied index is now lower than readState.Index' (duration: 1.101594ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:33:12.753882Z","caller":"traceutil/trace.go:171","msg":"trace[1183446236] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"590.68611ms","start":"2026-04-08T05:33:12.163159Z","end":"2026-04-08T05:33:12.753845Z","steps":["trace[1183446236] 'process raft request' (duration: 590.02752ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:12.754021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.503072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:33:12.754297Z","caller":"traceutil/trace.go:171","msg":"trace[1722093406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:671; }","duration":"251.79817ms","start":"2026-04-08T05:33:12.502447Z","end":"2026-04-08T05:33:12.754246Z","steps":["trace[1722093406] 'agreement among raft nodes before linearized reading' (duration: 251.515752ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:12.754317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:12.163129Z","time spent":"590.986449ms","remote":"127.0.0.1:37990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:33:13.358995Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15342811115908599932,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-08T05:33:13.673967Z","caller":"traceutil/trace.go:171","msg":"trace[694213385] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"901.520879ms","start":"2026-04-08T05:33:12.772423Z","end":"2026-04-08T05:33:13.673944Z","steps":["trace[694213385] 'process raft request' (duration: 901.376394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:13.674113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:12.772406Z","time spent":"901.632562ms","remote":"127.0.0.1:38086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:33:13.742191Z","caller":"traceutil/trace.go:171","msg":"trace[1238848020] linearizableReadLoop","detail":"{readStateIndex:699; appliedIndex:697; }","duration":"886.510999ms","start":"2026-04-08T05:33:12.855641Z","end":"2026-04-08T05:33:13.742152Z","steps":["trace[1238848020] 'read index received' (duration: 818.175373ms)","trace[1238848020] 'applied index is now lower than readState.Index' (duration: 68.334586ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:33:13.742441Z","caller":"traceutil/trace.go:171","msg":"trace[366178252] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"925.202977ms","start":"2026-04-08T05:33:12.817013Z","end":"2026-04-08T05:33:13.742216Z","steps":["trace[366178252] 'process raft request' (duration: 925.039843ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:13.742614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.50201ms","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-08T05:33:13.742653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.940145ms","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-08T05:33:13.742692Z","caller":"traceutil/trace.go:171","msg":"trace[498884555] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:673; }","duration":"441.635635ms","start":"2026-04-08T05:33:13.301039Z","end":"2026-04-08T05:33:13.742675Z","steps":["trace[498884555] 'agreement among raft nodes before linearized reading' (duration: 441.404677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:13.742662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.033585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-08T05:33:13.742731Z","caller":"traceutil/trace.go:171","msg":"trace[1788669929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:673; }","duration":"468.079491ms","start":"2026-04-08T05:33:13.274634Z","end":"2026-04-08T05:33:13.742713Z","steps":["trace[1788669929] 'agreement among raft nodes before linearized reading' (duration: 467.805382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:13.742734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:13.301018Z","time spent":"441.707597ms","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-08T05:33:13.742777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:13.274613Z","time spent":"468.154683ms","remote":"127.0.0.1:38180","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-08T05:33:13.742761Z","caller":"traceutil/trace.go:171","msg":"trace[280726003] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:673; }","duration":"886.190421ms","start":"2026-04-08T05:33:12.856553Z","end":"2026-04-08T05:33:13.742744Z","steps":["trace[280726003] 'agreement among raft nodes before linearized reading' (duration: 885.873241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:13.742856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:12.856542Z","time spent":"886.301484ms","remote":"127.0.0.1:38180","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-08T05:33:13.742858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"770.568964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T05:33:13.742549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.85973ms","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-08T05:33:13.743007Z","caller":"traceutil/trace.go:171","msg":"trace[828706765] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:673; }","duration":"887.411628ms","start":"2026-04-08T05:33:12.855584Z","end":"2026-04-08T05:33:13.742996Z","steps":["trace[828706765] 'agreement among raft nodes before linearized reading' (duration: 886.715776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:13.743051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:12.855559Z","time spent":"887.48087ms","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-08T05:33:13.74311Z","caller":"traceutil/trace.go:171","msg":"trace[1120890449] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:673; }","duration":"770.936975ms","start":"2026-04-08T05:33:12.972044Z","end":"2026-04-08T05:33:13.742981Z","steps":["trace[1120890449] 'agreement among raft nodes before linearized reading' (duration: 770.46422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:13.743143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:12.816987Z","time spent":"925.740604ms","remote":"127.0.0.1:38448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:33:13.74323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:12.972023Z","time spent":"771.190903ms","remote":"127.0.0.1:38434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-04-08T05:33:15.701885Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.941324082s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-08T05:33:16.48736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.726472343s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:33:16.487889Z","caller":"traceutil/trace.go:171","msg":"trace[1660984782] linearizableReadLoop","detail":"{readStateIndex:703; appliedIndex:699; }","duration":"2.734727461s","start":"2026-04-08T05:33:13.753127Z","end":"2026-04-08T05:33:16.487854Z","steps":["trace[1660984782] 'read index received' (duration: 7.523727ms)","trace[1660984782] 'applied index is now lower than readState.Index' (duration: 2.727202454s)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:33:16.488029Z","caller":"traceutil/trace.go:171","msg":"trace[750925957] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"2.740494395s","start":"2026-04-08T05:33:13.74752Z","end":"2026-04-08T05:33:16.488014Z","steps":["trace[750925957] 'process raft request' (duration: 13.233429ms)","trace[750925957] 'compare' (duration: 2.726148823s)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:33:16.488105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:13.747492Z","time spent":"2.740569788s","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:33:16.4882Z","caller":"traceutil/trace.go:171","msg":"trace[1447123258] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"2.740591708s","start":"2026-04-08T05:33:13.747575Z","end":"2026-04-08T05:33:16.488167Z","steps":["trace[1447123258] 'process raft request' (duration: 2.739953988s)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:33:16.488241Z","caller":"traceutil/trace.go:171","msg":"trace[867380841] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"2.739879486s","start":"2026-04-08T05:33:13.748315Z","end":"2026-04-08T05:33:16.488195Z","steps":["trace[867380841] 'process raft request' (duration: 2.739491533s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:16.4883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.155326224s","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-08T05:33:16.488374Z","caller":"traceutil/trace.go:171","msg":"trace[923948155] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:677; }","duration":"2.155428157s","start":"2026-04-08T05:33:14.33292Z","end":"2026-04-08T05:33:16.488348Z","steps":["trace[923948155] 'agreement among raft nodes before linearized reading' (duration: 2.155234922s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:16.488414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:14.332899Z","time spent":"2.155504859s","remote":"127.0.0.1:38290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":52,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-04-08T05:33:16.488457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:13.748284Z","time spent":"2.740044181s","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:33:16.488455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.770339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:33:16.488514Z","caller":"traceutil/trace.go:171","msg":"trace[373504653] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"2.740398042s","start":"2026-04-08T05:33:13.748101Z","end":"2026-04-08T05:33:16.488499Z","steps":["trace[373504653] 'process raft request' (duration: 2.739635649s)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:33:16.488555Z","caller":"traceutil/trace.go:171","msg":"trace[344326239] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:677; }","duration":"885.907803ms","start":"2026-04-08T05:33:15.602618Z","end":"2026-04-08T05:33:16.488526Z","steps":["trace[344326239] 'agreement among raft nodes before linearized reading' (duration: 885.744048ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:16.48857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.98669572s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T05:33:16.488602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.055936262s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-08T05:33:16.488588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:13.748092Z","time spent":"2.740455614s","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:33:16.488629Z","caller":"traceutil/trace.go:171","msg":"trace[213587545] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:677; }","duration":"2.055994254s","start":"2026-04-08T05:33:14.432627Z","end":"2026-04-08T05:33:16.488622Z","steps":["trace[213587545] 'agreement among raft nodes before linearized reading' (duration: 2.055940752s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:16.488618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:15.602601Z","time spent":"886.003525ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-08T05:33:16.488659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:14.432615Z","time spent":"2.056038715s","remote":"127.0.0.1:38262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":14,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-04-08T05:33:16.488724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.125930529s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.77\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-08T05:33:16.488789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.928729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:33:16.488806Z","caller":"traceutil/trace.go:171","msg":"trace[857208750] range","detail":"{range_begin:/registry/masterleases/199.204.45.77; range_end:; response_count:1; response_revision:677; }","duration":"1.126046572s","start":"2026-04-08T05:33:15.362746Z","end":"2026-04-08T05:33:16.488793Z","steps":["trace[857208750] 'agreement among raft nodes before linearized reading' (duration: 1.125916148s)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:33:16.488829Z","caller":"traceutil/trace.go:171","msg":"trace[493590369] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:677; }","duration":"363.012852ms","start":"2026-04-08T05:33:16.125802Z","end":"2026-04-08T05:33:16.488815Z","steps":["trace[493590369] 'agreement among raft nodes before linearized reading' (duration: 362.898998ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:16.48885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:15.362728Z","time spent":"1.126111443s","remote":"127.0.0.1:37936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.77\" "} {"level":"warn","ts":"2026-04-08T05:33:16.488875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:16.125781Z","time spent":"363.084734ms","remote":"127.0.0.1:38226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-08T05:33:16.488897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.73572427s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T05:33:16.488967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.639957ms","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-08T05:33:16.488632Z","caller":"traceutil/trace.go:171","msg":"trace[1292516939] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:677; }","duration":"1.986790453s","start":"2026-04-08T05:33:14.501822Z","end":"2026-04-08T05:33:16.488612Z","steps":["trace[1292516939] 'agreement among raft nodes before linearized reading' (duration: 1.98668405s)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:33:16.489022Z","caller":"traceutil/trace.go:171","msg":"trace[58158466] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:677; }","duration":"685.737711ms","start":"2026-04-08T05:33:15.803268Z","end":"2026-04-08T05:33:16.489006Z","steps":["trace[58158466] 'agreement among raft nodes before linearized reading' (duration: 685.647358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:16.489037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:14.501808Z","time spent":"1.987221946s","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-08T05:33:16.489024Z","caller":"traceutil/trace.go:171","msg":"trace[294882204] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:677; }","duration":"2.735901266s","start":"2026-04-08T05:33:13.753091Z","end":"2026-04-08T05:33:16.488992Z","steps":["trace[294882204] 'agreement among raft nodes before linearized reading' (duration: 2.73569637s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:16.489068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:15.803247Z","time spent":"685.807612ms","remote":"127.0.0.1:38324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-04-08T05:33:16.489092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:13.75308Z","time spent":"2.735996299s","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-04-08T05:33:16.489365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:13.747544Z","time spent":"2.741683489s","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:33:17.100462Z","caller":"traceutil/trace.go:171","msg":"trace[20457258] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"152.582342ms","start":"2026-04-08T05:33:16.947852Z","end":"2026-04-08T05:33:17.100434Z","steps":["trace[20457258] 'process raft request' (duration: 151.829371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:21.044145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.099552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-04-08T05:33:21.044245Z","caller":"traceutil/trace.go:171","msg":"trace[237204942] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:751; }","duration":"100.247916ms","start":"2026-04-08T05:33:20.943977Z","end":"2026-04-08T05:33:21.044225Z","steps":["trace[237204942] 'range keys from in-memory index tree' (duration: 99.922367ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:32.292794Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15342811115908600264,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-08T05:33:32.847752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.440554ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-08T05:33:32.84825Z","caller":"traceutil/trace.go:171","msg":"trace[1284750074] linearizableReadLoop","detail":"{readStateIndex:870; appliedIndex:869; }","duration":"1.055486852s","start":"2026-04-08T05:33:31.792734Z","end":"2026-04-08T05:33:32.848221Z","steps":["trace[1284750074] 'read index received' (duration: 754.437142ms)","trace[1284750074] 'applied index is now lower than readState.Index' (duration: 301.04737ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:33:32.84867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.055910882s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9tb9k\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-08T05:33:32.848789Z","caller":"traceutil/trace.go:171","msg":"trace[2029346521] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9tb9k; range_end:; response_count:1; response_revision:837; }","duration":"1.056085126s","start":"2026-04-08T05:33:31.792682Z","end":"2026-04-08T05:33:32.848767Z","steps":["trace[2029346521] 'agreement among raft nodes before linearized reading' (duration: 1.055640265s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:32.848835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:33:31.792659Z","time spent":"1.056165719s","remote":"127.0.0.1:38086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9tb9k\" "} {"level":"warn","ts":"2026-04-08T05:33:32.848929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.346153ms","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-08T05:33:32.849037Z","caller":"traceutil/trace.go:171","msg":"trace[1664515706] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:837; }","duration":"225.486727ms","start":"2026-04-08T05:33:32.623526Z","end":"2026-04-08T05:33:32.849013Z","steps":["trace[1664515706] 'agreement among raft nodes before linearized reading' (duration: 225.142369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:32.849005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.825957ms","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-08T05:33:32.849073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.839296ms","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":"warn","ts":"2026-04-08T05:33:32.848955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.300558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-08T05:33:32.849142Z","caller":"traceutil/trace.go:171","msg":"trace[1671519542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:837; }","duration":"263.001781ms","start":"2026-04-08T05:33:32.586093Z","end":"2026-04-08T05:33:32.849095Z","steps":["trace[1671519542] 'agreement among raft nodes before linearized reading' (duration: 262.597801ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:33:32.849155Z","caller":"traceutil/trace.go:171","msg":"trace[1259156736] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:837; }","duration":"225.983229ms","start":"2026-04-08T05:33:32.623154Z","end":"2026-04-08T05:33:32.849137Z","steps":["trace[1259156736] 'agreement among raft nodes before linearized reading' (duration: 225.733023ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:33:32.849161Z","caller":"traceutil/trace.go:171","msg":"trace[425974376] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:837; }","duration":"271.554195ms","start":"2026-04-08T05:33:32.577596Z","end":"2026-04-08T05:33:32.84915Z","steps":["trace[425974376] 'agreement among raft nodes before linearized reading' (duration: 271.065273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:32.84947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.354827ms","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-08T05:33:32.849515Z","caller":"traceutil/trace.go:171","msg":"trace[1966867460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:837; }","duration":"248.425598ms","start":"2026-04-08T05:33:32.601079Z","end":"2026-04-08T05:33:32.849504Z","steps":["trace[1966867460] 'agreement among raft nodes before linearized reading' (duration: 248.274315ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:33:47.12659Z","caller":"traceutil/trace.go:171","msg":"trace[53833153] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"102.315028ms","start":"2026-04-08T05:33:47.024252Z","end":"2026-04-08T05:33:47.126567Z","steps":["trace[53833153] 'process raft request' (duration: 86.582726ms)","trace[53833153] 'compare' (duration: 15.273212ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:33:47.132568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.808595ms","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-08T05:33:47.132685Z","caller":"traceutil/trace.go:171","msg":"trace[1417429390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1009; }","duration":"100.943148ms","start":"2026-04-08T05:33:47.031723Z","end":"2026-04-08T05:33:47.132666Z","steps":["trace[1417429390] 'agreement among raft nodes before linearized reading' (duration: 100.716013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:33:47.132868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.301956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-pwb67\" ","response":"range_response_count:1 size:5676"} {"level":"info","ts":"2026-04-08T05:33:47.132932Z","caller":"traceutil/trace.go:171","msg":"trace[1966233456] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-pwb67; range_end:; response_count:1; response_revision:1009; }","duration":"101.535462ms","start":"2026-04-08T05:33:47.03138Z","end":"2026-04-08T05:33:47.132915Z","steps":["trace[1966233456] 'agreement among raft nodes before linearized reading' (duration: 100.97842ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:34:01.368853Z","caller":"traceutil/trace.go:171","msg":"trace[596809413] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"124.594723ms","start":"2026-04-08T05:34:01.244227Z","end":"2026-04-08T05:34:01.368822Z","steps":["trace[596809413] 'process raft request' (duration: 102.974933ms)","trace[596809413] 'compare' (duration: 21.178672ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:34:17.603002Z","caller":"traceutil/trace.go:171","msg":"trace[1356262159] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"142.076715ms","start":"2026-04-08T05:34:17.460901Z","end":"2026-04-08T05:34:17.602978Z","steps":["trace[1356262159] 'process raft request' (duration: 77.306861ms)","trace[1356262159] 'compare' (duration: 64.642522ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:34:17.603204Z","caller":"traceutil/trace.go:171","msg":"trace[870663846] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"140.56779ms","start":"2026-04-08T05:34:17.462625Z","end":"2026-04-08T05:34:17.603192Z","steps":["trace[870663846] 'process raft request' (duration: 140.318556ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:34:17.603143Z","caller":"traceutil/trace.go:171","msg":"trace[804310664] linearizableReadLoop","detail":"{readStateIndex:1161; appliedIndex:1159; }","duration":"119.25175ms","start":"2026-04-08T05:34:17.483867Z","end":"2026-04-08T05:34:17.603119Z","steps":["trace[804310664] 'read index received' (duration: 54.397324ms)","trace[804310664] 'applied index is now lower than readState.Index' (duration: 64.853206ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:34:17.603446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.571575ms","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-08T05:34:17.603478Z","caller":"traceutil/trace.go:171","msg":"trace[305937997] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1118; }","duration":"119.643776ms","start":"2026-04-08T05:34:17.483825Z","end":"2026-04-08T05:34:17.603469Z","steps":["trace[305937997] 'agreement among raft nodes before linearized reading' (duration: 119.532615ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:34:17.646805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.346692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:34:17.646892Z","caller":"traceutil/trace.go:171","msg":"trace[2013678485] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1121; }","duration":"145.466444ms","start":"2026-04-08T05:34:17.501404Z","end":"2026-04-08T05:34:17.64687Z","steps":["trace[2013678485] 'agreement among raft nodes before linearized reading' (duration: 145.325662ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:34:40.019749Z","caller":"traceutil/trace.go:171","msg":"trace[1222991920] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"181.388857ms","start":"2026-04-08T05:34:39.838336Z","end":"2026-04-08T05:34:40.019725Z","steps":["trace[1222991920] 'process raft request' (duration: 84.638197ms)","trace[1222991920] 'compare' (duration: 96.346254ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:34:40.024766Z","caller":"traceutil/trace.go:171","msg":"trace[1428508534] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"185.675411ms","start":"2026-04-08T05:34:39.839082Z","end":"2026-04-08T05:34:40.024758Z","steps":["trace[1428508534] 'process raft request' (duration: 185.61182ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:34:40.353753Z","caller":"traceutil/trace.go:171","msg":"trace[1334743017] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"197.746171ms","start":"2026-04-08T05:34:40.15598Z","end":"2026-04-08T05:34:40.353726Z","steps":["trace[1334743017] 'process raft request' (duration: 197.609459ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:34:48.273898Z","caller":"traceutil/trace.go:171","msg":"trace[15033738] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"115.370405ms","start":"2026-04-08T05:34:48.158499Z","end":"2026-04-08T05:34:48.27387Z","steps":["trace[15033738] 'process raft request' (duration: 113.831673ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:35:07.813231Z","caller":"traceutil/trace.go:171","msg":"trace[1820018095] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"192.017003ms","start":"2026-04-08T05:35:07.621174Z","end":"2026-04-08T05:35:07.813191Z","steps":["trace[1820018095] 'process raft request' (duration: 156.193515ms)","trace[1820018095] 'compare' (duration: 35.564545ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:35:07.813614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.040729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T05:35:07.813621Z","caller":"traceutil/trace.go:171","msg":"trace[1420699685] linearizableReadLoop","detail":"{readStateIndex:1335; appliedIndex:1334; }","duration":"101.021519ms","start":"2026-04-08T05:35:07.712543Z","end":"2026-04-08T05:35:07.813564Z","steps":["trace[1420699685] 'read index received' (duration: 64.902877ms)","trace[1420699685] 'applied index is now lower than readState.Index' (duration: 35.721767ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:35:07.81368Z","caller":"traceutil/trace.go:171","msg":"trace[373120263] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1281; }","duration":"101.207201ms","start":"2026-04-08T05:35:07.712456Z","end":"2026-04-08T05:35:07.813664Z","steps":["trace[373120263] 'agreement among raft nodes before linearized reading' (duration: 100.992358ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:35:11.213618Z","caller":"traceutil/trace.go:171","msg":"trace[1044836932] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"359.061379ms","start":"2026-04-08T05:35:10.85452Z","end":"2026-04-08T05:35:11.213581Z","steps":["trace[1044836932] 'process raft request' (duration: 358.872527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:35:11.213787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:35:10.854485Z","time spent":"359.218092ms","remote":"127.0.0.1:37976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":853,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T05:35:12.374947Z","caller":"traceutil/trace.go:171","msg":"trace[832871175] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"115.22569ms","start":"2026-04-08T05:35:12.259682Z","end":"2026-04-08T05:35:12.374908Z","steps":["trace[832871175] 'process raft request' (duration: 94.726481ms)","trace[832871175] 'compare' (duration: 20.317376ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:35:12.807928Z","caller":"traceutil/trace.go:171","msg":"trace[219670625] linearizableReadLoop","detail":"{readStateIndex:1372; appliedIndex:1371; }","duration":"113.823652ms","start":"2026-04-08T05:35:12.694074Z","end":"2026-04-08T05:35:12.807897Z","steps":["trace[219670625] 'read index received' (duration: 111.273058ms)","trace[219670625] 'applied index is now lower than readState.Index' (duration: 2.549094ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:35:12.808078Z","caller":"traceutil/trace.go:171","msg":"trace[547421354] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"118.213318ms","start":"2026-04-08T05:35:12.689808Z","end":"2026-04-08T05:35:12.808022Z","steps":["trace[547421354] 'process raft request' (duration: 115.589294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:35:12.808123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.012814ms","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-08T05:35:12.808182Z","caller":"traceutil/trace.go:171","msg":"trace[70678466] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1317; }","duration":"114.142506ms","start":"2026-04-08T05:35:12.694023Z","end":"2026-04-08T05:35:12.808166Z","steps":["trace[70678466] 'agreement among raft nodes before linearized reading' (duration: 114.010344ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:35:14.674715Z","caller":"traceutil/trace.go:171","msg":"trace[290966770] linearizableReadLoop","detail":"{readStateIndex:1379; appliedIndex:1378; }","duration":"117.62438ms","start":"2026-04-08T05:35:14.557052Z","end":"2026-04-08T05:35:14.674676Z","steps":["trace[290966770] 'read index received' (duration: 67.854392ms)","trace[290966770] 'applied index is now lower than readState.Index' (duration: 49.768218ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:35:14.67485Z","caller":"traceutil/trace.go:171","msg":"trace[1266994813] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1324; }","duration":"118.154648ms","start":"2026-04-08T05:35:14.556677Z","end":"2026-04-08T05:35:14.674832Z","steps":["trace[1266994813] 'process raft request' (duration: 68.272889ms)","trace[1266994813] 'compare' (duration: 49.542523ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:35:14.674961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.915983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:35:14.675211Z","caller":"traceutil/trace.go:171","msg":"trace[1384234677] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1324; }","duration":"118.204858ms","start":"2026-04-08T05:35:14.556989Z","end":"2026-04-08T05:35:14.675194Z","steps":["trace[1384234677] 'agreement among raft nodes before linearized reading' (duration: 117.878594ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:35:14.846838Z","caller":"traceutil/trace.go:171","msg":"trace[751068073] linearizableReadLoop","detail":"{readStateIndex:1381; appliedIndex:1379; }","duration":"160.886283ms","start":"2026-04-08T05:35:14.685904Z","end":"2026-04-08T05:35:14.84679Z","steps":["trace[751068073] 'read index received' (duration: 20.73419ms)","trace[751068073] 'applied index is now lower than readState.Index' (duration: 140.149963ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:35:14.846881Z","caller":"traceutil/trace.go:171","msg":"trace[224058085] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"164.51007ms","start":"2026-04-08T05:35:14.682336Z","end":"2026-04-08T05:35:14.846846Z","steps":["trace[224058085] 'process raft request' (duration: 140.426807ms)","trace[224058085] 'compare' (duration: 23.907921ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:35:14.847177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.262057ms","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-08T05:35:14.847225Z","caller":"traceutil/trace.go:171","msg":"trace[352878720] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1326; }","duration":"161.373879ms","start":"2026-04-08T05:35:14.685839Z","end":"2026-04-08T05:35:14.847213Z","steps":["trace[352878720] 'agreement among raft nodes before linearized reading' (duration: 161.089396ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:35:15.154966Z","caller":"traceutil/trace.go:171","msg":"trace[1004433018] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"302.765451ms","start":"2026-04-08T05:35:14.85213Z","end":"2026-04-08T05:35:15.154896Z","steps":["trace[1004433018] 'process raft request' (duration: 279.53345ms)","trace[1004433018] 'compare' (duration: 22.933047ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:35:15.155006Z","caller":"traceutil/trace.go:171","msg":"trace[1059151143] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"302.390456ms","start":"2026-04-08T05:35:14.852578Z","end":"2026-04-08T05:35:15.154969Z","steps":["trace[1059151143] 'process raft request' (duration: 302.311485ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:35:15.15512Z","caller":"traceutil/trace.go:171","msg":"trace[240551320] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"302.76826ms","start":"2026-04-08T05:35:14.852317Z","end":"2026-04-08T05:35:15.155085Z","steps":["trace[240551320] 'process raft request' (duration: 302.490797ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:35:15.155243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:35:14.85255Z","time spent":"302.561747ms","remote":"127.0.0.1:38048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1240,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T05:35:15.155315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:35:14.852107Z","time spent":"302.994073ms","remote":"127.0.0.1:37976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":752,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T05:35:15.155384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:35:14.8523Z","time spent":"302.933503ms","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:35:18.613716Z","caller":"traceutil/trace.go:171","msg":"trace[1104210895] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"195.929912ms","start":"2026-04-08T05:35:18.417756Z","end":"2026-04-08T05:35:18.613686Z","steps":["trace[1104210895] 'process raft request' (duration: 195.683439ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T05:35:25.087934Z","caller":"traceutil/trace.go:171","msg":"trace[103550086] linearizableReadLoop","detail":"{readStateIndex:1430; appliedIndex:1429; }","duration":"425.635157ms","start":"2026-04-08T05:35:24.662265Z","end":"2026-04-08T05:35:25.0879Z","steps":["trace[103550086] 'read index received' (duration: 425.441645ms)","trace[103550086] 'applied index is now lower than readState.Index' (duration: 192.112µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:35:25.088082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.79813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:35:25.088139Z","caller":"traceutil/trace.go:171","msg":"trace[750037424] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1373; }","duration":"425.906211ms","start":"2026-04-08T05:35:24.662224Z","end":"2026-04-08T05:35:25.08813Z","steps":["trace[750037424] 'agreement among raft nodes before linearized reading' (duration: 425.788049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:35:25.088172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:35:24.662209Z","time spent":"425.956331ms","remote":"127.0.0.1:53140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"info","ts":"2026-04-08T05:35:25.087981Z","caller":"traceutil/trace.go:171","msg":"trace[186416660] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"443.433602ms","start":"2026-04-08T05:35:24.644524Z","end":"2026-04-08T05:35:25.087958Z","steps":["trace[186416660] 'process raft request' (duration: 443.205429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:35:25.088502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:35:24.644508Z","time spent":"443.949558ms","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T05:35:25.128913Z","caller":"traceutil/trace.go:171","msg":"trace[407732684] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"219.274172ms","start":"2026-04-08T05:35:24.909607Z","end":"2026-04-08T05:35:25.128882Z","steps":["trace[407732684] 'process raft request' (duration: 219.162831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:35:25.128966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.386134ms","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-08T05:35:25.129021Z","caller":"traceutil/trace.go:171","msg":"trace[717393437] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1374; }","duration":"449.492486ms","start":"2026-04-08T05:35:24.679515Z","end":"2026-04-08T05:35:25.129007Z","steps":["trace[717393437] 'agreement among raft nodes before linearized reading' (duration: 449.328114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:35:25.12906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:35:24.679491Z","time spent":"449.558626ms","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-08T05:35:25.129287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.257312ms","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-08T05:35:25.129362Z","caller":"traceutil/trace.go:171","msg":"trace[1439929774] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1374; }","duration":"328.377824ms","start":"2026-04-08T05:35:24.80096Z","end":"2026-04-08T05:35:25.129338Z","steps":["trace[1439929774] 'agreement among raft nodes before linearized reading' (duration: 328.16899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:35:25.129404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:35:24.800935Z","time spent":"328.459626ms","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-08T05:35:25.318759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.014809ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T05:35:25.318872Z","caller":"traceutil/trace.go:171","msg":"trace[1756095835] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"183.359707ms","start":"2026-04-08T05:35:25.135488Z","end":"2026-04-08T05:35:25.318848Z","steps":["trace[1756095835] 'process raft request' (duration: 77.157066ms)","trace[1756095835] 'compare' (duration: 105.917408ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:35:25.358976Z","caller":"traceutil/trace.go:171","msg":"trace[463338800] linearizableReadLoop","detail":"{readStateIndex:1433; appliedIndex:1431; }","duration":"222.72326ms","start":"2026-04-08T05:35:25.136238Z","end":"2026-04-08T05:35:25.358961Z","steps":["trace[463338800] 'read index received' (duration: 76.416897ms)","trace[463338800] 'applied index is now lower than readState.Index' (duration: 146.305463ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T05:35:25.359158Z","caller":"traceutil/trace.go:171","msg":"trace[1780492297] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"223.45927ms","start":"2026-04-08T05:35:25.13565Z","end":"2026-04-08T05:35:25.359109Z","steps":["trace[1780492297] 'process raft request' (duration: 223.228376ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:35:25.359178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.921794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:35:25.359242Z","caller":"traceutil/trace.go:171","msg":"trace[783032376] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1376; }","duration":"223.018486ms","start":"2026-04-08T05:35:25.136207Z","end":"2026-04-08T05:35:25.359225Z","steps":["trace[783032376] 'agreement among raft nodes before linearized reading' (duration: 222.912684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:35:25.359528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.308283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-08T05:35:25.359685Z","caller":"traceutil/trace.go:171","msg":"trace[759311144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1376; }","duration":"110.502955ms","start":"2026-04-08T05:35:25.24917Z","end":"2026-04-08T05:35:25.359673Z","steps":["trace[759311144] 'agreement among raft nodes before linearized reading' (duration: 110.035519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:35:26.495486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"848.498294ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-04-08T05:35:26.495582Z","caller":"traceutil/trace.go:171","msg":"trace[39960324] linearizableReadLoop","detail":"{readStateIndex:1435; appliedIndex:1434; }","duration":"993.652831ms","start":"2026-04-08T05:35:25.501912Z","end":"2026-04-08T05:35:26.495564Z","steps":["trace[39960324] 'read index received' (duration: 145.084947ms)","trace[39960324] 'applied index is now lower than readState.Index' (duration: 848.566274ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T05:35:26.495848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:35:25.382157Z","time spent":"1.113685365s","remote":"127.0.0.1:37936","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-08T05:35:26.496283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.124037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-08T05:35:26.496362Z","caller":"traceutil/trace.go:171","msg":"trace[587081413] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1377; }","duration":"388.24715ms","start":"2026-04-08T05:35:26.1081Z","end":"2026-04-08T05:35:26.496347Z","steps":["trace[587081413] 'agreement among raft nodes before linearized reading' (duration: 387.958306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:35:26.496432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:35:26.10808Z","time spent":"388.339871ms","remote":"127.0.0.1:38180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-08T05:35:26.496468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"994.556983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T05:35:26.496563Z","caller":"traceutil/trace.go:171","msg":"trace[1151900867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1377; }","duration":"994.687305ms","start":"2026-04-08T05:35:25.50186Z","end":"2026-04-08T05:35:26.496547Z","steps":["trace[1151900867] 'agreement among raft nodes before linearized reading' (duration: 994.36375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T05:35:26.496558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.543948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-08T05:35:26.496604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T05:35:25.501836Z","time spent":"994.754486ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-08T05:35:26.496606Z","caller":"traceutil/trace.go:171","msg":"trace[1420610710] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1377; }","duration":"153.641849ms","start":"2026-04-08T05:35:26.342952Z","end":"2026-04-08T05:35:26.496594Z","steps":["trace[1420610710] 'agreement among raft nodes before linearized reading' (duration: 153.542948ms)"],"step_count":1}