{"level":"warn","ts":"2026-08-20T06:07:17.30016Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-20T06:07:17.300251Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109: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.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-08-20T06:07:17.300442Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-20T06:07:17.300463Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-08-20T06:07:17.300514Z","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-08-20T06:07:17.301205Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-08-20T06:07:17.301323Z","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.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109: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-08-20T06:07:17.326173Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"24.587322ms"} {"level":"info","ts":"2026-08-20T06:07:17.367123Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-08-20T06:07:17.367249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-08-20T06:07:17.367454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-08-20T06:07:17.367559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-20T06:07:17.367662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-08-20T06:07:17.367812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-08-20T06:07:17.383691Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-20T06:07:17.385625Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-20T06:07:17.386978Z","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-08-20T06:07:17.391035Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-20T06:07:17.391244Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-20T06:07:17.391556Z","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-08-20T06:07:17.391711Z","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-08-20T06:07:17.391758Z","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-08-20T06:07:17.396815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-08-20T06:07:17.397074Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-08-20T06:07:17.399255Z","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-08-20T06:07:17.399313Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-08-20T06:07:17.39945Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-08-20T06:07:17.399814Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-20T06:07:17.399926Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-20T06:07:18.068912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-08-20T06:07:18.068975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-08-20T06:07:18.069026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-08-20T06:07:18.069099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-08-20T06:07:18.069121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-08-20T06:07:18.069289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-08-20T06:07:18.069315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-08-20T06:07:18.095637Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-08-20T06:07:18.09569Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-20T06:07:18.095991Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-20T06:07:18.096208Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T06:07:18.096657Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-20T06:07:18.096688Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-20T06:07:18.099113Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"info","ts":"2026-08-20T06:07:18.100483Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-20T06:07:18.129712Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T06:07:18.129922Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-20T06:07:18.130024Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-08-20T06:07:20.504142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.244457ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-20T06:07:20.50538Z","caller":"traceutil/trace.go:171","msg":"trace[1320204896] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"965.639514ms","start":"2026-08-20T06:07:19.539376Z","end":"2026-08-20T06:07:20.505015Z","steps":["trace[1320204896] 'process raft request' (duration: 434.905757ms)","trace[1320204896] 'compare' (duration: 528.081784ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:07:20.505886Z","caller":"traceutil/trace.go:171","msg":"trace[722429507] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:7; }","duration":"881.792983ms","start":"2026-08-20T06:07:19.624022Z","end":"2026-08-20T06:07:20.505815Z","steps":["trace[722429507] 'read index received' (duration: 350.23822ms)","trace[722429507] 'applied index is now lower than readState.Index' (duration: 531.425601ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:07:20.506163Z","caller":"traceutil/trace.go:171","msg":"trace[33102328] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"966.058303ms","start":"2026-08-20T06:07:19.539627Z","end":"2026-08-20T06:07:20.505685Z","steps":["trace[33102328] 'process raft request' (duration: 964.880599ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:20.50642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:19.539325Z","time spent":"966.743656ms","remote":"127.0.0.1:58634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T06:07:20.507097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"967.852549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-20T06:07:20.507163Z","caller":"traceutil/trace.go:171","msg":"trace[1873386820] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11; }","duration":"967.92302ms","start":"2026-08-20T06:07:19.539214Z","end":"2026-08-20T06:07:20.507137Z","steps":["trace[1873386820] 'agreement among raft nodes before linearized reading' (duration: 967.624394ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:20.507209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:19.539209Z","time spent":"967.990571ms","remote":"127.0.0.1:58112","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-08-20T06:07:20.507904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"968.702816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-20T06:07:20.507942Z","caller":"traceutil/trace.go:171","msg":"trace[78610649] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"968.840129ms","start":"2026-08-20T06:07:19.539087Z","end":"2026-08-20T06:07:20.507927Z","steps":["trace[78610649] 'agreement among raft nodes before linearized reading' (duration: 968.731817ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:20.508258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:19.539588Z","time spent":"966.769027ms","remote":"127.0.0.1:58634","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-08-20T06:07:20.509922Z","caller":"traceutil/trace.go:171","msg":"trace[13032971] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"968.593044ms","start":"2026-08-20T06:07:19.539484Z","end":"2026-08-20T06:07:20.508077Z","steps":["trace[13032971] 'process raft request' (duration: 964.808678ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:20.510015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:19.539473Z","time spent":"970.486071ms","remote":"127.0.0.1:58634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T06:07:20.510126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.877221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-20T06:07:20.510152Z","caller":"traceutil/trace.go:171","msg":"trace[1445792980] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"965.914881ms","start":"2026-08-20T06:07:19.54423Z","end":"2026-08-20T06:07:20.510145Z","steps":["trace[1445792980] 'agreement among raft nodes before linearized reading' (duration: 962.437391ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:20.510171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:19.544224Z","time spent":"965.942333ms","remote":"127.0.0.1:58518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-08-20T06:07:20.508275Z","caller":"traceutil/trace.go:171","msg":"trace[562231836] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"927.499023ms","start":"2026-08-20T06:07:19.580516Z","end":"2026-08-20T06:07:20.508015Z","steps":["trace[562231836] 'process raft request' (duration: 924.740848ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:20.510317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:19.580507Z","time spent":"929.79354ms","remote":"127.0.0.1:58364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T06:07:20.510442Z","caller":"traceutil/trace.go:171","msg":"trace[833174363] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"941.340186ms","start":"2026-08-20T06:07:19.566715Z","end":"2026-08-20T06:07:20.508055Z","steps":["trace[833174363] 'process raft request' (duration: 938.155862ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:20.510479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:19.566687Z","time spent":"943.776846ms","remote":"127.0.0.1:58298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T06:07:20.510802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"957.23665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-20T06:07:20.51083Z","caller":"traceutil/trace.go:171","msg":"trace[1316322513] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"957.305312ms","start":"2026-08-20T06:07:19.553519Z","end":"2026-08-20T06:07:20.510824Z","steps":["trace[1316322513] 'agreement among raft nodes before linearized reading' (duration: 954.409644ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:20.510851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:19.553507Z","time spent":"957.340282ms","remote":"127.0.0.1:58244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-08-20T06:07:20.510971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"920.550328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-20T06:07:20.511352Z","caller":"traceutil/trace.go:171","msg":"trace[1407091665] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"968.540853ms","start":"2026-08-20T06:07:19.539488Z","end":"2026-08-20T06:07:20.508029Z","steps":["trace[1407091665] 'process raft request' (duration: 964.884789ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:20.511441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:19.53946Z","time spent":"971.93532ms","remote":"127.0.0.1:58634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T06:07:20.511714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:19.539076Z","time spent":"969.008692ms","remote":"127.0.0.1:58216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-08-20T06:07:20.510996Z","caller":"traceutil/trace.go:171","msg":"trace[1921038458] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"920.67139ms","start":"2026-08-20T06:07:19.590318Z","end":"2026-08-20T06:07:20.510989Z","steps":["trace[1921038458] 'agreement among raft nodes before linearized reading' (duration: 916.324603ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:20.512603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:19.590296Z","time spent":"922.291163ms","remote":"127.0.0.1:58244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-08-20T06:07:20.511881Z","caller":"traceutil/trace.go:171","msg":"trace[1033985709] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"968.592244ms","start":"2026-08-20T06:07:19.539484Z","end":"2026-08-20T06:07:20.508077Z","steps":["trace[1033985709] 'process raft request' (duration: 964.972261ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:20.512831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:19.539443Z","time spent":"973.303459ms","remote":"127.0.0.1:58634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T06:07:21.690581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.241111ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-08-20T06:07:21.690744Z","caller":"traceutil/trace.go:171","msg":"trace[1959071167] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"2.06296442s","start":"2026-08-20T06:07:19.627751Z","end":"2026-08-20T06:07:21.690716Z","steps":["trace[1959071167] 'process raft request' (duration: 1.333520615s)","trace[1959071167] 'compare' (duration: 729.102958ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T06:07:21.690807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:19.627733Z","time spent":"2.063043472s","remote":"127.0.0.1:58560","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-08-20T06:07:21.690793Z","caller":"traceutil/trace.go:171","msg":"trace[110461010] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:14; }","duration":"1.184651856s","start":"2026-08-20T06:07:20.506112Z","end":"2026-08-20T06:07:21.690764Z","steps":["trace[110461010] 'read index received' (duration: 455.133459ms)","trace[110461010] 'applied index is now lower than readState.Index' (duration: 729.477607ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:07:21.690935Z","caller":"traceutil/trace.go:171","msg":"trace[1858454521] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"1.165832828s","start":"2026-08-20T06:07:20.525094Z","end":"2026-08-20T06:07:21.690927Z","steps":["trace[1858454521] 'process raft request' (duration: 1.165797587s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:21.691007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.254715757s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-20T06:07:21.691037Z","caller":"traceutil/trace.go:171","msg":"trace[1872378124] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:19; }","duration":"1.254824819s","start":"2026-08-20T06:07:20.436202Z","end":"2026-08-20T06:07:21.691027Z","steps":["trace[1872378124] 'agreement among raft nodes before linearized reading' (duration: 1.254708236s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:21.691067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:20.43617Z","time spent":"1.25489072s","remote":"127.0.0.1:58462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-08-20T06:07:21.691092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.077720234s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-08-20T06:07:21.691085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.176239177s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-8r7w4\" ","response":"range_response_count:1 size:861"} {"level":"warn","ts":"2026-08-20T06:07:21.691151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.255531402s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-20T06:07:21.691153Z","caller":"traceutil/trace.go:171","msg":"trace[1371671401] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-8r7w4; range_end:; response_count:1; response_revision:19; }","duration":"1.176319969s","start":"2026-08-20T06:07:20.514813Z","end":"2026-08-20T06:07:21.691133Z","steps":["trace[1371671401] 'agreement among raft nodes before linearized reading' (duration: 1.176180766s)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:07:21.691176Z","caller":"traceutil/trace.go:171","msg":"trace[1835767245] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"1.179893071s","start":"2026-08-20T06:07:20.511277Z","end":"2026-08-20T06:07:21.69117Z","steps":["trace[1835767245] 'process raft request' (duration: 1.179404491s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:21.691184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:20.514757Z","time spent":"1.176420951s","remote":"127.0.0.1:58364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":884,"request content":"key:\"/registry/certificatesigningrequests/csr-8r7w4\" "} {"level":"warn","ts":"2026-08-20T06:07:21.691213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:20.511255Z","time spent":"1.179939682s","remote":"127.0.0.1:58634","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-08-20T06:07:21.691243Z","caller":"traceutil/trace.go:171","msg":"trace[987562062] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:19; }","duration":"1.255587854s","start":"2026-08-20T06:07:20.435578Z","end":"2026-08-20T06:07:21.691166Z","steps":["trace[987562062] 'agreement among raft nodes before linearized reading' (duration: 1.255550403s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:21.691275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:20.435556Z","time spent":"1.255711867s","remote":"127.0.0.1:58486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"warn","ts":"2026-08-20T06:07:21.691315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.085370809s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-20T06:07:21.691337Z","caller":"traceutil/trace.go:171","msg":"trace[785349284] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"1.176627685s","start":"2026-08-20T06:07:20.514699Z","end":"2026-08-20T06:07:21.691326Z","steps":["trace[785349284] 'process raft request' (duration: 1.176027913s)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:07:21.691329Z","caller":"traceutil/trace.go:171","msg":"trace[288737669] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19; }","duration":"1.085407949s","start":"2026-08-20T06:07:20.605916Z","end":"2026-08-20T06:07:21.691324Z","steps":["trace[288737669] 'agreement among raft nodes before linearized reading' (duration: 1.085384208s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:21.691378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:20.605904Z","time spent":"1.085470961s","remote":"127.0.0.1:58122","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-08-20T06:07:21.691384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:20.514671Z","time spent":"1.176690897s","remote":"127.0.0.1:58634","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-08-20T06:07:21.691397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.721012ms","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-08-20T06:07:21.691419Z","caller":"traceutil/trace.go:171","msg":"trace[1066399704] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:19; }","duration":"975.785084ms","start":"2026-08-20T06:07:20.715625Z","end":"2026-08-20T06:07:21.69141Z","steps":["trace[1066399704] 'agreement among raft nodes before linearized reading' (duration: 975.751403ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:07:21.691436Z","caller":"traceutil/trace.go:171","msg":"trace[717671937] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"1.176111205s","start":"2026-08-20T06:07:20.515313Z","end":"2026-08-20T06:07:21.691424Z","steps":["trace[717671937] 'process raft request' (duration: 1.175481952s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:21.691438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:20.715612Z","time spent":"975.820524ms","remote":"127.0.0.1:58374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"info","ts":"2026-08-20T06:07:21.691474Z","caller":"traceutil/trace.go:171","msg":"trace[257221782] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"1.176081394s","start":"2026-08-20T06:07:20.515386Z","end":"2026-08-20T06:07:21.691467Z","steps":["trace[257221782] 'process raft request' (duration: 1.175461381s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:21.691504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.176638036s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"warn","ts":"2026-08-20T06:07:21.691509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:20.515379Z","time spent":"1.176114084s","remote":"127.0.0.1:58634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T06:07:21.691521Z","caller":"traceutil/trace.go:171","msg":"trace[198774349] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:19; }","duration":"1.176665676s","start":"2026-08-20T06:07:20.514851Z","end":"2026-08-20T06:07:21.691517Z","steps":["trace[198774349] 'agreement among raft nodes before linearized reading' (duration: 1.176638735s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:21.691149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:20.525069Z","time spent":"1.165886688s","remote":"127.0.0.1:58298","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-08-20T06:07:21.691534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:20.514844Z","time spent":"1.176687676s","remote":"127.0.0.1:58298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3514,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-08-20T06:07:21.691117Z","caller":"traceutil/trace.go:171","msg":"trace[1088668474] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19; }","duration":"1.077768916s","start":"2026-08-20T06:07:20.613339Z","end":"2026-08-20T06:07:21.691108Z","steps":["trace[1088668474] 'agreement among raft nodes before linearized reading' (duration: 1.077722455s)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:07:21.691609Z","caller":"traceutil/trace.go:171","msg":"trace[1271507436] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"1.172745647s","start":"2026-08-20T06:07:20.518856Z","end":"2026-08-20T06:07:21.691602Z","steps":["trace[1271507436] 'process raft request' (duration: 1.172011162s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:21.691621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:20.61333Z","time spent":"1.078286756s","remote":"127.0.0.1:58112","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-08-20T06:07:21.691646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:20.51883Z","time spent":"1.172801188s","remote":"127.0.0.1:58634","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-08-20T06:07:21.691479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.1172139s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-08-20T06:07:21.691865Z","caller":"traceutil/trace.go:171","msg":"trace[741151056] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:19; }","duration":"1.117638199s","start":"2026-08-20T06:07:20.574214Z","end":"2026-08-20T06:07:21.691852Z","steps":["trace[741151056] 'agreement among raft nodes before linearized reading' (duration: 1.1172355s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:21.691898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:20.574179Z","time spent":"1.117708439s","remote":"127.0.0.1:58244","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-08-20T06:07:21.692152Z","caller":"traceutil/trace.go:171","msg":"trace[344675241] transaction","detail":"{read_only:false; number_of_response:0; response_revision:15; }","duration":"1.177208937s","start":"2026-08-20T06:07:20.514933Z","end":"2026-08-20T06:07:21.692142Z","steps":["trace[344675241] 'process raft request' (duration: 1.175842629s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:21.692186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:20.51491Z","time spent":"1.177257858s","remote":"127.0.0.1:58244","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T06:07:21.6915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:20.515299Z","time spent":"1.176159336s","remote":"127.0.0.1:58634","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-08-20T06:07:21.691588Z","caller":"traceutil/trace.go:171","msg":"trace[849799084] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"1.176658406s","start":"2026-08-20T06:07:20.514923Z","end":"2026-08-20T06:07:21.691581Z","steps":["trace[849799084] 'process raft request' (duration: 1.175828049s)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:21.692466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:20.514914Z","time spent":"1.177536154s","remote":"127.0.0.1:58244","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-08-20T06:07:52.538973Z","caller":"traceutil/trace.go:171","msg":"trace[1356605424] linearizableReadLoop","detail":"{readStateIndex:464; appliedIndex:463; }","duration":"135.949576ms","start":"2026-08-20T06:07:52.402998Z","end":"2026-08-20T06:07:52.538947Z","steps":["trace[1356605424] 'read index received' (duration: 127.652501ms)","trace[1356605424] 'applied index is now lower than readState.Index' (duration: 8.296175ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:07:52.539128Z","caller":"traceutil/trace.go:171","msg":"trace[1938385298] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"208.560576ms","start":"2026-08-20T06:07:52.330518Z","end":"2026-08-20T06:07:52.539078Z","steps":["trace[1938385298] 'process raft request' (duration: 200.19857ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:52.539278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.257155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T06:07:52.539352Z","caller":"traceutil/trace.go:171","msg":"trace[31581653] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:444; }","duration":"136.4211ms","start":"2026-08-20T06:07:52.40291Z","end":"2026-08-20T06:07:52.539331Z","steps":["trace[31581653] 'agreement among raft nodes before linearized reading' (duration: 136.262815ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:52.539439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.764469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.109\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-20T06:07:52.539485Z","caller":"traceutil/trace.go:171","msg":"trace[1013688954] range","detail":"{range_begin:/registry/masterleases/199.204.45.109; range_end:; response_count:1; response_revision:444; }","duration":"119.896632ms","start":"2026-08-20T06:07:52.419575Z","end":"2026-08-20T06:07:52.539471Z","steps":["trace[1013688954] 'agreement among raft nodes before linearized reading' (duration: 119.768518ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:07:55.764435Z","caller":"traceutil/trace.go:171","msg":"trace[1971912755] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"476.337797ms","start":"2026-08-20T06:07:55.288069Z","end":"2026-08-20T06:07:55.764406Z","steps":["trace[1971912755] 'process raft request' (duration: 476.218234ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:55.764611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:55.288053Z","time spent":"476.457141ms","remote":"127.0.0.1:58182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T06:07:55.775477Z","caller":"traceutil/trace.go:171","msg":"trace[1819874055] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"483.674738ms","start":"2026-08-20T06:07:55.291785Z","end":"2026-08-20T06:07:55.775459Z","steps":["trace[1819874055] 'process raft request' (duration: 483.522803ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:07:55.77553Z","caller":"traceutil/trace.go:171","msg":"trace[624680831] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"483.180832ms","start":"2026-08-20T06:07:55.292316Z","end":"2026-08-20T06:07:55.775497Z","steps":["trace[624680831] 'process raft request' (duration: 483.10857ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:55.77563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:55.292311Z","time spent":"483.259585ms","remote":"127.0.0.1:58182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T06:07:55.775615Z","caller":"traceutil/trace.go:171","msg":"trace[1180762275] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"478.278138ms","start":"2026-08-20T06:07:55.297236Z","end":"2026-08-20T06:07:55.775514Z","steps":["trace[1180762275] 'process raft request' (duration: 478.206736ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:07:55.775773Z","caller":"traceutil/trace.go:171","msg":"trace[1405982998] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"483.695459ms","start":"2026-08-20T06:07:55.292067Z","end":"2026-08-20T06:07:55.775763Z","steps":["trace[1405982998] 'process raft request' (duration: 483.332267ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:55.775767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:55.291776Z","time spent":"483.753841ms","remote":"127.0.0.1:58182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T06:07:55.775806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:55.292061Z","time spent":"483.72583ms","remote":"127.0.0.1:58182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T06:07:55.775768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:55.297229Z","time spent":"478.492285ms","remote":"127.0.0.1:58182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T06:07:55.775869Z","caller":"traceutil/trace.go:171","msg":"trace[777595210] linearizableReadLoop","detail":"{readStateIndex:517; appliedIndex:507; }","duration":"372.094958ms","start":"2026-08-20T06:07:55.403756Z","end":"2026-08-20T06:07:55.775851Z","steps":["trace[777595210] 'read index received' (duration: 360.974568ms)","trace[777595210] 'applied index is now lower than readState.Index' (duration: 11.11979ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:07:55.775956Z","caller":"traceutil/trace.go:171","msg":"trace[1910054204] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"457.641659ms","start":"2026-08-20T06:07:55.318308Z","end":"2026-08-20T06:07:55.775949Z","steps":["trace[1910054204] 'process raft request' (duration: 457.257607ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:55.77597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.204721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T06:07:55.775992Z","caller":"traceutil/trace.go:171","msg":"trace[179750847] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:497; }","duration":"372.279973ms","start":"2026-08-20T06:07:55.403705Z","end":"2026-08-20T06:07:55.775985Z","steps":["trace[179750847] 'agreement among raft nodes before linearized reading' (duration: 372.212601ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:55.776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:55.318299Z","time spent":"457.674769ms","remote":"127.0.0.1:58182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T06:07:55.776016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:55.403688Z","time spent":"372.323265ms","remote":"127.0.0.1:58112","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-08-20T06:07:55.776059Z","caller":"traceutil/trace.go:171","msg":"trace[211537572] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"478.774144ms","start":"2026-08-20T06:07:55.297271Z","end":"2026-08-20T06:07:55.776045Z","steps":["trace[211537572] 'process raft request' (duration: 478.196366ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:07:55.776096Z","caller":"traceutil/trace.go:171","msg":"trace[751978173] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"473.466767ms","start":"2026-08-20T06:07:55.302624Z","end":"2026-08-20T06:07:55.776091Z","steps":["trace[751978173] 'process raft request' (duration: 472.898919ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:55.776122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:55.302617Z","time spent":"473.492628ms","remote":"127.0.0.1:58182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T06:07:55.77608Z","caller":"traceutil/trace.go:171","msg":"trace[845386582] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"475.361026ms","start":"2026-08-20T06:07:55.300705Z","end":"2026-08-20T06:07:55.776066Z","steps":["trace[845386582] 'process raft request' (duration: 474.788878ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:07:55.776183Z","caller":"traceutil/trace.go:171","msg":"trace[768761992] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"424.429164ms","start":"2026-08-20T06:07:55.351749Z","end":"2026-08-20T06:07:55.776179Z","steps":["trace[768761992] 'process raft request' (duration: 423.915078ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:55.776154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:55.297267Z","time spent":"478.857646ms","remote":"127.0.0.1:58182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T06:07:55.776239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:55.351731Z","time spent":"424.471156ms","remote":"127.0.0.1:58182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T06:07:55.776299Z","caller":"traceutil/trace.go:171","msg":"trace[917922357] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"305.041248ms","start":"2026-08-20T06:07:55.471252Z","end":"2026-08-20T06:07:55.776294Z","steps":["trace[917922357] 'process raft request' (duration: 304.47491ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:55.776328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:55.471225Z","time spent":"305.090629ms","remote":"127.0.0.1:58182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T06:07:55.776292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:55.300683Z","time spent":"475.510371ms","remote":"127.0.0.1:58182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T06:07:55.776163Z","caller":"traceutil/trace.go:171","msg":"trace[29958497] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"437.859147ms","start":"2026-08-20T06:07:55.338295Z","end":"2026-08-20T06:07:55.776154Z","steps":["trace[29958497] 'process raft request' (duration: 437.32238ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:55.776462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:07:55.33826Z","time spent":"438.174307ms","remote":"127.0.0.1:58182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-20T06:07:58.254206Z","caller":"traceutil/trace.go:171","msg":"trace[372533614] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:590; }","duration":"202.757174ms","start":"2026-08-20T06:07:58.051405Z","end":"2026-08-20T06:07:58.254162Z","steps":["trace[372533614] 'read index received' (duration: 202.426403ms)","trace[372533614] 'applied index is now lower than readState.Index' (duration: 329.631µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:07:58.254392Z","caller":"traceutil/trace.go:171","msg":"trace[491641766] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"210.231504ms","start":"2026-08-20T06:07:58.044149Z","end":"2026-08-20T06:07:58.25438Z","steps":["trace[491641766] 'process raft request' (duration: 209.787449ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:07:58.254637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.209758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-20T06:07:58.254707Z","caller":"traceutil/trace.go:171","msg":"trace[1947246915] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:565; }","duration":"203.299392ms","start":"2026-08-20T06:07:58.05139Z","end":"2026-08-20T06:07:58.254689Z","steps":["trace[1947246915] 'agreement among raft nodes before linearized reading' (duration: 203.116596ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:07:58.382991Z","caller":"traceutil/trace.go:171","msg":"trace[1523732772] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"124.059542ms","start":"2026-08-20T06:07:58.258901Z","end":"2026-08-20T06:07:58.382961Z","steps":["trace[1523732772] 'process raft request' (duration: 45.586407ms)","trace[1523732772] 'compare' (duration: 78.268008ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:07:58.383081Z","caller":"traceutil/trace.go:171","msg":"trace[761097173] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:591; }","duration":"119.395002ms","start":"2026-08-20T06:07:58.26347Z","end":"2026-08-20T06:07:58.382865Z","steps":["trace[761097173] 'read index received' (duration: 41.03055ms)","trace[761097173] 'applied index is now lower than readState.Index' (duration: 78.363701ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T06:07:58.383161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.67083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-08-20T06:07:58.383268Z","caller":"traceutil/trace.go:171","msg":"trace[999553033] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:566; }","duration":"119.844056ms","start":"2026-08-20T06:07:58.263412Z","end":"2026-08-20T06:07:58.383256Z","steps":["trace[999553033] 'agreement among raft nodes before linearized reading' (duration: 119.599288ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:08:02.470489Z","caller":"traceutil/trace.go:171","msg":"trace[392894891] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"202.727085ms","start":"2026-08-20T06:08:02.267732Z","end":"2026-08-20T06:08:02.470459Z","steps":["trace[392894891] 'read index received' (duration: 201.425542ms)","trace[392894891] 'applied index is now lower than readState.Index' (duration: 1.299843ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:08:02.470494Z","caller":"traceutil/trace.go:171","msg":"trace[1129401448] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"209.600882ms","start":"2026-08-20T06:08:02.260843Z","end":"2026-08-20T06:08:02.470444Z","steps":["trace[1129401448] 'process raft request' (duration: 208.597559ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:08:02.47078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.998664ms","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-08-20T06:08:02.470904Z","caller":"traceutil/trace.go:171","msg":"trace[1410068218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:592; }","duration":"203.19121ms","start":"2026-08-20T06:08:02.267688Z","end":"2026-08-20T06:08:02.470879Z","steps":["trace[1410068218] 'agreement among raft nodes before linearized reading' (duration: 202.874239ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:08:02.483502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.649593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-n6gmg\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-20T06:08:02.483611Z","caller":"traceutil/trace.go:171","msg":"trace[1266453703] range","detail":"{range_begin:/registry/pods/kube-system/cilium-n6gmg; range_end:; response_count:1; response_revision:593; }","duration":"212.775437ms","start":"2026-08-20T06:08:02.270801Z","end":"2026-08-20T06:08:02.483576Z","steps":["trace[1266453703] 'agreement among raft nodes before linearized reading' (duration: 212.424165ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:08:02.483964Z","caller":"traceutil/trace.go:171","msg":"trace[1226797179] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"180.705206ms","start":"2026-08-20T06:08:02.303246Z","end":"2026-08-20T06:08:02.483951Z","steps":["trace[1226797179] 'process raft request' (duration: 179.789546ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:08:03.086314Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334369831011974455,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-20T06:08:03.3992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.739627ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-20T06:08:03.399482Z","caller":"traceutil/trace.go:171","msg":"trace[2145541861] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"906.434555ms","start":"2026-08-20T06:08:02.492991Z","end":"2026-08-20T06:08:03.399425Z","steps":["trace[2145541861] 'process raft request' (duration: 23.900281ms)","trace[2145541861] 'compare' (duration: 881.085135ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:08:03.399527Z","caller":"traceutil/trace.go:171","msg":"trace[1959555079] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"905.633498ms","start":"2026-08-20T06:08:02.493854Z","end":"2026-08-20T06:08:03.399487Z","steps":["trace[1959555079] 'process raft request' (duration: 905.452772ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:08:03.39966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:08:02.492946Z","time spent":"906.61852ms","remote":"127.0.0.1:58374","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-08-20T06:08:03.399697Z","caller":"traceutil/trace.go:171","msg":"trace[1892705579] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"903.844829ms","start":"2026-08-20T06:08:02.495832Z","end":"2026-08-20T06:08:03.399677Z","steps":["trace[1892705579] 'process raft request' (duration: 903.547669ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:08:03.399709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:08:02.493835Z","time spent":"905.785873ms","remote":"127.0.0.1:58160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T06:08:03.399783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:08:02.495819Z","time spent":"903.921661ms","remote":"127.0.0.1:58374","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-08-20T06:08:03.399911Z","caller":"traceutil/trace.go:171","msg":"trace[1510844011] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"902.606128ms","start":"2026-08-20T06:08:02.497278Z","end":"2026-08-20T06:08:03.399884Z","steps":["trace[1510844011] 'process raft request' (duration: 902.140432ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:08:03.399994Z","caller":"traceutil/trace.go:171","msg":"trace[2134530675] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:621; }","duration":"814.68999ms","start":"2026-08-20T06:08:02.585292Z","end":"2026-08-20T06:08:03.399982Z","steps":["trace[2134530675] 'read index received' (duration: 780.260604ms)","trace[2134530675] 'applied index is now lower than readState.Index' (duration: 34.428446ms)"],"step_count":2} {"level":"warn","ts":"2026-08-20T06:08:03.400008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:08:02.497264Z","time spent":"902.702771ms","remote":"127.0.0.1:58300","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-08-20T06:08:03.400048Z","caller":"traceutil/trace.go:171","msg":"trace[1837728083] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"870.237477ms","start":"2026-08-20T06:08:02.529796Z","end":"2026-08-20T06:08:03.400033Z","steps":["trace[1837728083] 'process raft request' (duration: 869.925196ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:08:03.400112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:08:02.529763Z","time spent":"870.323881ms","remote":"127.0.0.1:58344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-20T06:08:03.400159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"814.873667ms","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-08-20T06:08:03.400198Z","caller":"traceutil/trace.go:171","msg":"trace[1546162987] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:599; }","duration":"814.962769ms","start":"2026-08-20T06:08:02.585223Z","end":"2026-08-20T06:08:03.400186Z","steps":["trace[1546162987] 'agreement among raft nodes before linearized reading' (duration: 814.807874ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:08:03.400231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:08:02.585196Z","time spent":"815.029341ms","remote":"127.0.0.1:58374","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-08-20T06:08:04.638505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.093785ms","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-08-20T06:08:04.638666Z","caller":"traceutil/trace.go:171","msg":"trace[740711235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:609; }","duration":"143.320522ms","start":"2026-08-20T06:08:04.495323Z","end":"2026-08-20T06:08:04.638643Z","steps":["trace[740711235] 'range keys from in-memory index tree' (duration: 142.839626ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:08:08.598686Z","caller":"traceutil/trace.go:171","msg":"trace[984745608] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"111.933781ms","start":"2026-08-20T06:08:08.486727Z","end":"2026-08-20T06:08:08.598661Z","steps":["trace[984745608] 'process raft request' (duration: 111.756585ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:08:16.555177Z","caller":"traceutil/trace.go:171","msg":"trace[531200339] linearizableReadLoop","detail":"{readStateIndex:765; appliedIndex:764; }","duration":"150.954365ms","start":"2026-08-20T06:08:16.404189Z","end":"2026-08-20T06:08:16.555144Z","steps":["trace[531200339] 'read index received' (duration: 150.703186ms)","trace[531200339] 'applied index is now lower than readState.Index' (duration: 249.879µs)"],"step_count":2} {"level":"warn","ts":"2026-08-20T06:08:16.555358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.134561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T06:08:16.555404Z","caller":"traceutil/trace.go:171","msg":"trace[2067956018] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:735; }","duration":"151.223775ms","start":"2026-08-20T06:08:16.404162Z","end":"2026-08-20T06:08:16.555386Z","steps":["trace[2067956018] 'agreement among raft nodes before linearized reading' (duration: 151.120291ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:08:16.555571Z","caller":"traceutil/trace.go:171","msg":"trace[1483593919] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"181.2311ms","start":"2026-08-20T06:08:16.37429Z","end":"2026-08-20T06:08:16.555521Z","steps":["trace[1483593919] 'process raft request' (duration: 180.646339ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:08:19.881653Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334369831011974763,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-20T06:08:19.889013Z","caller":"traceutil/trace.go:171","msg":"trace[85492650] linearizableReadLoop","detail":"{readStateIndex:788; appliedIndex:787; }","duration":"508.067561ms","start":"2026-08-20T06:08:19.380911Z","end":"2026-08-20T06:08:19.888978Z","steps":["trace[85492650] 'read index received' (duration: 507.884054ms)","trace[85492650] 'applied index is now lower than readState.Index' (duration: 182.657µs)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:08:19.889109Z","caller":"traceutil/trace.go:171","msg":"trace[29532808] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"964.466892ms","start":"2026-08-20T06:08:18.924631Z","end":"2026-08-20T06:08:19.889098Z","steps":["trace[29532808] 'process raft request' (duration: 964.213513ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:08:19.88922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:08:18.924603Z","time spent":"964.541795ms","remote":"127.0.0.1:58374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-20T06:08:19.889385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.092365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-20T06:08:19.88948Z","caller":"traceutil/trace.go:171","msg":"trace[260788334] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:757; }","duration":"176.22885ms","start":"2026-08-20T06:08:19.713197Z","end":"2026-08-20T06:08:19.889425Z","steps":["trace[260788334] 'agreement among raft nodes before linearized reading' (duration: 176.109166ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:08:19.889615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.708678ms","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-08-20T06:08:19.889657Z","caller":"traceutil/trace.go:171","msg":"trace[1573676004] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:757; }","duration":"404.772919ms","start":"2026-08-20T06:08:19.484874Z","end":"2026-08-20T06:08:19.889646Z","steps":["trace[1573676004] 'agreement among raft nodes before linearized reading' (duration: 404.640205ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:08:19.889692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:08:19.484863Z","time spent":"404.821622ms","remote":"127.0.0.1:58374","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-08-20T06:08:19.889789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.948616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-20T06:08:19.889725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.813228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7gnm5\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-08-20T06:08:19.889898Z","caller":"traceutil/trace.go:171","msg":"trace[298029000] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7gnm5; range_end:; response_count:1; response_revision:757; }","duration":"509.029826ms","start":"2026-08-20T06:08:19.380858Z","end":"2026-08-20T06:08:19.889888Z","steps":["trace[298029000] 'agreement among raft nodes before linearized reading' (duration: 508.721265ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:08:19.889872Z","caller":"traceutil/trace.go:171","msg":"trace[1008983209] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:757; }","duration":"131.154123ms","start":"2026-08-20T06:08:19.758697Z","end":"2026-08-20T06:08:19.889851Z","steps":["trace[1008983209] 'agreement among raft nodes before linearized reading' (duration: 130.917924ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:08:19.889934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:08:19.380842Z","time spent":"509.084878ms","remote":"127.0.0.1:58300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7gnm5\" "} {"level":"warn","ts":"2026-08-20T06:08:19.890123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.653897ms","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-08-20T06:08:19.89041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.682632ms","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-08-20T06:08:19.890492Z","caller":"traceutil/trace.go:171","msg":"trace[2079012568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:757; }","duration":"408.799527ms","start":"2026-08-20T06:08:19.481652Z","end":"2026-08-20T06:08:19.890451Z","steps":["trace[2079012568] 'agreement among raft nodes before linearized reading' (duration: 407.611544ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:08:19.890536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:08:19.481633Z","time spent":"408.891949ms","remote":"127.0.0.1:58374","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-08-20T06:08:19.890565Z","caller":"traceutil/trace.go:171","msg":"trace[589345022] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:757; }","duration":"383.048951ms","start":"2026-08-20T06:08:19.507381Z","end":"2026-08-20T06:08:19.89043Z","steps":["trace[589345022] 'agreement among raft nodes before linearized reading' (duration: 381.995523ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:08:19.890743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-20T06:08:19.507375Z","time spent":"383.355642ms","remote":"127.0.0.1:58374","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-08-20T06:08:20.105261Z","caller":"traceutil/trace.go:171","msg":"trace[1700695186] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"210.46311ms","start":"2026-08-20T06:08:19.894754Z","end":"2026-08-20T06:08:20.105217Z","steps":["trace[1700695186] 'process raft request' (duration: 209.417101ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:08:20.114488Z","caller":"traceutil/trace.go:171","msg":"trace[2036564348] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"219.561332ms","start":"2026-08-20T06:08:19.894898Z","end":"2026-08-20T06:08:20.11446Z","steps":["trace[2036564348] 'process raft request' (duration: 219.358344ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:08:20.114788Z","caller":"traceutil/trace.go:171","msg":"trace[2124015927] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"219.565512ms","start":"2026-08-20T06:08:19.895195Z","end":"2026-08-20T06:08:20.114761Z","steps":["trace[2124015927] 'process raft request' (duration: 219.217639ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:08:20.11549Z","caller":"traceutil/trace.go:171","msg":"trace[2052272974] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"218.939739ms","start":"2026-08-20T06:08:19.896528Z","end":"2026-08-20T06:08:20.115468Z","steps":["trace[2052272974] 'process raft request' (duration: 218.507054ms)"],"step_count":1} {"level":"warn","ts":"2026-08-20T06:08:20.115737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.161679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-20T06:08:20.115786Z","caller":"traceutil/trace.go:171","msg":"trace[300195715] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:761; }","duration":"151.264133ms","start":"2026-08-20T06:08:19.964508Z","end":"2026-08-20T06:08:20.115773Z","steps":["trace[300195715] 'agreement among raft nodes before linearized reading' (duration: 151.156219ms)"],"step_count":1} {"level":"info","ts":"2026-08-20T06:08:20.115953Z","caller":"traceutil/trace.go:171","msg":"trace[1829279488] linearizableReadLoop","detail":"{readStateIndex:792; appliedIndex:788; }","duration":"150.830097ms","start":"2026-08-20T06:08:19.964557Z","end":"2026-08-20T06:08:20.115387Z","steps":["trace[1829279488] 'read index received' (duration: 139.633568ms)","trace[1829279488] 'applied index is now lower than readState.Index' (duration: 11.195358ms)"],"step_count":2} {"level":"info","ts":"2026-08-20T06:08:23.574213Z","caller":"traceutil/trace.go:171","msg":"trace[203153609] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"127.937128ms","start":"2026-08-20T06:08:23.446244Z","end":"2026-08-20T06:08:23.574181Z","steps":["trace[203153609] 'process raft request' (duration: 127.655917ms)"],"step_count":1}