{"level":"warn","ts":"2026-10-26T21:29:05.225893Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-26T21:29:05.225998Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.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://162.253.55.223:2380","--initial-cluster=instance=https://162.253.55.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.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-10-26T21:29:05.226072Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-26T21:29:05.226085Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.223:2380"]} {"level":"info","ts":"2026-10-26T21:29:05.226108Z","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-10-26T21:29:05.226717Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.223:2379"]} {"level":"info","ts":"2026-10-26T21:29:05.226791Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.223:2380"],"listen-peer-urls":["https://162.253.55.223:2380"],"advertise-client-urls":["https://162.253.55.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.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-10-26T21:29:05.232308Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.288951ms"} {"level":"info","ts":"2026-10-26T21:29:05.239519Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a0f50f8a6c5f7d06","cluster-id":"62f129f77cf8e487"} {"level":"info","ts":"2026-10-26T21:29:05.239582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=()"} {"level":"info","ts":"2026-10-26T21:29:05.239598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became follower at term 0"} {"level":"info","ts":"2026-10-26T21:29:05.239622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a0f50f8a6c5f7d06 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-26T21:29:05.239631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became follower at term 1"} {"level":"info","ts":"2026-10-26T21:29:05.239661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=(11598193502560681222)"} {"level":"warn","ts":"2026-10-26T21:29:05.247594Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-26T21:29:05.249395Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-26T21:29:05.250977Z","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-10-26T21:29:05.253116Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a0f50f8a6c5f7d06","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-26T21:29:05.253211Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a0f50f8a6c5f7d06","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-26T21:29:05.253633Z","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-10-26T21:29:05.25377Z","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-10-26T21:29:05.253855Z","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-10-26T21:29:05.257969Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=(11598193502560681222)"} {"level":"info","ts":"2026-10-26T21:29:05.258177Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62f129f77cf8e487","local-member-id":"a0f50f8a6c5f7d06","added-peer-id":"a0f50f8a6c5f7d06","added-peer-peer-urls":["https://162.253.55.223:2380"]} {"level":"info","ts":"2026-10-26T21:29:05.258448Z","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-10-26T21:29:05.258698Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a0f50f8a6c5f7d06","initial-advertise-peer-urls":["https://162.253.55.223:2380"],"listen-peer-urls":["https://162.253.55.223:2380"],"advertise-client-urls":["https://162.253.55.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-26T21:29:05.258729Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-26T21:29:05.258839Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.223:2380"} {"level":"info","ts":"2026-10-26T21:29:05.25885Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.223:2380"} {"level":"info","ts":"2026-10-26T21:29:06.140455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 is starting a new election at term 1"} {"level":"info","ts":"2026-10-26T21:29:06.14052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-26T21:29:06.140565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 received MsgPreVoteResp from a0f50f8a6c5f7d06 at term 1"} {"level":"info","ts":"2026-10-26T21:29:06.140584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became candidate at term 2"} {"level":"info","ts":"2026-10-26T21:29:06.140594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 received MsgVoteResp from a0f50f8a6c5f7d06 at term 2"} {"level":"info","ts":"2026-10-26T21:29:06.140632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became leader at term 2"} {"level":"info","ts":"2026-10-26T21:29:06.14065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a0f50f8a6c5f7d06 elected leader a0f50f8a6c5f7d06 at term 2"} {"level":"info","ts":"2026-10-26T21:29:06.141699Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T21:29:06.142688Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-26T21:29:06.14269Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a0f50f8a6c5f7d06","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.223:2379]}","request-path":"/0/members/a0f50f8a6c5f7d06/attributes","cluster-id":"62f129f77cf8e487","publish-timeout":"7s"} {"level":"info","ts":"2026-10-26T21:29:06.142863Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-26T21:29:06.143194Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62f129f77cf8e487","local-member-id":"a0f50f8a6c5f7d06","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T21:29:06.143199Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-26T21:29:06.143248Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-26T21:29:06.143354Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T21:29:06.143404Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T21:29:06.145106Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-26T21:29:06.146839Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.223:2379"} {"level":"warn","ts":"2026-10-26T21:29:08.233327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.957431ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-10-26T21:29:08.233654Z","caller":"traceutil/trace.go:171","msg":"trace[1563741549] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"417.740029ms","start":"2026-10-26T21:29:07.815849Z","end":"2026-10-26T21:29:08.233589Z","steps":["trace[1563741549] 'process raft request' (duration: 132.884538ms)","trace[1563741549] 'compare' (duration: 283.786577ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T21:29:08.233814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:07.81583Z","time spent":"417.916953ms","remote":"127.0.0.1:43194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-26T21:29:08.233863Z","caller":"traceutil/trace.go:171","msg":"trace[1587461360] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"402.956421ms","start":"2026-10-26T21:29:07.83079Z","end":"2026-10-26T21:29:08.233747Z","steps":["trace[1587461360] 'process raft request' (duration: 402.832088ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:29:08.233863Z","caller":"traceutil/trace.go:171","msg":"trace[2071227034] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"404.873465ms","start":"2026-10-26T21:29:07.828877Z","end":"2026-10-26T21:29:08.23375Z","steps":["trace[2071227034] 'process raft request' (duration: 404.645329ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:29:08.233946Z","caller":"traceutil/trace.go:171","msg":"trace[1836720934] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"403.155365ms","start":"2026-10-26T21:29:07.830782Z","end":"2026-10-26T21:29:08.233937Z","steps":["trace[1836720934] 'process raft request' (duration: 402.884029ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:29:08.233897Z","caller":"traceutil/trace.go:171","msg":"trace[1279092834] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"403.899503ms","start":"2026-10-26T21:29:07.829848Z","end":"2026-10-26T21:29:08.233747Z","steps":["trace[1279092834] 'process raft request' (duration: 403.725119ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:08.234025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:07.830772Z","time spent":"403.215377ms","remote":"127.0.0.1:43150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-26T21:29:08.234042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:07.830773Z","time spent":"403.181826ms","remote":"127.0.0.1:43294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-26T21:29:08.234105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:07.828866Z","time spent":"405.13545ms","remote":"127.0.0.1:42906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-26T21:29:08.234153Z","caller":"traceutil/trace.go:171","msg":"trace[140066945] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"402.631223ms","start":"2026-10-26T21:29:07.831511Z","end":"2026-10-26T21:29:08.234142Z","steps":["trace[140066945] 'process raft request' (duration: 402.213203ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:08.234218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:07.831493Z","time spent":"402.696145ms","remote":"127.0.0.1:43294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-26T21:29:08.234226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:07.829816Z","time spent":"404.22811ms","remote":"127.0.0.1:42906","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-26T21:29:08.233895Z","caller":"traceutil/trace.go:171","msg":"trace[457327574] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"402.396707ms","start":"2026-10-26T21:29:07.831465Z","end":"2026-10-26T21:29:08.233862Z","steps":["trace[457327574] 'process raft request' (duration: 402.234813ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:29:08.234316Z","caller":"traceutil/trace.go:171","msg":"trace[303412447] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"402.591493ms","start":"2026-10-26T21:29:07.831715Z","end":"2026-10-26T21:29:08.234307Z","steps":["trace[303412447] 'process raft request' (duration: 402.134502ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:08.234342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:07.831444Z","time spent":"402.849988ms","remote":"127.0.0.1:43294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-26T21:29:08.23437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:07.831701Z","time spent":"402.650084ms","remote":"127.0.0.1:43294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-26T21:29:08.234331Z","caller":"traceutil/trace.go:171","msg":"trace[1763769106] linearizableReadLoop","detail":"{readStateIndex:24; appliedIndex:14; }","duration":"387.319374ms","start":"2026-10-26T21:29:07.846957Z","end":"2026-10-26T21:29:08.234277Z","steps":["trace[1763769106] 'read index received' (duration: 101.92499ms)","trace[1763769106] 'applied index is now lower than readState.Index' (duration: 285.393094ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:29:08.234467Z","caller":"traceutil/trace.go:171","msg":"trace[837011402] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"402.710725ms","start":"2026-10-26T21:29:07.831713Z","end":"2026-10-26T21:29:08.234423Z","steps":["trace[837011402] 'process raft request' (duration: 402.103691ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:29:08.234514Z","caller":"traceutil/trace.go:171","msg":"trace[1587954377] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"396.299088ms","start":"2026-10-26T21:29:07.838205Z","end":"2026-10-26T21:29:08.234504Z","steps":["trace[1587954377] 'process raft request' (duration: 395.862968ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:08.234641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.646161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-10-26T21:29:08.234676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:07.831698Z","time spent":"402.858018ms","remote":"127.0.0.1:43294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-26T21:29:08.234734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.382636ms","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-10-26T21:29:08.23479Z","caller":"traceutil/trace.go:171","msg":"trace[1486428157] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:20; }","duration":"258.478398ms","start":"2026-10-26T21:29:07.976297Z","end":"2026-10-26T21:29:08.234775Z","steps":["trace[1486428157] 'agreement among raft nodes before linearized reading' (duration: 258.397296ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:29:08.234743Z","caller":"traceutil/trace.go:171","msg":"trace[1930273829] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"387.819376ms","start":"2026-10-26T21:29:07.846877Z","end":"2026-10-26T21:29:08.234696Z","steps":["trace[1930273829] 'agreement among raft nodes before linearized reading' (duration: 387.635071ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:08.234884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:07.846868Z","time spent":"388.00233ms","remote":"127.0.0.1:42906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-26T21:29:08.234941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.704815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-10-26T21:29:08.234985Z","caller":"traceutil/trace.go:171","msg":"trace[1123137967] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"178.750546ms","start":"2026-10-26T21:29:08.056222Z","end":"2026-10-26T21:29:08.234972Z","steps":["trace[1123137967] 'agreement among raft nodes before linearized reading' (duration: 178.660104ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:08.234823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:07.838185Z","time spent":"396.3588ms","remote":"127.0.0.1:42970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T21:29:08.767514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.754984ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-10-26T21:29:08.767815Z","caller":"traceutil/trace.go:171","msg":"trace[1201414871] linearizableReadLoop","detail":"{readStateIndex:25; appliedIndex:24; }","duration":"526.654168ms","start":"2026-10-26T21:29:08.241106Z","end":"2026-10-26T21:29:08.76776Z","steps":["trace[1201414871] 'read index received' (duration: 383.528µs)","trace[1201414871] 'applied index is now lower than readState.Index' (duration: 526.26871ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:29:08.767859Z","caller":"traceutil/trace.go:171","msg":"trace[1898975806] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"526.743379ms","start":"2026-10-26T21:29:08.241078Z","end":"2026-10-26T21:29:08.767821Z","steps":["trace[1898975806] 'process raft request' (duration: 194.615848ms)","trace[1898975806] 'compare' (duration: 331.560129ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T21:29:08.768018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:08.241046Z","time spent":"526.890113ms","remote":"127.0.0.1:42890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-26T21:29:08.76808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.931184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-10-26T21:29:08.768157Z","caller":"traceutil/trace.go:171","msg":"trace[1682940145] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"527.087998ms","start":"2026-10-26T21:29:08.241051Z","end":"2026-10-26T21:29:08.768139Z","steps":["trace[1682940145] 'agreement among raft nodes before linearized reading' (duration: 526.844232ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:08.768235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:08.241026Z","time spent":"527.200881ms","remote":"127.0.0.1:42906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-10-26T21:29:08.775864Z","caller":"traceutil/trace.go:171","msg":"trace[562153396] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"534.421256ms","start":"2026-10-26T21:29:08.241419Z","end":"2026-10-26T21:29:08.77584Z","steps":["trace[562153396] 'process raft request' (duration: 534.212291ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:29:08.775946Z","caller":"traceutil/trace.go:171","msg":"trace[161278714] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"534.491088ms","start":"2026-10-26T21:29:08.241422Z","end":"2026-10-26T21:29:08.775913Z","steps":["trace[161278714] 'process raft request' (duration: 534.350195ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:08.775997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:08.241401Z","time spent":"534.518409ms","remote":"127.0.0.1:43194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-26T21:29:08.776041Z","caller":"traceutil/trace.go:171","msg":"trace[94758027] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"534.427336ms","start":"2026-10-26T21:29:08.241597Z","end":"2026-10-26T21:29:08.776025Z","steps":["trace[94758027] 'process raft request' (duration: 534.339574ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:08.776116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:08.241398Z","time spent":"534.633552ms","remote":"127.0.0.1:43040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-26T21:29:08.77613Z","caller":"traceutil/trace.go:171","msg":"trace[138646241] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"534.561289ms","start":"2026-10-26T21:29:08.241515Z","end":"2026-10-26T21:29:08.776077Z","steps":["trace[138646241] 'process raft request' (duration: 534.307954ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:08.776212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:08.241579Z","time spent":"534.506338ms","remote":"127.0.0.1:43294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-26T21:29:08.776337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:08.241504Z","time spent":"534.753033ms","remote":"127.0.0.1:43294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-26T21:29:08.776411Z","caller":"traceutil/trace.go:171","msg":"trace[1430126967] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"534.812455ms","start":"2026-10-26T21:29:08.241585Z","end":"2026-10-26T21:29:08.776398Z","steps":["trace[1430126967] 'process raft request' (duration: 534.278014ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:08.776482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:08.24156Z","time spent":"534.886856ms","remote":"127.0.0.1:43294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-26T21:29:08.776259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.554848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-10-26T21:29:08.776404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.945708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-26T21:29:08.776556Z","caller":"traceutil/trace.go:171","msg":"trace[2047381882] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:28; }","duration":"534.964868ms","start":"2026-10-26T21:29:08.241574Z","end":"2026-10-26T21:29:08.776539Z","steps":["trace[2047381882] 'agreement among raft nodes before linearized reading' (duration: 534.515028ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:08.776592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:08.241558Z","time spent":"535.023479ms","remote":"127.0.0.1:42870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" "} {"level":"info","ts":"2026-10-26T21:29:08.776592Z","caller":"traceutil/trace.go:171","msg":"trace[1706446241] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:28; }","duration":"535.172183ms","start":"2026-10-26T21:29:08.241406Z","end":"2026-10-26T21:29:08.776578Z","steps":["trace[1706446241] 'agreement among raft nodes before linearized reading' (duration: 534.961368ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:08.776656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:08.241385Z","time spent":"535.260755ms","remote":"127.0.0.1:42924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"info","ts":"2026-10-26T21:29:08.776777Z","caller":"traceutil/trace.go:171","msg":"trace[474862612] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"535.169123ms","start":"2026-10-26T21:29:08.241596Z","end":"2026-10-26T21:29:08.776765Z","steps":["trace[474862612] 'process raft request' (duration: 534.305334ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:08.77685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:08.241584Z","time spent":"535.222975ms","remote":"127.0.0.1:43294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-26T21:29:08.777288Z","caller":"traceutil/trace.go:171","msg":"trace[2122360690] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"534.391795ms","start":"2026-10-26T21:29:08.241685Z","end":"2026-10-26T21:29:08.776077Z","steps":["trace[2122360690] 'process raft request' (duration: 534.285593ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:08.777988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:08.241656Z","time spent":"535.919091ms","remote":"127.0.0.1:43294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-26T21:29:16.025824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.238315ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T21:29:16.02605Z","caller":"traceutil/trace.go:171","msg":"trace[1344863913] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"303.852446ms","start":"2026-10-26T21:29:15.722179Z","end":"2026-10-26T21:29:16.026032Z","steps":["trace[1344863913] 'process raft request' (duration: 62.297235ms)","trace[1344863913] 'compare' (duration: 241.09294ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T21:29:16.026179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:15.722136Z","time spent":"303.956189ms","remote":"127.0.0.1:43204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3691,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T21:29:16.026208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.798534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-10-26T21:29:16.026295Z","caller":"traceutil/trace.go:171","msg":"trace[866792186] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:312; }","duration":"292.919706ms","start":"2026-10-26T21:29:15.73335Z","end":"2026-10-26T21:29:16.02627Z","steps":["trace[866792186] 'agreement among raft nodes before linearized reading' (duration: 292.777872ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:29:16.025982Z","caller":"traceutil/trace.go:171","msg":"trace[1604179786] linearizableReadLoop","detail":"{readStateIndex:320; appliedIndex:319; }","duration":"292.567998ms","start":"2026-10-26T21:29:15.733399Z","end":"2026-10-26T21:29:16.025967Z","steps":["trace[1604179786] 'read index received' (duration: 50.985895ms)","trace[1604179786] 'applied index is now lower than readState.Index' (duration: 241.581003ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T21:29:16.026775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.129305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-10-26T21:29:16.026824Z","caller":"traceutil/trace.go:171","msg":"trace[354325519] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:312; }","duration":"144.195236ms","start":"2026-10-26T21:29:15.882611Z","end":"2026-10-26T21:29:16.026806Z","steps":["trace[354325519] 'agreement among raft nodes before linearized reading' (duration: 144.119294ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:16.026859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.895223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-10-26T21:29:16.026964Z","caller":"traceutil/trace.go:171","msg":"trace[673004394] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:312; }","duration":"205.042656ms","start":"2026-10-26T21:29:15.821902Z","end":"2026-10-26T21:29:16.026944Z","steps":["trace[673004394] 'agreement among raft nodes before linearized reading' (duration: 204.837463ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:16.027084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.643721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-10-26T21:29:16.027119Z","caller":"traceutil/trace.go:171","msg":"trace[994686745] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:312; }","duration":"244.742654ms","start":"2026-10-26T21:29:15.782366Z","end":"2026-10-26T21:29:16.027109Z","steps":["trace[994686745] 'agreement among raft nodes before linearized reading' (duration: 244.691533ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:16.027167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.606407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-10-26T21:29:16.027222Z","caller":"traceutil/trace.go:171","msg":"trace[846401447] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:312; }","duration":"194.690539ms","start":"2026-10-26T21:29:15.832517Z","end":"2026-10-26T21:29:16.027207Z","steps":["trace[846401447] 'agreement among raft nodes before linearized reading' (duration: 194.612528ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:16.02668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.384864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T21:29:16.02733Z","caller":"traceutil/trace.go:171","msg":"trace[569738646] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:312; }","duration":"293.054048ms","start":"2026-10-26T21:29:15.734267Z","end":"2026-10-26T21:29:16.027321Z","steps":["trace[569738646] 'agreement among raft nodes before linearized reading' (duration: 292.381903ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:29:19.015788Z","caller":"traceutil/trace.go:171","msg":"trace[584706084] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"113.826462ms","start":"2026-10-26T21:29:18.901937Z","end":"2026-10-26T21:29:19.015763Z","steps":["trace[584706084] 'process raft request' (duration: 95.491302ms)","trace[584706084] 'compare' (duration: 18.031702ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:29:56.826412Z","caller":"traceutil/trace.go:171","msg":"trace[368663454] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"136.566124ms","start":"2026-10-26T21:29:56.686267Z","end":"2026-10-26T21:29:56.822833Z","steps":["trace[368663454] 'process raft request' (duration: 134.77269ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:29:57.550641Z","caller":"traceutil/trace.go:171","msg":"trace[948131097] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"133.56558ms","start":"2026-10-26T21:29:57.417048Z","end":"2026-10-26T21:29:57.550614Z","steps":["trace[948131097] 'process raft request' (duration: 46.962967ms)","trace[948131097] 'compare' (duration: 86.46669ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:29:58.117148Z","caller":"traceutil/trace.go:171","msg":"trace[134572962] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"111.156598ms","start":"2026-10-26T21:29:58.00595Z","end":"2026-10-26T21:29:58.117107Z","steps":["trace[134572962] 'process raft request' (duration: 110.217305ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:58.513821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.099811ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-26T21:29:58.513958Z","caller":"traceutil/trace.go:171","msg":"trace[1745825477] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"314.062988ms","start":"2026-10-26T21:29:58.199852Z","end":"2026-10-26T21:29:58.513915Z","steps":["trace[1745825477] 'process raft request' (duration: 119.776372ms)","trace[1745825477] 'compare' (duration: 193.889546ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T21:29:58.514136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:58.199823Z","time spent":"314.231131ms","remote":"127.0.0.1:43116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-26T21:29:59.193728Z","caller":"traceutil/trace.go:171","msg":"trace[500688156] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"459.333466ms","start":"2026-10-26T21:29:58.734361Z","end":"2026-10-26T21:29:59.193695Z","steps":["trace[500688156] 'read index received' (duration: 386.302957ms)","trace[500688156] 'applied index is now lower than readState.Index' (duration: 73.028969ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:29:59.193862Z","caller":"traceutil/trace.go:171","msg":"trace[1496900409] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"616.129209ms","start":"2026-10-26T21:29:58.57772Z","end":"2026-10-26T21:29:59.193849Z","steps":["trace[1496900409] 'process raft request' (duration: 543.538791ms)","trace[1496900409] 'compare' (duration: 72.26629ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T21:29:59.194164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.796168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-26T21:29:59.19417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:58.577684Z","time spent":"616.321064ms","remote":"127.0.0.1:42972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T21:29:59.194227Z","caller":"traceutil/trace.go:171","msg":"trace[1294212665] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"459.864429ms","start":"2026-10-26T21:29:58.734345Z","end":"2026-10-26T21:29:59.194209Z","steps":["trace[1294212665] 'agreement among raft nodes before linearized reading' (duration: 459.744396ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:59.194271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:29:58.734281Z","time spent":"459.983193ms","remote":"127.0.0.1:42786","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-10-26T21:29:59.195237Z","caller":"traceutil/trace.go:171","msg":"trace[178410056] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"189.442218ms","start":"2026-10-26T21:29:59.005756Z","end":"2026-10-26T21:29:59.195199Z","steps":["trace[178410056] 'process raft request' (duration: 188.506765ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:29:59.195447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.776841ms","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-10-26T21:29:59.195539Z","caller":"traceutil/trace.go:171","msg":"trace[1812474630] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:610; }","duration":"268.958296ms","start":"2026-10-26T21:29:58.92656Z","end":"2026-10-26T21:29:59.195518Z","steps":["trace[1812474630] 'agreement among raft nodes before linearized reading' (duration: 268.615747ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:30:55.269786Z","caller":"traceutil/trace.go:171","msg":"trace[531913418] linearizableReadLoop","detail":"{readStateIndex:1097; appliedIndex:1096; }","duration":"394.389021ms","start":"2026-10-26T21:30:54.875372Z","end":"2026-10-26T21:30:55.269761Z","steps":["trace[531913418] 'read index received' (duration: 394.241018ms)","trace[531913418] 'applied index is now lower than readState.Index' (duration: 146.883µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:30:55.269911Z","caller":"traceutil/trace.go:171","msg":"trace[2132918150] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"395.754577ms","start":"2026-10-26T21:30:54.874116Z","end":"2026-10-26T21:30:55.269871Z","steps":["trace[2132918150] 'process raft request' (duration: 395.501111ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:30:55.270001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.608348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-26T21:30:55.270045Z","caller":"traceutil/trace.go:171","msg":"trace[1293290644] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1061; }","duration":"394.72071ms","start":"2026-10-26T21:30:54.875311Z","end":"2026-10-26T21:30:55.270032Z","steps":["trace[1293290644] 'agreement among raft nodes before linearized reading' (duration: 394.543866ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:30:55.270094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:30:54.87529Z","time spent":"394.793602ms","remote":"127.0.0.1:43040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-26T21:30:55.270137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:30:54.874089Z","time spent":"395.927391ms","remote":"127.0.0.1:43040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T21:30:55.549368Z","caller":"traceutil/trace.go:171","msg":"trace[372397161] linearizableReadLoop","detail":"{readStateIndex:1099; appliedIndex:1097; }","duration":"235.406931ms","start":"2026-10-26T21:30:55.313948Z","end":"2026-10-26T21:30:55.549355Z","steps":["trace[372397161] 'read index received' (duration: 221.775173ms)","trace[372397161] 'applied index is now lower than readState.Index' (duration: 13.631048ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:30:55.54954Z","caller":"traceutil/trace.go:171","msg":"trace[1516077359] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"274.834035ms","start":"2026-10-26T21:30:55.274698Z","end":"2026-10-26T21:30:55.549532Z","steps":["trace[1516077359] 'process raft request' (duration: 274.577739ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:30:55.549698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.733239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T21:30:55.549729Z","caller":"traceutil/trace.go:171","msg":"trace[1332459533] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1062; }","duration":"235.813111ms","start":"2026-10-26T21:30:55.313901Z","end":"2026-10-26T21:30:55.549714Z","steps":["trace[1332459533] 'agreement among raft nodes before linearized reading' (duration: 235.756819ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:11.865649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.202045ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T21:31:11.865774Z","caller":"traceutil/trace.go:171","msg":"trace[894887986] linearizableReadLoop","detail":"{readStateIndex:1162; appliedIndex:1161; }","duration":"295.204055ms","start":"2026-10-26T21:31:11.570549Z","end":"2026-10-26T21:31:11.865753Z","steps":["trace[894887986] 'read index received' (duration: 57.781604ms)","trace[894887986] 'applied index is now lower than readState.Index' (duration: 237.420981ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:31:11.865906Z","caller":"traceutil/trace.go:171","msg":"trace[352383685] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"487.844854ms","start":"2026-10-26T21:31:11.378044Z","end":"2026-10-26T21:31:11.865889Z","steps":["trace[352383685] 'process raft request' (duration: 250.267909ms)","trace[352383685] 'compare' (duration: 236.809735ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T21:31:11.865996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:11.37803Z","time spent":"487.919106ms","remote":"127.0.0.1:43040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T21:31:11.866059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.880077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-26T21:31:11.866111Z","caller":"traceutil/trace.go:171","msg":"trace[1049041569] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1122; }","duration":"234.98215ms","start":"2026-10-26T21:31:11.631118Z","end":"2026-10-26T21:31:11.866101Z","steps":["trace[1049041569] 'agreement among raft nodes before linearized reading' (duration: 234.847906ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:11.866125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.575414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T21:31:11.866165Z","caller":"traceutil/trace.go:171","msg":"trace[1596421426] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1122; }","duration":"295.657396ms","start":"2026-10-26T21:31:11.570495Z","end":"2026-10-26T21:31:11.866153Z","steps":["trace[1596421426] 'agreement among raft nodes before linearized reading' (duration: 295.597534ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:11.866206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.351258ms","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-10-26T21:31:11.866222Z","caller":"traceutil/trace.go:171","msg":"trace[671984591] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1122; }","duration":"233.391539ms","start":"2026-10-26T21:31:11.632826Z","end":"2026-10-26T21:31:11.866218Z","steps":["trace[671984591] 'agreement among raft nodes before linearized reading' (duration: 233.351998ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:11.866059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.535276ms","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-10-26T21:31:11.866259Z","caller":"traceutil/trace.go:171","msg":"trace[1549791873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1122; }","duration":"210.782843ms","start":"2026-10-26T21:31:11.655471Z","end":"2026-10-26T21:31:11.866254Z","steps":["trace[1549791873] 'agreement among raft nodes before linearized reading' (duration: 210.505115ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:11.866316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.058221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T21:31:11.866349Z","caller":"traceutil/trace.go:171","msg":"trace[1017726793] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1122; }","duration":"131.142374ms","start":"2026-10-26T21:31:11.735198Z","end":"2026-10-26T21:31:11.866341Z","steps":["trace[1017726793] 'agreement among raft nodes before linearized reading' (duration: 131.097573ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:11.866488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.426025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-26T21:31:11.866666Z","caller":"traceutil/trace.go:171","msg":"trace[513568991] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1122; }","duration":"223.60662ms","start":"2026-10-26T21:31:11.643025Z","end":"2026-10-26T21:31:11.866632Z","steps":["trace[513568991] 'agreement among raft nodes before linearized reading' (duration: 222.972904ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:31:12.091077Z","caller":"traceutil/trace.go:171","msg":"trace[1014083976] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"219.275698ms","start":"2026-10-26T21:31:11.871761Z","end":"2026-10-26T21:31:12.091037Z","steps":["trace[1014083976] 'process raft request' (duration: 195.218505ms)","trace[1014083976] 'compare' (duration: 23.94304ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:31:12.17944Z","caller":"traceutil/trace.go:171","msg":"trace[182750145] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"307.454586ms","start":"2026-10-26T21:31:11.871958Z","end":"2026-10-26T21:31:12.179412Z","steps":["trace[182750145] 'process raft request' (duration: 307.262681ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:12.179668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:11.871945Z","time spent":"307.576759ms","remote":"127.0.0.1:43040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T21:31:12.179905Z","caller":"traceutil/trace.go:171","msg":"trace[1242633] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"307.808335ms","start":"2026-10-26T21:31:11.872081Z","end":"2026-10-26T21:31:12.17989Z","steps":["trace[1242633] 'process raft request' (duration: 307.279851ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:12.179996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:11.872065Z","time spent":"307.884777ms","remote":"127.0.0.1:43040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T21:31:12.180802Z","caller":"traceutil/trace.go:171","msg":"trace[164191944] linearizableReadLoop","detail":"{readStateIndex:1166; appliedIndex:1162; }","duration":"301.884614ms","start":"2026-10-26T21:31:11.878894Z","end":"2026-10-26T21:31:12.180779Z","steps":["trace[164191944] 'read index received' (duration: 188.045113ms)","trace[164191944] 'applied index is now lower than readState.Index' (duration: 113.837781ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T21:31:12.180947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.034468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T21:31:12.180995Z","caller":"traceutil/trace.go:171","msg":"trace[534712475] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1126; }","duration":"302.1182ms","start":"2026-10-26T21:31:11.878859Z","end":"2026-10-26T21:31:12.180977Z","steps":["trace[534712475] 'agreement among raft nodes before linearized reading' (duration: 302.000257ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:12.181038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:11.878845Z","time spent":"302.178441ms","remote":"127.0.0.1:42834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":31,"response size":30,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"info","ts":"2026-10-26T21:31:12.181105Z","caller":"traceutil/trace.go:171","msg":"trace[369664950] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"306.061699ms","start":"2026-10-26T21:31:11.875005Z","end":"2026-10-26T21:31:12.181066Z","steps":["trace[369664950] 'process raft request' (duration: 304.826219ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:12.181303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:11.874989Z","time spent":"306.210194ms","remote":"127.0.0.1:43040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T21:31:12.274167Z","caller":"traceutil/trace.go:171","msg":"trace[1445823758] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"159.257469ms","start":"2026-10-26T21:31:12.114455Z","end":"2026-10-26T21:31:12.273712Z","steps":["trace[1445823758] 'process raft request' (duration: 91.593214ms)","trace[1445823758] 'compare' (duration: 67.438579ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:31:14.274767Z","caller":"traceutil/trace.go:171","msg":"trace[1539142075] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"175.142264ms","start":"2026-10-26T21:31:14.099585Z","end":"2026-10-26T21:31:14.274728Z","steps":["trace[1539142075] 'process raft request' (duration: 174.869327ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:31:14.536024Z","caller":"traceutil/trace.go:171","msg":"trace[682381549] linearizableReadLoop","detail":"{readStateIndex:1170; appliedIndex:1168; }","duration":"350.357019ms","start":"2026-10-26T21:31:14.185641Z","end":"2026-10-26T21:31:14.535998Z","steps":["trace[682381549] 'read index received' (duration: 88.798893ms)","trace[682381549] 'applied index is now lower than readState.Index' (duration: 261.556756ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:31:14.536258Z","caller":"traceutil/trace.go:171","msg":"trace[2009933622] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"391.693544ms","start":"2026-10-26T21:31:14.144546Z","end":"2026-10-26T21:31:14.53624Z","steps":["trace[2009933622] 'process raft request' (duration: 360.216601ms)","trace[2009933622] 'compare' (duration: 31.029841ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:31:14.536305Z","caller":"traceutil/trace.go:171","msg":"trace[332647360] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"280.483159ms","start":"2026-10-26T21:31:14.255814Z","end":"2026-10-26T21:31:14.536297Z","steps":["trace[332647360] 'process raft request' (duration: 280.12345ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:14.5367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:14.144533Z","time spent":"392.058903ms","remote":"127.0.0.1:43040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T21:31:14.536488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.814162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-26T21:31:14.536908Z","caller":"traceutil/trace.go:171","msg":"trace[841818524] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1131; }","duration":"351.289154ms","start":"2026-10-26T21:31:14.185583Z","end":"2026-10-26T21:31:14.536872Z","steps":["trace[841818524] 'agreement among raft nodes before linearized reading' (duration: 350.7547ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:14.537023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:14.185573Z","time spent":"351.407087ms","remote":"127.0.0.1:43040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-26T21:31:14.579033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.125613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T21:31:14.579202Z","caller":"traceutil/trace.go:171","msg":"trace[835722688] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1132; }","duration":"306.360898ms","start":"2026-10-26T21:31:14.272815Z","end":"2026-10-26T21:31:14.579176Z","steps":["trace[835722688] 'agreement among raft nodes before linearized reading' (duration: 306.145533ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:14.579351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:14.272777Z","time spent":"306.547173ms","remote":"127.0.0.1:36780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-10-26T21:31:14.579076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.362846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-26T21:31:14.580061Z","caller":"traceutil/trace.go:171","msg":"trace[1905580637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1132; }","duration":"394.359421ms","start":"2026-10-26T21:31:14.185682Z","end":"2026-10-26T21:31:14.580041Z","steps":["trace[1905580637] 'agreement among raft nodes before linearized reading' (duration: 393.244623ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:14.580312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:14.185676Z","time spent":"394.611528ms","remote":"127.0.0.1:43040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-26T21:31:14.579374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.639383ms","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-10-26T21:31:14.579377Z","caller":"traceutil/trace.go:171","msg":"trace[744480838] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"298.898309ms","start":"2026-10-26T21:31:14.28044Z","end":"2026-10-26T21:31:14.579338Z","steps":["trace[744480838] 'process raft request' (duration: 298.373595ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:14.580653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:14.280415Z","time spent":"300.12806ms","remote":"127.0.0.1:43040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T21:31:14.580783Z","caller":"traceutil/trace.go:171","msg":"trace[1834978162] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1132; }","duration":"395.054289ms","start":"2026-10-26T21:31:14.185707Z","end":"2026-10-26T21:31:14.580762Z","steps":["trace[1834978162] 'agreement among raft nodes before linearized reading' (duration: 393.397308ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:14.580939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:14.185703Z","time spent":"395.200903ms","remote":"127.0.0.1:43040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-26T21:31:15.087604Z","caller":"traceutil/trace.go:171","msg":"trace[767343492] linearizableReadLoop","detail":"{readStateIndex:1175; appliedIndex:1172; }","duration":"496.197427ms","start":"2026-10-26T21:31:14.591381Z","end":"2026-10-26T21:31:15.087578Z","steps":["trace[767343492] 'read index received' (duration: 25.263634ms)","trace[767343492] 'applied index is now lower than readState.Index' (duration: 470.932513ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:31:15.087759Z","caller":"traceutil/trace.go:171","msg":"trace[1255725498] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"502.765084ms","start":"2026-10-26T21:31:14.584979Z","end":"2026-10-26T21:31:15.087744Z","steps":["trace[1255725498] 'process raft request' (duration: 502.546408ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:31:15.087681Z","caller":"traceutil/trace.go:171","msg":"trace[2792915] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"502.863266ms","start":"2026-10-26T21:31:14.584776Z","end":"2026-10-26T21:31:15.087639Z","steps":["trace[2792915] 'process raft request' (duration: 502.588139ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:15.087911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.493145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T21:31:15.088001Z","caller":"traceutil/trace.go:171","msg":"trace[1917979697] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1135; }","duration":"496.633318ms","start":"2026-10-26T21:31:14.591349Z","end":"2026-10-26T21:31:15.087982Z","steps":["trace[1917979697] 'agreement among raft nodes before linearized reading' (duration: 496.451313ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:15.088046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:14.591336Z","time spent":"496.701051ms","remote":"127.0.0.1:42788","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-10-26T21:31:15.088224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:14.58497Z","time spent":"503.00768ms","remote":"127.0.0.1:43040","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-10-26T21:31:15.088224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:14.58475Z","time spent":"503.193915ms","remote":"127.0.0.1:43040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T21:31:15.24883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.393409ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-26T21:31:15.248958Z","caller":"traceutil/trace.go:171","msg":"trace[571586372] linearizableReadLoop","detail":"{readStateIndex:1176; appliedIndex:1175; }","duration":"161.238059ms","start":"2026-10-26T21:31:15.087698Z","end":"2026-10-26T21:31:15.248936Z","steps":["trace[571586372] 'read index received' (duration: 18.978303ms)","trace[571586372] 'applied index is now lower than readState.Index' (duration: 142.257986ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T21:31:15.24923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.023755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T21:31:15.249307Z","caller":"traceutil/trace.go:171","msg":"trace[1670295381] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1135; }","duration":"513.314363ms","start":"2026-10-26T21:31:14.735971Z","end":"2026-10-26T21:31:15.249285Z","steps":["trace[1670295381] 'agreement among raft nodes before linearized reading' (duration: 512.992805ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:15.249331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.830109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-26T21:31:15.249346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:14.73596Z","time spent":"513.379024ms","remote":"127.0.0.1:42786","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-10-26T21:31:15.249376Z","caller":"traceutil/trace.go:171","msg":"trace[1940075850] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1135; }","duration":"561.934922ms","start":"2026-10-26T21:31:14.687426Z","end":"2026-10-26T21:31:15.24936Z","steps":["trace[1940075850] 'agreement among raft nodes before linearized reading' (duration: 561.817179ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:15.249348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.388281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-26T21:31:15.249433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:14.687403Z","time spent":"562.015663ms","remote":"127.0.0.1:43190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-10-26T21:31:15.249445Z","caller":"traceutil/trace.go:171","msg":"trace[1187006348] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1135; }","duration":"538.526905ms","start":"2026-10-26T21:31:14.710894Z","end":"2026-10-26T21:31:15.249421Z","steps":["trace[1187006348] 'agreement among raft nodes before linearized reading' (duration: 538.33313ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:15.249504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:14.710882Z","time spent":"538.606397ms","remote":"127.0.0.1:43226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"info","ts":"2026-10-26T21:31:22.894475Z","caller":"traceutil/trace.go:171","msg":"trace[1137484184] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"181.569327ms","start":"2026-10-26T21:31:22.712878Z","end":"2026-10-26T21:31:22.894447Z","steps":["trace[1137484184] 'process raft request' (duration: 154.663212ms)","trace[1137484184] 'compare' (duration: 26.725571ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:31:22.894601Z","caller":"traceutil/trace.go:171","msg":"trace[1853180355] linearizableReadLoop","detail":"{readStateIndex:1236; appliedIndex:1234; }","duration":"159.072694ms","start":"2026-10-26T21:31:22.735496Z","end":"2026-10-26T21:31:22.894568Z","steps":["trace[1853180355] 'read index received' (duration: 132.021636ms)","trace[1853180355] 'applied index is now lower than readState.Index' (duration: 27.049588ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T21:31:22.894785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.267279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T21:31:22.894834Z","caller":"traceutil/trace.go:171","msg":"trace[1250906040] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1193; }","duration":"159.334231ms","start":"2026-10-26T21:31:22.735483Z","end":"2026-10-26T21:31:22.894817Z","steps":["trace[1250906040] 'agreement among raft nodes before linearized reading' (duration: 159.235808ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:31:22.894822Z","caller":"traceutil/trace.go:171","msg":"trace[1931444550] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"181.840705ms","start":"2026-10-26T21:31:22.712942Z","end":"2026-10-26T21:31:22.894783Z","steps":["trace[1931444550] 'process raft request' (duration: 181.469665ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:23.289725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.282364ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T21:31:23.289921Z","caller":"traceutil/trace.go:171","msg":"trace[58963369] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"163.225881ms","start":"2026-10-26T21:31:23.126648Z","end":"2026-10-26T21:31:23.289874Z","steps":["trace[58963369] 'process raft request' (duration: 55.65223ms)","trace[58963369] 'compare' (duration: 106.792871ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:31:23.31154Z","caller":"traceutil/trace.go:171","msg":"trace[1879921331] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"184.720718ms","start":"2026-10-26T21:31:23.12679Z","end":"2026-10-26T21:31:23.311511Z","steps":["trace[1879921331] 'process raft request' (duration: 184.566084ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:31:23.988834Z","caller":"traceutil/trace.go:171","msg":"trace[11946178] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"143.60164ms","start":"2026-10-26T21:31:23.845194Z","end":"2026-10-26T21:31:23.988796Z","steps":["trace[11946178] 'process raft request' (duration: 143.539499ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:23.989262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.365214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-10-26T21:31:23.989318Z","caller":"traceutil/trace.go:171","msg":"trace[656789615] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1202; }","duration":"145.466637ms","start":"2026-10-26T21:31:23.843837Z","end":"2026-10-26T21:31:23.989304Z","steps":["trace[656789615] 'agreement among raft nodes before linearized reading' (duration: 145.18201ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:31:23.98892Z","caller":"traceutil/trace.go:171","msg":"trace[1853203765] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"180.47788ms","start":"2026-10-26T21:31:23.808408Z","end":"2026-10-26T21:31:23.988886Z","steps":["trace[1853203765] 'process raft request' (duration: 80.522092ms)","trace[1853203765] 'compare' (duration: 99.578939ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:31:23.988909Z","caller":"traceutil/trace.go:171","msg":"trace[197257511] linearizableReadLoop","detail":"{readStateIndex:1244; appliedIndex:1243; }","duration":"145.011105ms","start":"2026-10-26T21:31:23.843871Z","end":"2026-10-26T21:31:23.988882Z","steps":["trace[197257511] 'read index received' (duration: 45.044708ms)","trace[197257511] 'applied index is now lower than readState.Index' (duration: 99.964297ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:31:24.625224Z","caller":"traceutil/trace.go:171","msg":"trace[2035723651] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"201.121236ms","start":"2026-10-26T21:31:24.424081Z","end":"2026-10-26T21:31:24.625203Z","steps":["trace[2035723651] 'process raft request' (duration: 128.504345ms)","trace[2035723651] 'compare' (duration: 72.445596ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T21:31:24.779412Z","caller":"traceutil/trace.go:171","msg":"trace[781203612] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"110.565917ms","start":"2026-10-26T21:31:24.668818Z","end":"2026-10-26T21:31:24.779384Z","steps":["trace[781203612] 'process raft request' (duration: 109.792457ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:31:24.779401Z","caller":"traceutil/trace.go:171","msg":"trace[1516259715] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"108.096655ms","start":"2026-10-26T21:31:24.671274Z","end":"2026-10-26T21:31:24.779371Z","steps":["trace[1516259715] 'process raft request' (duration: 108.012813ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:31:25.980086Z","caller":"traceutil/trace.go:171","msg":"trace[190526649] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"132.054026ms","start":"2026-10-26T21:31:25.848004Z","end":"2026-10-26T21:31:25.980058Z","steps":["trace[190526649] 'process raft request' (duration: 131.884532ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T21:31:26.157427Z","caller":"traceutil/trace.go:171","msg":"trace[270449009] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"134.346364ms","start":"2026-10-26T21:31:26.023049Z","end":"2026-10-26T21:31:26.157396Z","steps":["trace[270449009] 'process raft request' (duration: 132.358344ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:28.109301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.657018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T21:31:28.109394Z","caller":"traceutil/trace.go:171","msg":"trace[1047390752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1231; }","duration":"372.819653ms","start":"2026-10-26T21:31:27.736553Z","end":"2026-10-26T21:31:28.109373Z","steps":["trace[1047390752] 'range keys from in-memory index tree' (duration: 372.540995ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T21:31:28.109437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T21:31:27.736526Z","time spent":"372.902194ms","remote":"127.0.0.1:42788","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-10-26T21:31:28.109507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.340646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-10-26T21:31:28.109744Z","caller":"traceutil/trace.go:171","msg":"trace[1828855593] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1231; }","duration":"209.746837ms","start":"2026-10-26T21:31:27.89997Z","end":"2026-10-26T21:31:28.109717Z","steps":["trace[1828855593] 'range keys from in-memory index tree' (duration: 209.139581ms)"],"step_count":1}