{"level":"warn","ts":"2026-05-28T06:50:33.36389Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-28T06:50:33.363974Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210: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.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210: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-05-28T06:50:33.364036Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-28T06:50:33.364047Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-05-28T06:50:33.364062Z","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-05-28T06:50:33.364663Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]} {"level":"info","ts":"2026-05-28T06:50:33.364734Z","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.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210: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-05-28T06:50:33.454544Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"86.48187ms"} {"level":"info","ts":"2026-05-28T06:50:33.509949Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"} {"level":"info","ts":"2026-05-28T06:50:33.510304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"} {"level":"info","ts":"2026-05-28T06:50:33.510431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"} {"level":"info","ts":"2026-05-28T06:50:33.510469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-28T06:50:33.510481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"} {"level":"info","ts":"2026-05-28T06:50:33.510521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"warn","ts":"2026-05-28T06:50:33.534553Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-28T06:50:33.536592Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-28T06:50:33.539339Z","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-05-28T06:50:33.543528Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-28T06:50:33.543678Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-28T06:50:33.543794Z","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-05-28T06:50:33.543931Z","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-05-28T06:50:33.54395Z","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-05-28T06:50:33.546985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"info","ts":"2026-05-28T06:50:33.5479Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-05-28T06:50:33.549792Z","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-05-28T06:50:33.550254Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-28T06:50:33.550332Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-28T06:50:33.549934Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-05-28T06:50:33.55107Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-05-28T06:50:33.811256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"} {"level":"info","ts":"2026-05-28T06:50:33.811392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-28T06:50:33.811459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"} {"level":"info","ts":"2026-05-28T06:50:33.811513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"} {"level":"info","ts":"2026-05-28T06:50:33.811547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-05-28T06:50:33.811591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"} {"level":"info","ts":"2026-05-28T06:50:33.811634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-05-28T06:50:33.822808Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T06:50:33.824797Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"} {"level":"info","ts":"2026-05-28T06:50:33.825086Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T06:50:33.827724Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-28T06:50:33.827816Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T06:50:33.828434Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T06:50:33.828636Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T06:50:33.828716Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T06:50:33.829096Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-28T06:50:33.829147Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-28T06:50:33.8311Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"} {"level":"warn","ts":"2026-05-28T06:50:35.545361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.786913ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-28T06:50:35.545626Z","caller":"traceutil/trace.go:171","msg":"trace[1172909354] linearizableReadLoop","detail":"{readStateIndex:40; appliedIndex:38; }","duration":"238.545238ms","start":"2026-05-28T06:50:35.307056Z","end":"2026-05-28T06:50:35.545601Z","steps":["trace[1172909354] 'read index received' (duration: 4.851358ms)","trace[1172909354] 'applied index is now lower than readState.Index' (duration: 233.69259ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T06:50:35.545745Z","caller":"traceutil/trace.go:171","msg":"trace[1181038160] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"243.92065ms","start":"2026-05-28T06:50:35.301794Z","end":"2026-05-28T06:50:35.545714Z","steps":["trace[1181038160] 'process raft request' (duration: 243.742329ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:50:35.545718Z","caller":"traceutil/trace.go:171","msg":"trace[1308382298] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"244.257882ms","start":"2026-05-28T06:50:35.301427Z","end":"2026-05-28T06:50:35.545685Z","steps":["trace[1308382298] 'compare' (duration: 232.597112ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:50:35.545927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.456791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-28T06:50:35.545972Z","caller":"traceutil/trace.go:171","msg":"trace[1608414039] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:36; }","duration":"143.535282ms","start":"2026-05-28T06:50:35.402425Z","end":"2026-05-28T06:50:35.54596Z","steps":["trace[1608414039] 'agreement among raft nodes before linearized reading' (duration: 143.393711ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:50:35.546334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.060472ms","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-05-28T06:50:35.546394Z","caller":"traceutil/trace.go:171","msg":"trace[1303980779] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:36; }","duration":"239.342684ms","start":"2026-05-28T06:50:35.307038Z","end":"2026-05-28T06:50:35.54638Z","steps":["trace[1303980779] 'agreement among raft nodes before linearized reading' (duration: 238.75806ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:50:36.867612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.206029ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-28T06:50:36.867775Z","caller":"traceutil/trace.go:171","msg":"trace[1128958313] transaction","detail":"{read_only:false; response_revision:120; number_of_response:1; }","duration":"115.370837ms","start":"2026-05-28T06:50:36.752352Z","end":"2026-05-28T06:50:36.867723Z","steps":["trace[1128958313] 'compare' (duration: 105.027718ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:50:37.336596Z","caller":"traceutil/trace.go:171","msg":"trace[1210513533] linearizableReadLoop","detail":"{readStateIndex:133; appliedIndex:132; }","duration":"244.091305ms","start":"2026-05-28T06:50:37.092471Z","end":"2026-05-28T06:50:37.336562Z","steps":["trace[1210513533] 'read index received' (duration: 182.963488ms)","trace[1210513533] 'applied index is now lower than readState.Index' (duration: 61.126487ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T06:50:37.336644Z","caller":"traceutil/trace.go:171","msg":"trace[498153410] transaction","detail":"{read_only:false; response_revision:129; number_of_response:1; }","duration":"249.892629ms","start":"2026-05-28T06:50:37.086707Z","end":"2026-05-28T06:50:37.3366Z","steps":["trace[498153410] 'process raft request' (duration: 188.859003ms)","trace[498153410] 'compare' (duration: 60.778444ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T06:50:37.336956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.813471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T06:50:37.337145Z","caller":"traceutil/trace.go:171","msg":"trace[739379641] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:129; }","duration":"197.935162ms","start":"2026-05-28T06:50:37.139083Z","end":"2026-05-28T06:50:37.337018Z","steps":["trace[739379641] 'agreement among raft nodes before linearized reading' (duration: 197.67191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:50:37.337224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.591479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T06:50:37.337609Z","caller":"traceutil/trace.go:171","msg":"trace[1644958639] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:129; }","duration":"244.936921ms","start":"2026-05-28T06:50:37.092425Z","end":"2026-05-28T06:50:37.337362Z","steps":["trace[1644958639] 'agreement among raft nodes before linearized reading' (duration: 244.310856ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:50:37.781061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.761157ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-28T06:50:37.781145Z","caller":"traceutil/trace.go:171","msg":"trace[1976693630] linearizableReadLoop","detail":"{readStateIndex:144; appliedIndex:143; }","duration":"102.221791ms","start":"2026-05-28T06:50:37.67891Z","end":"2026-05-28T06:50:37.781132Z","steps":["trace[1976693630] 'read index received' (duration: 62.141µs)","trace[1976693630] 'applied index is now lower than readState.Index' (duration: 102.15868ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T06:50:37.781235Z","caller":"traceutil/trace.go:171","msg":"trace[735324695] transaction","detail":"{read_only:false; response_revision:140; number_of_response:1; }","duration":"167.238287ms","start":"2026-05-28T06:50:37.613941Z","end":"2026-05-28T06:50:37.781179Z","steps":["trace[735324695] 'process raft request' (duration: 52.29311ms)","trace[735324695] 'compare' (duration: 114.651255ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T06:50:37.781332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.402052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T06:50:37.781446Z","caller":"traceutil/trace.go:171","msg":"trace[781124984] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:140; }","duration":"102.567073ms","start":"2026-05-28T06:50:37.678846Z","end":"2026-05-28T06:50:37.781413Z","steps":["trace[781124984] 'agreement among raft nodes before linearized reading' (duration: 102.346782ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:50:46.24948Z","caller":"traceutil/trace.go:171","msg":"trace[1995386203] linearizableReadLoop","detail":"{readStateIndex:365; appliedIndex:364; }","duration":"183.550057ms","start":"2026-05-28T06:50:46.065911Z","end":"2026-05-28T06:50:46.249461Z","steps":["trace[1995386203] 'read index received' (duration: 183.420686ms)","trace[1995386203] 'applied index is now lower than readState.Index' (duration: 128.841µs)"],"step_count":2} {"level":"warn","ts":"2026-05-28T06:50:46.249624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.707488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T06:50:46.249643Z","caller":"traceutil/trace.go:171","msg":"trace[478657968] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:356; }","duration":"183.764118ms","start":"2026-05-28T06:50:46.065871Z","end":"2026-05-28T06:50:46.249635Z","steps":["trace[478657968] 'agreement among raft nodes before linearized reading' (duration: 183.671477ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:50:46.249644Z","caller":"traceutil/trace.go:171","msg":"trace[375311970] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"230.079323ms","start":"2026-05-28T06:50:46.019529Z","end":"2026-05-28T06:50:46.249609Z","steps":["trace[375311970] 'process raft request' (duration: 229.807761ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:50:54.066721Z","caller":"traceutil/trace.go:171","msg":"trace[1923851652] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"141.034412ms","start":"2026-05-28T06:50:53.925658Z","end":"2026-05-28T06:50:54.066692Z","steps":["trace[1923851652] 'process raft request' (duration: 42.289825ms)","trace[1923851652] 'compare' (duration: 98.586866ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T06:50:58.268403Z","caller":"traceutil/trace.go:171","msg":"trace[1370415573] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"177.919286ms","start":"2026-05-28T06:50:58.090452Z","end":"2026-05-28T06:50:58.268371Z","steps":["trace[1370415573] 'process raft request' (duration: 177.739394ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:51:04.550388Z","caller":"traceutil/trace.go:171","msg":"trace[1719975941] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"129.526108ms","start":"2026-05-28T06:51:04.420841Z","end":"2026-05-28T06:51:04.550367Z","steps":["trace[1719975941] 'process raft request' (duration: 41.252206ms)","trace[1719975941] 'compare' (duration: 88.195879ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T06:51:06.245358Z","caller":"traceutil/trace.go:171","msg":"trace[578182665] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"104.496759ms","start":"2026-05-28T06:51:06.140834Z","end":"2026-05-28T06:51:06.24533Z","steps":["trace[578182665] 'process raft request' (duration: 104.367834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:12.743725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.149743ms","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-05-28T06:51:12.743821Z","caller":"traceutil/trace.go:171","msg":"trace[1811882548] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:486; }","duration":"159.300058ms","start":"2026-05-28T06:51:12.5845Z","end":"2026-05-28T06:51:12.7438Z","steps":["trace[1811882548] 'range keys from in-memory index tree' (duration: 159.019608ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:51:13.649712Z","caller":"traceutil/trace.go:171","msg":"trace[497954100] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"510.044636ms","start":"2026-05-28T06:51:13.139634Z","end":"2026-05-28T06:51:13.649679Z","steps":["trace[497954100] 'process raft request' (duration: 509.907972ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:13.649857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:13.139614Z","time spent":"510.183671ms","remote":"127.0.0.1:50356","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-05-28T06:51:14.224283Z","caller":"traceutil/trace.go:171","msg":"trace[808063649] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"1.078750213s","start":"2026-05-28T06:51:13.145499Z","end":"2026-05-28T06:51:14.224249Z","steps":["trace[808063649] 'process raft request' (duration: 1.078552556s)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:51:14.224337Z","caller":"traceutil/trace.go:171","msg":"trace[470349292] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"1.068108592s","start":"2026-05-28T06:51:13.156184Z","end":"2026-05-28T06:51:14.224293Z","steps":["trace[470349292] 'process raft request' (duration: 1.067923296s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:14.224486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:13.156169Z","time spent":"1.068244968s","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T06:51:14.224472Z","caller":"traceutil/trace.go:171","msg":"trace[184570299] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"1.068175124s","start":"2026-05-28T06:51:13.156238Z","end":"2026-05-28T06:51:14.224413Z","steps":["trace[184570299] 'process raft request' (duration: 1.067952067s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:14.224535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:13.145479Z","time spent":"1.078883948s","remote":"127.0.0.1:50356","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-05-28T06:51:14.224642Z","caller":"traceutil/trace.go:171","msg":"trace[1080868746] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"1.067577083s","start":"2026-05-28T06:51:13.157053Z","end":"2026-05-28T06:51:14.22463Z","steps":["trace[1080868746] 'process raft request' (duration: 1.067316824s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:14.224696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:13.156235Z","time spent":"1.068373421s","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T06:51:14.22473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:13.157045Z","time spent":"1.067628305s","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T06:51:14.224493Z","caller":"traceutil/trace.go:171","msg":"trace[1492061951] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"1.067884545s","start":"2026-05-28T06:51:13.156588Z","end":"2026-05-28T06:51:14.224473Z","steps":["trace[1492061951] 'process raft request' (duration: 1.067724069s)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:51:14.224826Z","caller":"traceutil/trace.go:171","msg":"trace[1390415201] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"1.061707534s","start":"2026-05-28T06:51:13.163105Z","end":"2026-05-28T06:51:14.224812Z","steps":["trace[1390415201] 'process raft request' (duration: 1.06131872s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:14.22487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:13.156564Z","time spent":"1.068283949s","remote":"127.0.0.1:50356","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-05-28T06:51:14.224892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:13.163089Z","time spent":"1.061775645s","remote":"127.0.0.1:50356","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-05-28T06:51:14.225048Z","caller":"traceutil/trace.go:171","msg":"trace[1193173095] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"1.047916871s","start":"2026-05-28T06:51:13.177094Z","end":"2026-05-28T06:51:14.225011Z","steps":["trace[1193173095] 'process raft request' (duration: 1.047599939s)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:51:14.225173Z","caller":"traceutil/trace.go:171","msg":"trace[853164880] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"1.041495341s","start":"2026-05-28T06:51:13.183657Z","end":"2026-05-28T06:51:14.225153Z","steps":["trace[853164880] 'process raft request' (duration: 1.041260902s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:14.225269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:13.177075Z","time spent":"1.048063306s","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T06:51:14.225285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:13.183637Z","time spent":"1.041566093s","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T06:51:14.224248Z","caller":"traceutil/trace.go:171","msg":"trace[643072152] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"1.082941832s","start":"2026-05-28T06:51:13.14127Z","end":"2026-05-28T06:51:14.224212Z","steps":["trace[643072152] 'process raft request' (duration: 1.082662163s)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:51:14.225483Z","caller":"traceutil/trace.go:171","msg":"trace[1186097039] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"1.014233137s","start":"2026-05-28T06:51:13.211235Z","end":"2026-05-28T06:51:14.225468Z","steps":["trace[1186097039] 'process raft request' (duration: 1.013785801s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:14.225636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:13.141251Z","time spent":"1.084263429s","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T06:51:14.225747Z","caller":"traceutil/trace.go:171","msg":"trace[2059203224] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"922.431485ms","start":"2026-05-28T06:51:13.303303Z","end":"2026-05-28T06:51:14.225735Z","steps":["trace[2059203224] 'process raft request' (duration: 921.942878ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:14.225793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:13.303284Z","time spent":"922.487197ms","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T06:51:14.225696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:13.211193Z","time spent":"1.014444174s","remote":"127.0.0.1:50356","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-05-28T06:51:15.067563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.958056ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-28T06:51:15.06798Z","caller":"traceutil/trace.go:171","msg":"trace[1181327682] linearizableReadLoop","detail":"{readStateIndex:514; appliedIndex:502; }","duration":"1.421047204s","start":"2026-05-28T06:51:13.64688Z","end":"2026-05-28T06:51:15.067927Z","steps":["trace[1181327682] 'read index received' (duration: 2.811291ms)","trace[1181327682] 'applied index is now lower than readState.Index' (duration: 1.418224742s)"],"step_count":2} {"level":"info","ts":"2026-05-28T06:51:15.068159Z","caller":"traceutil/trace.go:171","msg":"trace[1889940176] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"1.412380783s","start":"2026-05-28T06:51:13.655685Z","end":"2026-05-28T06:51:15.068065Z","steps":["trace[1889940176] 'process raft request' (duration: 1.411962129s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:15.070324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.421584662s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-28T06:51:15.070365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:13.655661Z","time spent":"1.412755907s","remote":"127.0.0.1:50770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T06:51:15.070406Z","caller":"traceutil/trace.go:171","msg":"trace[1751425157] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:501; }","duration":"1.423559111s","start":"2026-05-28T06:51:13.646823Z","end":"2026-05-28T06:51:15.070382Z","steps":["trace[1751425157] 'agreement among raft nodes before linearized reading' (duration: 1.421259171s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:15.070481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:13.646791Z","time spent":"1.423677275s","remote":"127.0.0.1:50556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-28T06:51:15.070796Z","caller":"traceutil/trace.go:171","msg":"trace[1365052620] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"1.413200871s","start":"2026-05-28T06:51:13.657567Z","end":"2026-05-28T06:51:15.070768Z","steps":["trace[1365052620] 'process raft request' (duration: 1.410200326s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:15.071394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:13.657558Z","time spent":"1.413296934s","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T06:51:15.071718Z","caller":"traceutil/trace.go:171","msg":"trace[747042139] transaction","detail":"{read_only:false; number_of_response:1; response_revision:501; }","duration":"1.413816042s","start":"2026-05-28T06:51:13.65787Z","end":"2026-05-28T06:51:15.071686Z","steps":["trace[747042139] 'process raft request' (duration: 1.412926221s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:15.072031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:13.657854Z","time spent":"1.413975697s","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7366,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T06:51:15.103611Z","caller":"traceutil/trace.go:171","msg":"trace[803898216] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"865.814555ms","start":"2026-05-28T06:51:14.23774Z","end":"2026-05-28T06:51:15.103555Z","steps":["trace[803898216] 'process raft request' (duration: 865.743583ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:51:15.103636Z","caller":"traceutil/trace.go:171","msg":"trace[1579280528] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"865.905708ms","start":"2026-05-28T06:51:14.237679Z","end":"2026-05-28T06:51:15.103585Z","steps":["trace[1579280528] 'process raft request' (duration: 865.718382ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:15.103824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.034953041s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-28T06:51:15.103792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:14.237737Z","time spent":"865.95659ms","remote":"127.0.0.1:50770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T06:51:15.103872Z","caller":"traceutil/trace.go:171","msg":"trace[1840484456] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:510; }","duration":"1.035052335s","start":"2026-05-28T06:51:14.068808Z","end":"2026-05-28T06:51:15.10386Z","steps":["trace[1840484456] 'agreement among raft nodes before linearized reading' (duration: 1.034970042s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:15.103899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:14.068775Z","time spent":"1.035117737s","remote":"127.0.0.1:53236","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-05-28T06:51:15.104077Z","caller":"traceutil/trace.go:171","msg":"trace[427210344] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"851.890762ms","start":"2026-05-28T06:51:14.252176Z","end":"2026-05-28T06:51:15.104067Z","steps":["trace[427210344] 'process raft request' (duration: 851.53032ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:51:15.104101Z","caller":"traceutil/trace.go:171","msg":"trace[460650723] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"854.278257ms","start":"2026-05-28T06:51:14.249787Z","end":"2026-05-28T06:51:15.104065Z","steps":["trace[460650723] 'process raft request' (duration: 853.872783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:15.104135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:14.252167Z","time spent":"851.933365ms","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T06:51:15.104275Z","caller":"traceutil/trace.go:171","msg":"trace[411872509] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"805.778503ms","start":"2026-05-28T06:51:14.298489Z","end":"2026-05-28T06:51:15.104267Z","steps":["trace[411872509] 'process raft request' (duration: 805.257695ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:15.104318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:14.298458Z","time spent":"805.836695ms","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T06:51:15.104369Z","caller":"traceutil/trace.go:171","msg":"trace[12596849] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"863.624247ms","start":"2026-05-28T06:51:14.240674Z","end":"2026-05-28T06:51:15.104298Z","steps":["trace[12596849] 'process raft request' (duration: 862.83092ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:15.104577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:14.240659Z","time spent":"863.822805ms","remote":"127.0.0.1:50770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T06:51:15.104291Z","caller":"traceutil/trace.go:171","msg":"trace[440768710] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"862.047771ms","start":"2026-05-28T06:51:14.242216Z","end":"2026-05-28T06:51:15.104264Z","steps":["trace[440768710] 'process raft request' (duration: 861.324536ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:15.104919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:14.249776Z","time spent":"854.396001ms","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T06:51:15.104977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.233188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-28T06:51:15.104623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.11959ms","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-05-28T06:51:15.105077Z","caller":"traceutil/trace.go:171","msg":"trace[1136438447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:510; }","duration":"832.383233ms","start":"2026-05-28T06:51:14.272668Z","end":"2026-05-28T06:51:15.105052Z","steps":["trace[1136438447] 'agreement among raft nodes before linearized reading' (duration: 832.070012ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:51:15.105088Z","caller":"traceutil/trace.go:171","msg":"trace[1232473245] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:510; }","duration":"278.580026ms","start":"2026-05-28T06:51:14.826493Z","end":"2026-05-28T06:51:15.105073Z","steps":["trace[1232473245] 'agreement among raft nodes before linearized reading' (duration: 278.027907ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:15.105062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.43041ms","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-05-28T06:51:15.10517Z","caller":"traceutil/trace.go:171","msg":"trace[1358020857] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"859.068376ms","start":"2026-05-28T06:51:14.246089Z","end":"2026-05-28T06:51:15.105158Z","steps":["trace[1358020857] 'process raft request' (duration: 857.530593ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:15.10505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:14.242206Z","time spent":"862.654643ms","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T06:51:15.105228Z","caller":"traceutil/trace.go:171","msg":"trace[263301062] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:510; }","duration":"623.624437ms","start":"2026-05-28T06:51:14.481547Z","end":"2026-05-28T06:51:15.105171Z","steps":["trace[263301062] 'agreement among raft nodes before linearized reading' (duration: 623.193412ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:15.10524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:14.246082Z","time spent":"859.123978ms","remote":"127.0.0.1:50770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T06:51:15.105272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:14.481527Z","time spent":"623.734461ms","remote":"127.0.0.1:50556","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":"info","ts":"2026-05-28T06:51:15.105128Z","caller":"traceutil/trace.go:171","msg":"trace[1690878488] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"862.094623ms","start":"2026-05-28T06:51:14.243015Z","end":"2026-05-28T06:51:15.105109Z","steps":["trace[1690878488] 'process raft request' (duration: 860.58014ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:15.105598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:14.243007Z","time spent":"862.547668ms","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T06:51:15.10513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:14.272653Z","time spent":"832.468356ms","remote":"127.0.0.1:50556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-28T06:51:15.104181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:14.237663Z","time spent":"866.121115ms","remote":"127.0.0.1:50770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T06:51:16.080288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.111074ms","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-05-28T06:51:16.080375Z","caller":"traceutil/trace.go:171","msg":"trace[908041405] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:546; }","duration":"247.209337ms","start":"2026-05-28T06:51:15.833153Z","end":"2026-05-28T06:51:16.080362Z","steps":["trace[908041405] 'range keys from in-memory index tree' (duration: 247.100683ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:51:16.080626Z","caller":"traceutil/trace.go:171","msg":"trace[294028587] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"478.776628ms","start":"2026-05-28T06:51:15.601842Z","end":"2026-05-28T06:51:16.080619Z","steps":["trace[294028587] 'process raft request' (duration: 465.442627ms)","trace[294028587] 'compare' (duration: 12.788722ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T06:51:16.080684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:15.601817Z","time spent":"478.82759ms","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98689,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T06:51:16.087556Z","caller":"traceutil/trace.go:171","msg":"trace[1444737539] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"483.905914ms","start":"2026-05-28T06:51:15.603611Z","end":"2026-05-28T06:51:16.087516Z","steps":["trace[1444737539] 'process raft request' (duration: 483.660466ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:16.087728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:15.603593Z","time spent":"484.046109ms","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T06:51:16.088838Z","caller":"traceutil/trace.go:171","msg":"trace[1224920197] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"349.191577ms","start":"2026-05-28T06:51:15.739629Z","end":"2026-05-28T06:51:16.088821Z","steps":["trace[1224920197] 'process raft request' (duration: 348.241004ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:16.088971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:15.739603Z","time spent":"349.319312ms","remote":"127.0.0.1:50356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-28T06:51:22.470221Z","caller":"traceutil/trace.go:171","msg":"trace[265496242] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"255.356196ms","start":"2026-05-28T06:51:22.214836Z","end":"2026-05-28T06:51:22.470192Z","steps":["trace[265496242] 'process raft request' (duration: 255.17278ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:24.3629Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.165991525s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-28T06:51:25.35752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"994.125589ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T06:51:25.35841Z","caller":"traceutil/trace.go:171","msg":"trace[1130033231] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"2.16154763s","start":"2026-05-28T06:51:23.196831Z","end":"2026-05-28T06:51:25.358379Z","steps":["trace[1130033231] 'process raft request' (duration: 1.166314766s)","trace[1130033231] 'compare' (duration: 993.906132ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T06:51:25.358453Z","caller":"traceutil/trace.go:171","msg":"trace[1560787905] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"2.158540753s","start":"2026-05-28T06:51:23.199876Z","end":"2026-05-28T06:51:25.358417Z","steps":["trace[1560787905] 'process raft request' (duration: 2.157764108s)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:51:25.358475Z","caller":"traceutil/trace.go:171","msg":"trace[1442575937] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"2.157734857s","start":"2026-05-28T06:51:23.200712Z","end":"2026-05-28T06:51:25.358447Z","steps":["trace[1442575937] 'process raft request' (duration: 2.157023584s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:25.358578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:23.200696Z","time spent":"2.15783811s","remote":"127.0.0.1:50556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T06:51:25.358539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:23.19682Z","time spent":"2.161652873s","remote":"127.0.0.1:50556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T06:51:25.358612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:23.19985Z","time spent":"2.158680707s","remote":"127.0.0.1:50556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T06:51:25.363752Z","caller":"traceutil/trace.go:171","msg":"trace[629248341] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:629; }","duration":"296.230351ms","start":"2026-05-28T06:51:25.067495Z","end":"2026-05-28T06:51:25.363726Z","steps":["trace[629248341] 'read index received' (duration: 278.954951ms)","trace[629248341] 'applied index is now lower than readState.Index' (duration: 17.27389ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T06:51:25.363834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.339434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T06:51:25.363867Z","caller":"traceutil/trace.go:171","msg":"trace[2097421504] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:612; }","duration":"296.407606ms","start":"2026-05-28T06:51:25.067449Z","end":"2026-05-28T06:51:25.363856Z","steps":["trace[2097421504] 'agreement among raft nodes before linearized reading' (duration: 296.352724ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:25.364042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.274776ms","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-05-28T06:51:25.364088Z","caller":"traceutil/trace.go:171","msg":"trace[929280766] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:612; }","duration":"168.382479ms","start":"2026-05-28T06:51:25.195693Z","end":"2026-05-28T06:51:25.364076Z","steps":["trace[929280766] 'agreement among raft nodes before linearized reading' (duration: 168.171562ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:51:27.532267Z","caller":"traceutil/trace.go:171","msg":"trace[680825187] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"166.916604ms","start":"2026-05-28T06:51:27.365322Z","end":"2026-05-28T06:51:27.532239Z","steps":["trace[680825187] 'process raft request' (duration: 166.749049ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:51:27.548409Z","caller":"traceutil/trace.go:171","msg":"trace[199063954] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"181.528431ms","start":"2026-05-28T06:51:27.366852Z","end":"2026-05-28T06:51:27.548381Z","steps":["trace[199063954] 'process raft request' (duration: 181.347666ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:51:27.548757Z","caller":"traceutil/trace.go:171","msg":"trace[297029721] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"181.227792ms","start":"2026-05-28T06:51:27.367504Z","end":"2026-05-28T06:51:27.548732Z","steps":["trace[297029721] 'process raft request' (duration: 180.83605ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:51:27.548782Z","caller":"traceutil/trace.go:171","msg":"trace[1788021375] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:665; }","duration":"147.590111ms","start":"2026-05-28T06:51:27.401144Z","end":"2026-05-28T06:51:27.548734Z","steps":["trace[1788021375] 'read index received' (duration: 130.969492ms)","trace[1788021375] 'applied index is now lower than readState.Index' (duration: 16.619419ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T06:51:27.548856Z","caller":"traceutil/trace.go:171","msg":"trace[1360817095] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"135.413048ms","start":"2026-05-28T06:51:27.413424Z","end":"2026-05-28T06:51:27.548837Z","steps":["trace[1360817095] 'process raft request' (duration: 135.201942ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:27.549094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.926271ms","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-05-28T06:51:27.549164Z","caller":"traceutil/trace.go:171","msg":"trace[1380721770] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:648; }","duration":"148.034605ms","start":"2026-05-28T06:51:27.401114Z","end":"2026-05-28T06:51:27.549149Z","steps":["trace[1380721770] 'agreement among raft nodes before linearized reading' (duration: 147.749806ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:42.095723Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496341600578673,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-28T06:51:42.36963Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.061156778s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-28T06:51:42.436666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.140069785s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-t9t8h\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-28T06:51:42.436748Z","caller":"traceutil/trace.go:171","msg":"trace[771557697] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-t9t8h; range_end:; response_count:1; response_revision:765; }","duration":"1.140202308s","start":"2026-05-28T06:51:41.296525Z","end":"2026-05-28T06:51:42.436727Z","steps":["trace[771557697] 'range keys from in-memory index tree' (duration: 1.139849099s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:42.436781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:41.296506Z","time spent":"1.14026832s","remote":"127.0.0.1:50486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-t9t8h\" "} {"level":"info","ts":"2026-05-28T06:51:42.437224Z","caller":"traceutil/trace.go:171","msg":"trace[151507638] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"1.128858427s","start":"2026-05-28T06:51:41.308353Z","end":"2026-05-28T06:51:42.437212Z","steps":["trace[151507638] 'process raft request' (duration: 1.061555268s)","trace[151507638] 'compare' (duration: 66.508828ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T06:51:42.437297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:41.308327Z","time spent":"1.128928149s","remote":"127.0.0.1:50556","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-05-28T06:51:42.529041Z","caller":"traceutil/trace.go:171","msg":"trace[449910963] linearizableReadLoop","detail":"{readStateIndex:793; appliedIndex:791; }","duration":"933.364065ms","start":"2026-05-28T06:51:41.595651Z","end":"2026-05-28T06:51:42.529015Z","steps":["trace[449910963] 'read index received' (duration: 774.272015ms)","trace[449910963] 'applied index is now lower than readState.Index' (duration: 159.09117ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T06:51:42.529171Z","caller":"traceutil/trace.go:171","msg":"trace[948257277] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"793.801902ms","start":"2026-05-28T06:51:41.73533Z","end":"2026-05-28T06:51:42.529132Z","steps":["trace[948257277] 'process raft request' (duration: 793.563425ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:42.52933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.663903ms","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-05-28T06:51:42.52937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:41.735306Z","time spent":"793.965145ms","remote":"127.0.0.1:50480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4905,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T06:51:42.529399Z","caller":"traceutil/trace.go:171","msg":"trace[992559211] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:767; }","duration":"933.784036ms","start":"2026-05-28T06:51:41.595597Z","end":"2026-05-28T06:51:42.529381Z","steps":["trace[992559211] 'agreement among raft nodes before linearized reading' (duration: 933.54938ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:42.529462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:41.595577Z","time spent":"933.870869ms","remote":"127.0.0.1:50556","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-05-28T06:51:42.548106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"932.62374ms","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-05-28T06:51:42.548228Z","caller":"traceutil/trace.go:171","msg":"trace[623782994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:768; }","duration":"932.780555ms","start":"2026-05-28T06:51:41.61543Z","end":"2026-05-28T06:51:42.54821Z","steps":["trace[623782994] 'agreement among raft nodes before linearized reading' (duration: 932.526778ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:42.548286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:41.615419Z","time spent":"932.854907ms","remote":"127.0.0.1:50556","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":"info","ts":"2026-05-28T06:51:42.548453Z","caller":"traceutil/trace.go:171","msg":"trace[1314391668] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"105.436321ms","start":"2026-05-28T06:51:42.443005Z","end":"2026-05-28T06:51:42.548441Z","steps":["trace[1314391668] 'process raft request' (duration: 104.569178ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:42.548492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"926.429806ms","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-05-28T06:51:42.548547Z","caller":"traceutil/trace.go:171","msg":"trace[1718200090] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:768; }","duration":"926.518108ms","start":"2026-05-28T06:51:41.622013Z","end":"2026-05-28T06:51:42.548531Z","steps":["trace[1718200090] 'agreement among raft nodes before linearized reading' (duration: 926.394655ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:42.548579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:41.621995Z","time spent":"926.576721ms","remote":"127.0.0.1:50556","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-05-28T06:51:42.548594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"915.910797ms","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-05-28T06:51:42.548717Z","caller":"traceutil/trace.go:171","msg":"trace[1285224729] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:768; }","duration":"916.081262ms","start":"2026-05-28T06:51:41.632618Z","end":"2026-05-28T06:51:42.548699Z","steps":["trace[1285224729] 'agreement among raft nodes before linearized reading' (duration: 915.769884ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:42.548553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.317222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-28T06:51:42.548787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:41.632606Z","time spent":"916.170044ms","remote":"127.0.0.1:50556","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-05-28T06:51:42.548819Z","caller":"traceutil/trace.go:171","msg":"trace[210480334] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:768; }","duration":"523.670942ms","start":"2026-05-28T06:51:42.025129Z","end":"2026-05-28T06:51:42.5488Z","steps":["trace[210480334] 'agreement among raft nodes before linearized reading' (duration: 523.24914ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:51:42.548966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:51:42.025108Z","time spent":"523.841696ms","remote":"127.0.0.1:50410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":9,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"info","ts":"2026-05-28T06:51:43.474602Z","caller":"traceutil/trace.go:171","msg":"trace[2136655283] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"162.615682ms","start":"2026-05-28T06:51:43.311961Z","end":"2026-05-28T06:51:43.474576Z","steps":["trace[2136655283] 'process raft request' (duration: 162.405487ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:52:07.621398Z","caller":"traceutil/trace.go:171","msg":"trace[2001278215] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"103.773185ms","start":"2026-05-28T06:52:07.517587Z","end":"2026-05-28T06:52:07.62136Z","steps":["trace[2001278215] 'process raft request' (duration: 103.599231ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:52:18.909308Z","caller":"traceutil/trace.go:171","msg":"trace[524162956] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"169.608478ms","start":"2026-05-28T06:52:18.739657Z","end":"2026-05-28T06:52:18.909266Z","steps":["trace[524162956] 'process raft request' (duration: 169.478556ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:52:19.09272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.592499ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T06:52:19.092845Z","caller":"traceutil/trace.go:171","msg":"trace[1150776094] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"180.043375ms","start":"2026-05-28T06:52:18.912782Z","end":"2026-05-28T06:52:19.092825Z","steps":["trace[1150776094] 'process raft request' (duration: 79.221112ms)","trace[1150776094] 'compare' (duration: 100.474106ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T06:52:19.189557Z","caller":"traceutil/trace.go:171","msg":"trace[555307143] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"274.418105ms","start":"2026-05-28T06:52:18.915112Z","end":"2026-05-28T06:52:19.18953Z","steps":["trace[555307143] 'process raft request' (duration: 274.370924ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:52:19.189705Z","caller":"traceutil/trace.go:171","msg":"trace[410122448] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"274.595857ms","start":"2026-05-28T06:52:18.915012Z","end":"2026-05-28T06:52:19.189608Z","steps":["trace[410122448] 'process raft request' (duration: 274.337112ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:52:19.641426Z","caller":"traceutil/trace.go:171","msg":"trace[240941224] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"299.035691ms","start":"2026-05-28T06:52:19.342366Z","end":"2026-05-28T06:52:19.641401Z","steps":["trace[240941224] 'process raft request' (duration: 298.879648ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:52:29.912398Z","caller":"traceutil/trace.go:171","msg":"trace[1356236934] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"130.382363ms","start":"2026-05-28T06:52:29.781985Z","end":"2026-05-28T06:52:29.912367Z","steps":["trace[1356236934] 'process raft request' (duration: 130.24023ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:52:33.418785Z","caller":"traceutil/trace.go:171","msg":"trace[1385619079] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"128.204872ms","start":"2026-05-28T06:52:33.290519Z","end":"2026-05-28T06:52:33.418724Z","steps":["trace[1385619079] 'process raft request' (duration: 109.888346ms)","trace[1385619079] 'compare' (duration: 18.150783ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T06:52:53.423141Z","caller":"traceutil/trace.go:171","msg":"trace[1270062773] linearizableReadLoop","detail":"{readStateIndex:1170; appliedIndex:1169; }","duration":"138.70114ms","start":"2026-05-28T06:52:53.284416Z","end":"2026-05-28T06:52:53.423117Z","steps":["trace[1270062773] 'read index received' (duration: 138.588088ms)","trace[1270062773] 'applied index is now lower than readState.Index' (duration: 111.912µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T06:52:53.423226Z","caller":"traceutil/trace.go:171","msg":"trace[18466996] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"314.977064ms","start":"2026-05-28T06:52:53.108196Z","end":"2026-05-28T06:52:53.423173Z","steps":["trace[18466996] 'process raft request' (duration: 314.773851ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:52:53.423338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.906823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-28T06:52:53.423367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:52:53.10818Z","time spent":"315.110306ms","remote":"127.0.0.1:50556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T06:52:53.423372Z","caller":"traceutil/trace.go:171","msg":"trace[1263873636] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1129; }","duration":"138.996264ms","start":"2026-05-28T06:52:53.284366Z","end":"2026-05-28T06:52:53.423362Z","steps":["trace[1263873636] 'agreement among raft nodes before linearized reading' (duration: 138.850172ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:52:53.559776Z","caller":"traceutil/trace.go:171","msg":"trace[2049874983] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"145.515474ms","start":"2026-05-28T06:52:53.414233Z","end":"2026-05-28T06:52:53.559748Z","steps":["trace[2049874983] 'process raft request' (duration: 145.286001ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:52:53.58796Z","caller":"traceutil/trace.go:171","msg":"trace[1785020359] linearizableReadLoop","detail":"{readStateIndex:1172; appliedIndex:1170; }","duration":"114.257776ms","start":"2026-05-28T06:52:53.473683Z","end":"2026-05-28T06:52:53.587941Z","steps":["trace[1785020359] 'read index received' (duration: 85.943613ms)","trace[1785020359] 'applied index is now lower than readState.Index' (duration: 28.312633ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T06:52:53.58806Z","caller":"traceutil/trace.go:171","msg":"trace[1617645254] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"159.880424ms","start":"2026-05-28T06:52:53.428101Z","end":"2026-05-28T06:52:53.587982Z","steps":["trace[1617645254] 'process raft request' (duration: 159.744592ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:52:53.588327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.626452ms","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-05-28T06:52:53.588544Z","caller":"traceutil/trace.go:171","msg":"trace[938715843] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1131; }","duration":"114.903096ms","start":"2026-05-28T06:52:53.473624Z","end":"2026-05-28T06:52:53.588527Z","steps":["trace[938715843] 'agreement among raft nodes before linearized reading' (duration: 114.411089ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:52:58.321492Z","caller":"traceutil/trace.go:171","msg":"trace[344629108] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"108.690407ms","start":"2026-05-28T06:52:58.212778Z","end":"2026-05-28T06:52:58.321468Z","steps":["trace[344629108] 'process raft request' (duration: 108.496814ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:52:58.58692Z","caller":"traceutil/trace.go:171","msg":"trace[496289730] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"123.060621ms","start":"2026-05-28T06:52:58.463837Z","end":"2026-05-28T06:52:58.586897Z","steps":["trace[496289730] 'process raft request' (duration: 122.897769ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T06:53:27.822097Z","caller":"traceutil/trace.go:171","msg":"trace[622757916] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"113.802996ms","start":"2026-05-28T06:53:27.708273Z","end":"2026-05-28T06:53:27.822076Z","steps":["trace[622757916] 'process raft request' (duration: 113.681654ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:53:36.497285Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496341600580035,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-28T06:53:36.6355Z","caller":"traceutil/trace.go:171","msg":"trace[464383880] linearizableReadLoop","detail":"{readStateIndex:1358; appliedIndex:1357; }","duration":"638.470861ms","start":"2026-05-28T06:53:35.996985Z","end":"2026-05-28T06:53:36.635455Z","steps":["trace[464383880] 'read index received' (duration: 636.498306ms)","trace[464383880] 'applied index is now lower than readState.Index' (duration: 1.971345ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T06:53:36.635944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.956567ms","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-05-28T06:53:36.636016Z","caller":"traceutil/trace.go:171","msg":"trace[249118621] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1306; }","duration":"639.085369ms","start":"2026-05-28T06:53:35.996912Z","end":"2026-05-28T06:53:36.635998Z","steps":["trace[249118621] 'agreement among raft nodes before linearized reading' (duration: 638.856816ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:53:36.636054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:53:35.9969Z","time spent":"639.145719ms","remote":"127.0.0.1:50556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-28T06:53:36.635713Z","caller":"traceutil/trace.go:171","msg":"trace[1207129538] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"716.452411ms","start":"2026-05-28T06:53:35.919235Z","end":"2026-05-28T06:53:36.635687Z","steps":["trace[1207129538] 'process raft request' (duration: 714.306744ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:53:36.636753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:53:35.919223Z","time spent":"717.439753ms","remote":"127.0.0.1:50556","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T06:53:36.637263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.313845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T06:53:36.637316Z","caller":"traceutil/trace.go:171","msg":"trace[822213610] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1306; }","duration":"569.392006ms","start":"2026-05-28T06:53:36.067907Z","end":"2026-05-28T06:53:36.637299Z","steps":["trace[822213610] 'agreement among raft nodes before linearized reading' (duration: 569.315815ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:53:36.637384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:53:36.067844Z","time spent":"569.498278ms","remote":"127.0.0.1:53240","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-05-28T06:53:36.637353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.871281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T06:53:36.637466Z","caller":"traceutil/trace.go:171","msg":"trace[382159515] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1306; }","duration":"434.042823ms","start":"2026-05-28T06:53:36.203393Z","end":"2026-05-28T06:53:36.637435Z","steps":["trace[382159515] 'agreement among raft nodes before linearized reading' (duration: 433.83343ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:53:36.637543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:53:36.203372Z","time spent":"434.159724ms","remote":"127.0.0.1:50592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-05-28T06:53:36.637996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.019239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T06:53:36.638067Z","caller":"traceutil/trace.go:171","msg":"trace[1735638333] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1306; }","duration":"346.15307ms","start":"2026-05-28T06:53:36.291893Z","end":"2026-05-28T06:53:36.638046Z","steps":["trace[1735638333] 'agreement among raft nodes before linearized reading' (duration: 345.36054ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:53:36.638117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:53:36.291873Z","time spent":"346.228942ms","remote":"127.0.0.1:47122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-28T06:53:36.63832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.372587ms","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-05-28T06:53:36.63841Z","caller":"traceutil/trace.go:171","msg":"trace[1531868654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1306; }","duration":"637.434067ms","start":"2026-05-28T06:53:36.00091Z","end":"2026-05-28T06:53:36.638345Z","steps":["trace[1531868654] 'agreement among raft nodes before linearized reading' (duration: 636.251572ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T06:53:36.638524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T06:53:36.000898Z","time spent":"637.552049ms","remote":"127.0.0.1:50556","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\" "}