{"level":"warn","ts":"2026-04-23T02:12:33.379312Z","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-23T02:12:33.379382Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223: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.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223: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-23T02:12:33.379533Z","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-23T02:12:33.37955Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-04-23T02:12:33.379633Z","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-23T02:12:33.380375Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]} {"level":"info","ts":"2026-04-23T02:12:33.380502Z","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.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223: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-23T02:12:33.386497Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.202425ms"} {"level":"info","ts":"2026-04-23T02:12:33.393781Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-04-23T02:12:33.393856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-04-23T02:12:33.393874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-04-23T02:12:33.393912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-23T02:12:33.393926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-04-23T02:12:33.393983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-04-23T02:12:33.402625Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-23T02:12:33.404782Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-23T02:12:33.406678Z","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-23T02:12:33.411326Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-23T02:12:33.411552Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-23T02:12:33.411713Z","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-23T02:12:33.411829Z","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-23T02:12:33.411866Z","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-23T02:12:33.412539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-04-23T02:12:33.4127Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-04-23T02:12:33.422614Z","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-23T02:12:33.422881Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-23T02:12:33.422917Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-23T02:12:33.424009Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-04-23T02:12:33.424027Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-04-23T02:12:33.794667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-04-23T02:12:33.794762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-23T02:12:33.794788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-04-23T02:12:33.794802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-04-23T02:12:33.79481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-04-23T02:12:33.794821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-04-23T02:12:33.794836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-04-23T02:12:33.795887Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"} {"level":"info","ts":"2026-04-23T02:12:33.796046Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T02:12:33.796162Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T02:12:33.796371Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T02:12:33.796473Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-23T02:12:33.796506Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-23T02:12:33.799154Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-23T02:12:33.799492Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T02:12:33.799552Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T02:12:33.799582Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T02:12:33.799979Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"info","ts":"2026-04-23T02:12:46.547814Z","caller":"traceutil/trace.go:171","msg":"trace[2122940694] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"106.039874ms","start":"2026-04-23T02:12:46.441752Z","end":"2026-04-23T02:12:46.547792Z","steps":["trace[2122940694] 'process raft request' (duration: 105.909184ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:12:47.709547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.706397ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T02:12:47.709709Z","caller":"traceutil/trace.go:171","msg":"trace[748399703] linearizableReadLoop","detail":"{readStateIndex:422; appliedIndex:421; }","duration":"178.270435ms","start":"2026-04-23T02:12:47.531419Z","end":"2026-04-23T02:12:47.70969Z","steps":["trace[748399703] 'read index received' (duration: 56.645µs)","trace[748399703] 'applied index is now lower than readState.Index' (duration: 178.21241ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T02:12:47.709788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.377703ms","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-23T02:12:47.709823Z","caller":"traceutil/trace.go:171","msg":"trace[1921040660] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:407; }","duration":"178.45188ms","start":"2026-04-23T02:12:47.531358Z","end":"2026-04-23T02:12:47.70981Z","steps":["trace[1921040660] 'agreement among raft nodes before linearized reading' (duration: 178.386614ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:12:47.709924Z","caller":"traceutil/trace.go:171","msg":"trace[626278851] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"325.086854ms","start":"2026-04-23T02:12:47.384796Z","end":"2026-04-23T02:12:47.709883Z","steps":["trace[626278851] 'process raft request' (duration: 124.478014ms)","trace[626278851] 'compare' (duration: 199.542303ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T02:12:47.710158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:12:47.384769Z","time spent":"325.236315ms","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T02:12:53.035978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.571863ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-23T02:12:53.036166Z","caller":"traceutil/trace.go:171","msg":"trace[51070877] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"175.87741ms","start":"2026-04-23T02:12:52.860241Z","end":"2026-04-23T02:12:53.036119Z","steps":["trace[51070877] 'process raft request' (duration: 54.069887ms)","trace[51070877] 'compare' (duration: 121.352166ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T02:12:53.320571Z","caller":"traceutil/trace.go:171","msg":"trace[335738874] linearizableReadLoop","detail":"{readStateIndex:451; appliedIndex:450; }","duration":"159.264748ms","start":"2026-04-23T02:12:53.161285Z","end":"2026-04-23T02:12:53.32055Z","steps":["trace[335738874] 'read index received' (duration: 130.435359ms)","trace[335738874] 'applied index is now lower than readState.Index' (duration: 28.828519ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T02:12:53.320742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.445953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3810"} {"level":"info","ts":"2026-04-23T02:12:53.320792Z","caller":"traceutil/trace.go:171","msg":"trace[1285915597] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:435; }","duration":"159.52597ms","start":"2026-04-23T02:12:53.161259Z","end":"2026-04-23T02:12:53.320785Z","steps":["trace[1285915597] 'agreement among raft nodes before linearized reading' (duration: 159.367956ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:12:53.320935Z","caller":"traceutil/trace.go:171","msg":"trace[1273588454] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"161.832621ms","start":"2026-04-23T02:12:53.158752Z","end":"2026-04-23T02:12:53.320585Z","steps":["trace[1273588454] 'process raft request' (duration: 132.900623ms)","trace[1273588454] 'compare' (duration: 28.792446ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T02:12:53.321003Z","caller":"traceutil/trace.go:171","msg":"trace[825300992] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"155.202682ms","start":"2026-04-23T02:12:53.165784Z","end":"2026-04-23T02:12:53.320987Z","steps":["trace[825300992] 'process raft request' (duration: 155.102234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:12:57.688089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.790742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T02:12:57.688182Z","caller":"traceutil/trace.go:171","msg":"trace[627663626] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:463; }","duration":"697.940855ms","start":"2026-04-23T02:12:56.990223Z","end":"2026-04-23T02:12:57.688164Z","steps":["trace[627663626] 'range keys from in-memory index tree' (duration: 697.683724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:12:57.688223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:12:56.990207Z","time spent":"698.008231ms","remote":"127.0.0.1:41204","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-23T02:12:57.68819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.661095ms","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-23T02:12:57.688392Z","caller":"traceutil/trace.go:171","msg":"trace[1498398647] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:463; }","duration":"221.909065ms","start":"2026-04-23T02:12:57.466421Z","end":"2026-04-23T02:12:57.68833Z","steps":["trace[1498398647] 'range keys from in-memory index tree' (duration: 221.434836ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:12:58.071924Z","caller":"traceutil/trace.go:171","msg":"trace[335827669] linearizableReadLoop","detail":"{readStateIndex:483; appliedIndex:482; }","duration":"262.769165ms","start":"2026-04-23T02:12:57.809123Z","end":"2026-04-23T02:12:58.071892Z","steps":["trace[335827669] 'read index received' (duration: 262.552127ms)","trace[335827669] 'applied index is now lower than readState.Index' (duration: 215.898µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T02:12:58.071998Z","caller":"traceutil/trace.go:171","msg":"trace[694004123] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"286.998135ms","start":"2026-04-23T02:12:57.784977Z","end":"2026-04-23T02:12:58.071976Z","steps":["trace[694004123] 'process raft request' (duration: 286.729192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:12:58.072085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.926528ms","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-23T02:12:58.072116Z","caller":"traceutil/trace.go:171","msg":"trace[1228988067] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:465; }","duration":"263.038078ms","start":"2026-04-23T02:12:57.809068Z","end":"2026-04-23T02:12:58.072107Z","steps":["trace[1228988067] 'agreement among raft nodes before linearized reading' (duration: 262.938329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:02.492508Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225685817619987,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-23T02:13:02.618846Z","caller":"traceutil/trace.go:171","msg":"trace[658374698] linearizableReadLoop","detail":"{readStateIndex:492; appliedIndex:491; }","duration":"626.4172ms","start":"2026-04-23T02:13:01.992384Z","end":"2026-04-23T02:13:02.618801Z","steps":["trace[658374698] 'read index received' (duration: 621.759305ms)","trace[658374698] 'applied index is now lower than readState.Index' (duration: 4.655895ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T02:13:02.618991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.576533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T02:13:02.619119Z","caller":"traceutil/trace.go:171","msg":"trace[967479277] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:473; }","duration":"626.729926ms","start":"2026-04-23T02:13:01.992368Z","end":"2026-04-23T02:13:02.619098Z","steps":["trace[967479277] 'agreement among raft nodes before linearized reading' (duration: 626.515728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:02.619148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.916569ms","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-23T02:13:02.619179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:01.992284Z","time spent":"626.887481ms","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-23T02:13:02.619201Z","caller":"traceutil/trace.go:171","msg":"trace[1598579233] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:473; }","duration":"528.03993ms","start":"2026-04-23T02:13:02.091146Z","end":"2026-04-23T02:13:02.619186Z","steps":["trace[1598579233] 'agreement among raft nodes before linearized reading' (duration: 527.895688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:02.619251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:02.091121Z","time spent":"528.119926ms","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-23T02:13:02.619582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.316312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-23T02:13:02.619677Z","caller":"traceutil/trace.go:171","msg":"trace[1402153500] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:473; }","duration":"484.481425ms","start":"2026-04-23T02:13:02.135173Z","end":"2026-04-23T02:13:02.619654Z","steps":["trace[1402153500] 'agreement among raft nodes before linearized reading' (duration: 484.3015ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:02.619734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:02.135143Z","time spent":"484.581134ms","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-23T02:13:04.194143Z","caller":"traceutil/trace.go:171","msg":"trace[350097320] linearizableReadLoop","detail":"{readStateIndex:496; appliedIndex:495; }","duration":"202.059076ms","start":"2026-04-23T02:13:03.992055Z","end":"2026-04-23T02:13:04.194114Z","steps":["trace[350097320] 'read index received' (duration: 201.86768ms)","trace[350097320] 'applied index is now lower than readState.Index' (duration: 190.316µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T02:13:04.194254Z","caller":"traceutil/trace.go:171","msg":"trace[1949566230] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"403.840053ms","start":"2026-04-23T02:13:03.790372Z","end":"2026-04-23T02:13:04.194212Z","steps":["trace[1949566230] 'process raft request' (duration: 403.5619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:04.194345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.258643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T02:13:04.194387Z","caller":"traceutil/trace.go:171","msg":"trace[1289318249] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:477; }","duration":"202.392005ms","start":"2026-04-23T02:13:03.991976Z","end":"2026-04-23T02:13:04.194368Z","steps":["trace[1289318249] 'agreement among raft nodes before linearized reading' (duration: 202.253783ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:04.19447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:03.790343Z","time spent":"404.006567ms","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T02:13:07.209699Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225685817620072,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T02:13:07.71072Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225685817620072,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T02:13:07.714721Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.072449934s","expected-duration":"1s"} {"level":"info","ts":"2026-04-23T02:13:07.715218Z","caller":"traceutil/trace.go:171","msg":"trace[574649927] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"1.073021153s","start":"2026-04-23T02:13:06.64216Z","end":"2026-04-23T02:13:07.715181Z","steps":["trace[574649927] 'process raft request' (duration: 1.072816785s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:07.715417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:06.642141Z","time spent":"1.073172856s","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T02:13:08.176426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.391503ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T02:13:08.176576Z","caller":"traceutil/trace.go:171","msg":"trace[473257904] linearizableReadLoop","detail":"{readStateIndex:537; appliedIndex:535; }","duration":"1.467417743s","start":"2026-04-23T02:13:06.709135Z","end":"2026-04-23T02:13:08.176553Z","steps":["trace[473257904] 'read index received' (duration: 1.005880552s)","trace[473257904] 'applied index is now lower than readState.Index' (duration: 461.535431ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T02:13:08.176596Z","caller":"traceutil/trace.go:171","msg":"trace[1766632956] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"1.533319508s","start":"2026-04-23T02:13:06.643253Z","end":"2026-04-23T02:13:08.176572Z","steps":["trace[1766632956] 'process raft request' (duration: 1.217655932s)","trace[1766632956] 'compare' (duration: 315.12617ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T02:13:08.176721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.467584987s","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":"warn","ts":"2026-04-23T02:13:08.176713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:06.643227Z","time spent":"1.533432237s","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T02:13:08.176756Z","caller":"traceutil/trace.go:171","msg":"trace[979463392] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:518; }","duration":"1.467673695s","start":"2026-04-23T02:13:06.709068Z","end":"2026-04-23T02:13:08.176741Z","steps":["trace[979463392] 'agreement among raft nodes before linearized reading' (duration: 1.467602159s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:08.176791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:06.709041Z","time spent":"1.467741471s","remote":"127.0.0.1:43344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-04-23T02:13:08.176819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.379054218s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.223\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-23T02:13:08.176893Z","caller":"traceutil/trace.go:171","msg":"trace[819694054] range","detail":"{range_begin:/registry/masterleases/199.204.45.223; range_end:; response_count:1; response_revision:518; }","duration":"1.379192921s","start":"2026-04-23T02:13:06.797679Z","end":"2026-04-23T02:13:08.176872Z","steps":["trace[819694054] 'agreement among raft nodes before linearized reading' (duration: 1.37906846s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:08.176935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:06.797654Z","time spent":"1.379275097s","remote":"127.0.0.1:41238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.223\" "} {"level":"warn","ts":"2026-04-23T02:13:08.177106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.185579767s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T02:13:08.177125Z","caller":"traceutil/trace.go:171","msg":"trace[1028722911] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"1.185649823s","start":"2026-04-23T02:13:06.991469Z","end":"2026-04-23T02:13:08.177119Z","steps":["trace[1028722911] 'agreement among raft nodes before linearized reading' (duration: 1.18561807s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:08.177141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:06.991441Z","time spent":"1.185696537s","remote":"127.0.0.1:41204","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-23T02:13:08.177201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.360462659s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-23T02:13:08.177238Z","caller":"traceutil/trace.go:171","msg":"trace[1770897351] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:518; }","duration":"1.360538816s","start":"2026-04-23T02:13:06.816688Z","end":"2026-04-23T02:13:08.177226Z","steps":["trace[1770897351] 'agreement among raft nodes before linearized reading' (duration: 1.36046878s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:08.177266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:06.816664Z","time spent":"1.360595411s","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-23T02:13:12.33083Z","caller":"traceutil/trace.go:171","msg":"trace[645497199] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"124.475322ms","start":"2026-04-23T02:13:12.206314Z","end":"2026-04-23T02:13:12.330789Z","steps":["trace[645497199] 'process raft request' (duration: 100.702909ms)","trace[645497199] 'compare' (duration: 23.418343ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T02:13:12.331535Z","caller":"traceutil/trace.go:171","msg":"trace[564292577] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"123.089323ms","start":"2026-04-23T02:13:12.208431Z","end":"2026-04-23T02:13:12.331521Z","steps":["trace[564292577] 'process raft request' (duration: 122.287233ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:13:12.967978Z","caller":"traceutil/trace.go:171","msg":"trace[1851640262] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"136.314615ms","start":"2026-04-23T02:13:12.83161Z","end":"2026-04-23T02:13:12.967924Z","steps":["trace[1851640262] 'process raft request' (duration: 129.929754ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:13:13.916876Z","caller":"traceutil/trace.go:171","msg":"trace[869842321] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"256.741673ms","start":"2026-04-23T02:13:13.660097Z","end":"2026-04-23T02:13:13.916838Z","steps":["trace[869842321] 'read index received' (duration: 254.778073ms)","trace[869842321] 'applied index is now lower than readState.Index' (duration: 1.96235ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T02:13:13.916979Z","caller":"traceutil/trace.go:171","msg":"trace[92453983] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"291.888704ms","start":"2026-04-23T02:13:13.625051Z","end":"2026-04-23T02:13:13.91694Z","steps":["trace[92453983] 'process raft request' (duration: 289.901862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:13.917144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.994984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T02:13:13.917204Z","caller":"traceutil/trace.go:171","msg":"trace[1297095974] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:615; }","duration":"257.086053ms","start":"2026-04-23T02:13:13.660102Z","end":"2026-04-23T02:13:13.917188Z","steps":["trace[1297095974] 'agreement among raft nodes before linearized reading' (duration: 256.922019ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:13.917221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.48093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T02:13:13.917213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.290231ms","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-23T02:13:13.917281Z","caller":"traceutil/trace.go:171","msg":"trace[1436244664] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:615; }","duration":"162.371848ms","start":"2026-04-23T02:13:13.754894Z","end":"2026-04-23T02:13:13.917266Z","steps":["trace[1436244664] 'agreement among raft nodes before linearized reading' (duration: 162.186692ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:13:13.917286Z","caller":"traceutil/trace.go:171","msg":"trace[155776091] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:615; }","duration":"190.543325ms","start":"2026-04-23T02:13:13.726715Z","end":"2026-04-23T02:13:13.917258Z","steps":["trace[155776091] 'agreement among raft nodes before linearized reading' (duration: 190.476609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:13.917403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.318874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T02:13:13.917506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.009283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T02:13:13.917143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.051179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T02:13:13.918436Z","caller":"traceutil/trace.go:171","msg":"trace[649441412] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:615; }","duration":"226.88879ms","start":"2026-04-23T02:13:13.691445Z","end":"2026-04-23T02:13:13.918334Z","steps":["trace[649441412] 'agreement among raft nodes before linearized reading' (duration: 226.019495ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:13:13.918495Z","caller":"traceutil/trace.go:171","msg":"trace[64605199] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:615; }","duration":"192.425129ms","start":"2026-04-23T02:13:13.726055Z","end":"2026-04-23T02:13:13.91848Z","steps":["trace[64605199] 'agreement among raft nodes before linearized reading' (duration: 191.027368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:13.91751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.414691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T02:13:13.91872Z","caller":"traceutil/trace.go:171","msg":"trace[136594743] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:615; }","duration":"192.668919ms","start":"2026-04-23T02:13:13.726035Z","end":"2026-04-23T02:13:13.918704Z","steps":["trace[136594743] 'agreement among raft nodes before linearized reading' (duration: 191.40185ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:13:13.918175Z","caller":"traceutil/trace.go:171","msg":"trace[2041242103] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:615; }","duration":"226.280207ms","start":"2026-04-23T02:13:13.691869Z","end":"2026-04-23T02:13:13.918149Z","steps":["trace[2041242103] 'agreement among raft nodes before linearized reading' (duration: 225.27283ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:13.917778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.674954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T02:13:13.919058Z","caller":"traceutil/trace.go:171","msg":"trace[771741399] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:615; }","duration":"258.992008ms","start":"2026-04-23T02:13:13.660055Z","end":"2026-04-23T02:13:13.919047Z","steps":["trace[771741399] 'agreement among raft nodes before linearized reading' (duration: 256.924889ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:13:15.728576Z","caller":"traceutil/trace.go:171","msg":"trace[264278188] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"187.295512ms","start":"2026-04-23T02:13:15.541236Z","end":"2026-04-23T02:13:15.728532Z","steps":["trace[264278188] 'process raft request' (duration: 118.574609ms)","trace[264278188] 'compare' (duration: 68.280325ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T02:13:15.728625Z","caller":"traceutil/trace.go:171","msg":"trace[91645945] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"133.604113ms","start":"2026-04-23T02:13:15.594996Z","end":"2026-04-23T02:13:15.7286Z","steps":["trace[91645945] 'process raft request' (duration: 133.405006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:16.384253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.616717ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-23T02:13:16.38441Z","caller":"traceutil/trace.go:171","msg":"trace[994497376] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"477.427293ms","start":"2026-04-23T02:13:15.906923Z","end":"2026-04-23T02:13:16.38435Z","steps":["trace[994497376] 'read index received' (duration: 268.698366ms)","trace[994497376] 'applied index is now lower than readState.Index' (duration: 208.727797ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T02:13:16.384552Z","caller":"traceutil/trace.go:171","msg":"trace[2005471785] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"626.834787ms","start":"2026-04-23T02:13:15.75768Z","end":"2026-04-23T02:13:16.384515Z","steps":["trace[2005471785] 'process raft request' (duration: 417.866269ms)","trace[2005471785] 'compare' (duration: 208.446293ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T02:13:16.384674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:15.757663Z","time spent":"626.981299ms","remote":"127.0.0.1:43334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":688,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T02:13:16.384734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.794954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8kw42\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-23T02:13:16.384806Z","caller":"traceutil/trace.go:171","msg":"trace[1269902339] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8kw42; range_end:; response_count:1; response_revision:628; }","duration":"477.910645ms","start":"2026-04-23T02:13:15.906877Z","end":"2026-04-23T02:13:16.384788Z","steps":["trace[1269902339] 'agreement among raft nodes before linearized reading' (duration: 477.673414ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:16.384832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:15.906852Z","time spent":"477.97467ms","remote":"127.0.0.1:43448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-8kw42\" "} {"level":"info","ts":"2026-04-23T02:13:16.655861Z","caller":"traceutil/trace.go:171","msg":"trace[1681467770] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"515.417106ms","start":"2026-04-23T02:13:16.140417Z","end":"2026-04-23T02:13:16.655834Z","steps":["trace[1681467770] 'process raft request' (duration: 514.370595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:16.656016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:16.140378Z","time spent":"515.557377ms","remote":"127.0.0.1:43344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T02:13:17.501218Z","caller":"traceutil/trace.go:171","msg":"trace[1907246181] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"1.234579891s","start":"2026-04-23T02:13:16.266613Z","end":"2026-04-23T02:13:17.501193Z","steps":["trace[1907246181] 'process raft request' (duration: 1.23433809s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:17.50139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:16.266571Z","time spent":"1.234718694s","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T02:13:17.501372Z","caller":"traceutil/trace.go:171","msg":"trace[665933704] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:651; }","duration":"1.116891006s","start":"2026-04-23T02:13:16.384446Z","end":"2026-04-23T02:13:17.501337Z","steps":["trace[665933704] 'read index received' (duration: 269.959337ms)","trace[665933704] 'applied index is now lower than readState.Index' (duration: 846.929619ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T02:13:17.501692Z","caller":"traceutil/trace.go:171","msg":"trace[1078708674] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"1.097467038s","start":"2026-04-23T02:13:16.40421Z","end":"2026-04-23T02:13:17.501677Z","steps":["trace[1078708674] 'process raft request' (duration: 1.09690987s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:17.50163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.132885185s","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-23T02:13:17.501729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.553968747s","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-23T02:13:17.501792Z","caller":"traceutil/trace.go:171","msg":"trace[122999140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:631; }","duration":"1.133124736s","start":"2026-04-23T02:13:16.368645Z","end":"2026-04-23T02:13:17.50177Z","steps":["trace[122999140] 'agreement among raft nodes before linearized reading' (duration: 1.132752794s)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:13:17.501806Z","caller":"traceutil/trace.go:171","msg":"trace[907875861] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:631; }","duration":"1.554127311s","start":"2026-04-23T02:13:15.94766Z","end":"2026-04-23T02:13:17.501787Z","steps":["trace[907875861] 'agreement among raft nodes before linearized reading' (duration: 1.553778671s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:17.501817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:16.404151Z","time spent":"1.097584198s","remote":"127.0.0.1:43448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T02:13:17.501855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:15.947605Z","time spent":"1.55423852s","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-23T02:13:17.501855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:16.368624Z","time spent":"1.133212823s","remote":"127.0.0.1:43526","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-23T02:13:17.502087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.145535684s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-23T02:13:17.502142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.135072735s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-23T02:13:17.502177Z","caller":"traceutil/trace.go:171","msg":"trace[1447196080] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:631; }","duration":"1.135115589s","start":"2026-04-23T02:13:16.367049Z","end":"2026-04-23T02:13:17.502165Z","steps":["trace[1447196080] 'agreement among raft nodes before linearized reading' (duration: 1.135007589s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:17.502238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:16.367043Z","time spent":"1.135187225s","remote":"127.0.0.1:43526","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-23T02:13:17.502158Z","caller":"traceutil/trace.go:171","msg":"trace[996606880] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:631; }","duration":"1.145664696s","start":"2026-04-23T02:13:16.356475Z","end":"2026-04-23T02:13:17.50214Z","steps":["trace[996606880] 'agreement among raft nodes before linearized reading' (duration: 1.145478679s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:17.50228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:16.356454Z","time spent":"1.145817139s","remote":"127.0.0.1:43526","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-23T02:13:18.075283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.406609ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-23T02:13:18.075656Z","caller":"traceutil/trace.go:171","msg":"trace[2091127643] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"567.716923ms","start":"2026-04-23T02:13:17.507921Z","end":"2026-04-23T02:13:18.075638Z","steps":["trace[2091127643] 'process raft request' (duration: 567.67705ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:13:18.075734Z","caller":"traceutil/trace.go:171","msg":"trace[1058785599] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"569.495759ms","start":"2026-04-23T02:13:17.506218Z","end":"2026-04-23T02:13:18.075714Z","steps":["trace[1058785599] 'process raft request' (duration: 569.242477ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:13:18.07574Z","caller":"traceutil/trace.go:171","msg":"trace[1187674705] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"569.05711ms","start":"2026-04-23T02:13:17.506654Z","end":"2026-04-23T02:13:18.075711Z","steps":["trace[1187674705] 'process raft request' (duration: 568.875145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:18.075819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:17.50791Z","time spent":"567.824153ms","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T02:13:18.075837Z","caller":"traceutil/trace.go:171","msg":"trace[280916087] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"568.681517ms","start":"2026-04-23T02:13:17.507094Z","end":"2026-04-23T02:13:18.075776Z","steps":["trace[280916087] 'process raft request' (duration: 568.470319ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:18.075895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:17.506633Z","time spent":"569.176111ms","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T02:13:18.075885Z","caller":"traceutil/trace.go:171","msg":"trace[1061735644] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"574.188887ms","start":"2026-04-23T02:13:17.501686Z","end":"2026-04-23T02:13:18.075875Z","steps":["trace[1061735644] 'read index received' (duration: 251.144912ms)","trace[1061735644] 'applied index is now lower than readState.Index' (duration: 323.042595ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T02:13:18.075834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:17.506175Z","time spent":"569.609308ms","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T02:13:18.076029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.277740577s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.223\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-23T02:13:18.076057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.085323357s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-23T02:13:18.076043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:17.507085Z","time spent":"568.851532ms","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T02:13:18.076069Z","caller":"traceutil/trace.go:171","msg":"trace[353176328] range","detail":"{range_begin:/registry/masterleases/199.204.45.223; range_end:; response_count:1; response_revision:636; }","duration":"1.277808023s","start":"2026-04-23T02:13:16.79825Z","end":"2026-04-23T02:13:18.076058Z","steps":["trace[353176328] 'agreement among raft nodes before linearized reading' (duration: 1.277684022s)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:13:18.076116Z","caller":"traceutil/trace.go:171","msg":"trace[1878982896] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"1.085406134s","start":"2026-04-23T02:13:16.990684Z","end":"2026-04-23T02:13:18.07609Z","steps":["trace[1878982896] 'agreement among raft nodes before linearized reading' (duration: 1.085335118s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:18.076137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:16.798232Z","time spent":"1.27789487s","remote":"127.0.0.1:41238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.223\" "} {"level":"warn","ts":"2026-04-23T02:13:18.076153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:16.990659Z","time spent":"1.085487311s","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-23T02:13:18.075823Z","caller":"traceutil/trace.go:171","msg":"trace[1263064719] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"1.35971384s","start":"2026-04-23T02:13:16.716082Z","end":"2026-04-23T02:13:18.075795Z","steps":["trace[1263064719] 'process raft request' (duration: 1.03673086s)","trace[1263064719] 'compare' (duration: 322.113644ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T02:13:18.076277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:16.716056Z","time spent":"1.360163319s","remote":"127.0.0.1:43504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T02:13:18.57822Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225685817620325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T02:13:19.078373Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225685817620325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T02:13:19.579406Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225685817620325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T02:13:20.077649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000205034s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-23T02:13:20.077743Z","caller":"traceutil/trace.go:171","msg":"trace[1506234131] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000353007s","start":"2026-04-23T02:13:18.077371Z","end":"2026-04-23T02:13:20.077724Z","steps":["trace[1506234131] 'agreement among raft nodes before linearized reading' (duration: 2.000218606s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:20.077796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:18.077361Z","time spent":"2.000424254s","remote":"127.0.0.1:41220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/23 02:13:20 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-23T02:13:20.079731Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225685817620325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T02:13:20.288732Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.599896746s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-23T02:13:20.614922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.695174146s","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-23T02:13:20.615721Z","caller":"traceutil/trace.go:171","msg":"trace[242293267] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:636; }","duration":"1.695983116s","start":"2026-04-23T02:13:18.919723Z","end":"2026-04-23T02:13:20.615706Z","steps":["trace[242293267] 'range keys from in-memory index tree' (duration: 1.695159505s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:20.615555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.496604ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"warn","ts":"2026-04-23T02:13:20.616105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:18.077112Z","time spent":"2.538989639s","remote":"127.0.0.1:41238","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-23T02:13:20.620367Z","caller":"traceutil/trace.go:171","msg":"trace[807424072] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:659; }","duration":"2.542960507s","start":"2026-04-23T02:13:18.077397Z","end":"2026-04-23T02:13:20.620358Z","steps":["trace[807424072] 'read index received' (duration: 2.211668233s)","trace[807424072] 'applied index is now lower than readState.Index' (duration: 331.291584ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T02:13:20.620505Z","caller":"traceutil/trace.go:171","msg":"trace[1148473662] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"538.566376ms","start":"2026-04-23T02:13:20.081913Z","end":"2026-04-23T02:13:20.620479Z","steps":["trace[1148473662] 'process raft request' (duration: 538.417753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:20.620618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:20.081896Z","time spent":"538.664964ms","remote":"127.0.0.1:43334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-23T02:13:20.620695Z","caller":"traceutil/trace.go:171","msg":"trace[806267056] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"736.913756ms","start":"2026-04-23T02:13:19.883758Z","end":"2026-04-23T02:13:20.620672Z","steps":["trace[806267056] 'process raft request' (duration: 736.432354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:20.620831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:19.883723Z","time spent":"737.033016ms","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T02:13:20.622943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.543022372s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-23T02:13:20.623174Z","caller":"traceutil/trace.go:171","msg":"trace[322834674] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:639; }","duration":"2.543271354s","start":"2026-04-23T02:13:18.079897Z","end":"2026-04-23T02:13:20.623168Z","steps":["trace[322834674] 'agreement among raft nodes before linearized reading' (duration: 2.54300015s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:20.623176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.459929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-23T02:13:20.623209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.467239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-23T02:13:20.623234Z","caller":"traceutil/trace.go:171","msg":"trace[672452646] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:639; }","duration":"541.569988ms","start":"2026-04-23T02:13:20.081654Z","end":"2026-04-23T02:13:20.623224Z","steps":["trace[672452646] 'agreement among raft nodes before linearized reading' (duration: 541.401473ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:13:20.623245Z","caller":"traceutil/trace.go:171","msg":"trace[268463673] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:639; }","duration":"541.518024ms","start":"2026-04-23T02:13:20.081717Z","end":"2026-04-23T02:13:20.623235Z","steps":["trace[268463673] 'agreement among raft nodes before linearized reading' (duration: 541.381162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:20.623266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:20.081626Z","time spent":"541.633924ms","remote":"127.0.0.1:43526","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-23T02:13:20.623269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:20.081712Z","time spent":"541.550936ms","remote":"127.0.0.1:43526","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-23T02:13:20.623095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.691389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T02:13:20.62333Z","caller":"traceutil/trace.go:171","msg":"trace[709848428] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"538.033259ms","start":"2026-04-23T02:13:20.085291Z","end":"2026-04-23T02:13:20.623324Z","steps":["trace[709848428] 'agreement among raft nodes before linearized reading' (duration: 537.783087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:20.623359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:20.085284Z","time spent":"538.069982ms","remote":"127.0.0.1:41204","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-23T02:13:20.623049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.223976ms","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-23T02:13:20.623145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.968591ms","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-23T02:13:20.623469Z","caller":"traceutil/trace.go:171","msg":"trace[1274339520] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:639; }","duration":"538.661724ms","start":"2026-04-23T02:13:20.084798Z","end":"2026-04-23T02:13:20.62346Z","steps":["trace[1274339520] 'agreement among raft nodes before linearized reading' (duration: 538.198544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:20.623519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:20.084786Z","time spent":"538.7246ms","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-23T02:13:20.623522Z","caller":"traceutil/trace.go:171","msg":"trace[34126408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:639; }","duration":"543.370175ms","start":"2026-04-23T02:13:20.08013Z","end":"2026-04-23T02:13:20.6235Z","steps":["trace[34126408] 'agreement among raft nodes before linearized reading' (duration: 542.985241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:20.623586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:20.080103Z","time spent":"543.476795ms","remote":"127.0.0.1:43526","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-23T02:13:20.623268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:18.079889Z","time spent":"2.543328958s","remote":"127.0.0.1:43462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"info","ts":"2026-04-23T02:13:21.082848Z","caller":"traceutil/trace.go:171","msg":"trace[1011758386] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"159.795254ms","start":"2026-04-23T02:13:20.923025Z","end":"2026-04-23T02:13:21.08282Z","steps":["trace[1011758386] 'process raft request' (duration: 159.630669ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:13:21.088937Z","caller":"traceutil/trace.go:171","msg":"trace[384475784] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"156.222422ms","start":"2026-04-23T02:13:20.932699Z","end":"2026-04-23T02:13:21.088921Z","steps":["trace[384475784] 'process raft request' (duration: 156.108212ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:13:22.041601Z","caller":"traceutil/trace.go:171","msg":"trace[437605429] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"112.051762ms","start":"2026-04-23T02:13:21.929517Z","end":"2026-04-23T02:13:22.041569Z","steps":["trace[437605429] 'process raft request' (duration: 111.706767ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:13:22.05431Z","caller":"traceutil/trace.go:171","msg":"trace[1108218681] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"110.310849ms","start":"2026-04-23T02:13:21.943969Z","end":"2026-04-23T02:13:22.05428Z","steps":["trace[1108218681] 'process raft request' (duration: 110.006127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:22.921227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.481709ms","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-23T02:13:22.92143Z","caller":"traceutil/trace.go:171","msg":"trace[1602184540] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:656; }","duration":"282.716806ms","start":"2026-04-23T02:13:22.638688Z","end":"2026-04-23T02:13:22.921404Z","steps":["trace[1602184540] 'range keys from in-memory index tree' (duration: 282.194438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:22.921548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.220519ms","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-23T02:13:22.921731Z","caller":"traceutil/trace.go:171","msg":"trace[430835643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:656; }","duration":"282.379831ms","start":"2026-04-23T02:13:22.639246Z","end":"2026-04-23T02:13:22.921626Z","steps":["trace[430835643] 'range keys from in-memory index tree' (duration: 282.034587ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:22.921319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.494219ms","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-23T02:13:22.921941Z","caller":"traceutil/trace.go:171","msg":"trace[1767881988] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:656; }","duration":"283.064441ms","start":"2026-04-23T02:13:22.638743Z","end":"2026-04-23T02:13:22.921808Z","steps":["trace[1767881988] 'range keys from in-memory index tree' (duration: 282.175827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:22.922275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.946955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-23T02:13:22.922949Z","caller":"traceutil/trace.go:171","msg":"trace[570135926] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:656; }","duration":"284.676417ms","start":"2026-04-23T02:13:22.638253Z","end":"2026-04-23T02:13:22.92293Z","steps":["trace[570135926] 'range keys from in-memory index tree' (duration: 282.63429ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:13:34.087228Z","caller":"traceutil/trace.go:171","msg":"trace[1735287788] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"598.867945ms","start":"2026-04-23T02:13:33.488329Z","end":"2026-04-23T02:13:34.087197Z","steps":["trace[1735287788] 'process raft request' (duration: 598.534444ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:34.087789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:33.488314Z","time spent":"599.004101ms","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T02:13:37.491173Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225685817620633,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T02:13:37.993055Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225685817620633,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T02:13:38.446399Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.645767998s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-23T02:13:38.447094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:36.800498Z","time spent":"1.64658866s","remote":"127.0.0.1:41238","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-23T02:13:38.458757Z","caller":"traceutil/trace.go:171","msg":"trace[1156667645] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"1.379564363s","start":"2026-04-23T02:13:37.079172Z","end":"2026-04-23T02:13:38.458737Z","steps":["trace[1156667645] 'process raft request' (duration: 1.379337667s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:38.458903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:37.079154Z","time spent":"1.37965375s","remote":"127.0.0.1:43504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T02:13:38.458922Z","caller":"traceutil/trace.go:171","msg":"trace[1517614768] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:823; }","duration":"1.468170751s","start":"2026-04-23T02:13:36.990731Z","end":"2026-04-23T02:13:38.458902Z","steps":["trace[1517614768] 'read index received' (duration: 1.456218283s)","trace[1517614768] 'applied index is now lower than readState.Index' (duration: 11.951509ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T02:13:38.459Z","caller":"traceutil/trace.go:171","msg":"trace[1866265210] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"685.889696ms","start":"2026-04-23T02:13:37.773101Z","end":"2026-04-23T02:13:38.458991Z","steps":["trace[1866265210] 'process raft request' (duration: 685.568832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:38.459093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:37.773067Z","time spent":"686.003693ms","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T02:13:38.459121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.468326168s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T02:13:38.459153Z","caller":"traceutil/trace.go:171","msg":"trace[1574686666] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:797; }","duration":"1.468441886s","start":"2026-04-23T02:13:36.990701Z","end":"2026-04-23T02:13:38.459143Z","steps":["trace[1574686666] 'agreement among raft nodes before linearized reading' (duration: 1.468328958s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:38.459281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:36.990688Z","time spent":"1.468574023s","remote":"127.0.0.1:41204","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-23T02:13:38.466286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.431565144s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-23T02:13:38.466581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.464401122s","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-23T02:13:38.466602Z","caller":"traceutil/trace.go:171","msg":"trace[1723984107] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:798; }","duration":"1.431894236s","start":"2026-04-23T02:13:37.03469Z","end":"2026-04-23T02:13:38.466584Z","steps":["trace[1723984107] 'agreement among raft nodes before linearized reading' (duration: 1.431482365s)"],"step_count":1} {"level":"info","ts":"2026-04-23T02:13:38.466664Z","caller":"traceutil/trace.go:171","msg":"trace[1518690065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:798; }","duration":"1.46453644s","start":"2026-04-23T02:13:37.002074Z","end":"2026-04-23T02:13:38.466611Z","steps":["trace[1518690065] 'agreement among raft nodes before linearized reading' (duration: 1.464131338s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:38.466692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:37.034681Z","time spent":"1.431962555s","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-23T02:13:38.466294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.427756206s","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-23T02:13:38.466742Z","caller":"traceutil/trace.go:171","msg":"trace[158870513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:798; }","duration":"1.428222446s","start":"2026-04-23T02:13:37.038508Z","end":"2026-04-23T02:13:38.46673Z","steps":["trace[158870513] 'agreement among raft nodes before linearized reading' (duration: 1.427670227s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:38.466784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:37.038495Z","time spent":"1.428276595s","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-23T02:13:38.466356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.055056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-gg2l9\" ","response":"range_response_count:1 size:5050"} {"level":"info","ts":"2026-04-23T02:13:38.466843Z","caller":"traceutil/trace.go:171","msg":"trace[536352622] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-gg2l9; range_end:; response_count:1; response_revision:798; }","duration":"333.577225ms","start":"2026-04-23T02:13:38.13325Z","end":"2026-04-23T02:13:38.466827Z","steps":["trace[536352622] 'agreement among raft nodes before linearized reading' (duration: 333.030816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:38.466335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.906622ms","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-04-23T02:13:38.466933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:38.133229Z","time spent":"333.642603ms","remote":"127.0.0.1:43448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":5072,"request content":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-gg2l9\" "} {"level":"info","ts":"2026-04-23T02:13:38.466973Z","caller":"traceutil/trace.go:171","msg":"trace[1009752893] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:798; }","duration":"229.589668ms","start":"2026-04-23T02:13:38.237358Z","end":"2026-04-23T02:13:38.466948Z","steps":["trace[1009752893] 'agreement among raft nodes before linearized reading' (duration: 228.904872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:38.466469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.433911613s","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-04-23T02:13:38.467017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:37.002042Z","time spent":"1.464964001s","remote":"127.0.0.1:43526","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-23T02:13:38.467059Z","caller":"traceutil/trace.go:171","msg":"trace[51221157] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:798; }","duration":"1.43451625s","start":"2026-04-23T02:13:37.032526Z","end":"2026-04-23T02:13:38.467042Z","steps":["trace[51221157] 'agreement among raft nodes before linearized reading' (duration: 1.433720216s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:38.466499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.946631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-23T02:13:38.467131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:37.032509Z","time spent":"1.434576019s","remote":"127.0.0.1:43526","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-23T02:13:38.467155Z","caller":"traceutil/trace.go:171","msg":"trace[1652193634] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:798; }","duration":"364.651107ms","start":"2026-04-23T02:13:38.102492Z","end":"2026-04-23T02:13:38.467143Z","steps":["trace[1652193634] 'agreement among raft nodes before linearized reading' (duration: 363.824904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T02:13:38.467189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T02:13:38.102468Z","time spent":"364.711195ms","remote":"127.0.0.1:43526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-23T02:13:52.626355Z","caller":"traceutil/trace.go:171","msg":"trace[1960416781] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"119.862166ms","start":"2026-04-23T02:13:52.506476Z","end":"2026-04-23T02:13:52.626338Z","steps":["trace[1960416781] 'process raft request' (duration: 119.746896ms)"],"step_count":1}