{"level":"warn","ts":"2026-08-26T03:54:54.379653Z","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-26T03:54:54.379744Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.143: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.143:2380","--initial-cluster=instance=https://162.253.55.143:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.143:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.143: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-26T03:54:54.379832Z","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-26T03:54:54.379866Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.143:2380"]} {"level":"info","ts":"2026-08-26T03:54:54.379892Z","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-26T03:54:54.380561Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"]} {"level":"info","ts":"2026-08-26T03:54:54.380696Z","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.143:2380"],"listen-peer-urls":["https://162.253.55.143:2380"],"advertise-client-urls":["https://162.253.55.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.143: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-26T03:54:54.385818Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.876595ms"} {"level":"info","ts":"2026-08-26T03:54:54.395256Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7bf20b54406e85d1","cluster-id":"de54e01795e71fe2"} {"level":"info","ts":"2026-08-26T03:54:54.39537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=()"} {"level":"info","ts":"2026-08-26T03:54:54.395426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became follower at term 0"} {"level":"info","ts":"2026-08-26T03:54:54.395454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7bf20b54406e85d1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-26T03:54:54.395492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became follower at term 1"} {"level":"info","ts":"2026-08-26T03:54:54.395561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=(8931213467515258321)"} {"level":"warn","ts":"2026-08-26T03:54:54.400678Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-26T03:54:54.404027Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-26T03:54:54.406097Z","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-26T03:54:54.40839Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7bf20b54406e85d1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-26T03:54:54.408777Z","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-26T03:54:54.408898Z","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-26T03:54:54.408926Z","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-26T03:54:54.409165Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7bf20b54406e85d1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-26T03:54:54.412576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=(8931213467515258321)"} {"level":"info","ts":"2026-08-26T03:54:54.412969Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de54e01795e71fe2","local-member-id":"7bf20b54406e85d1","added-peer-id":"7bf20b54406e85d1","added-peer-peer-urls":["https://162.253.55.143:2380"]} {"level":"info","ts":"2026-08-26T03:54:54.413348Z","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-26T03:54:54.413508Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.143:2380"} {"level":"info","ts":"2026-08-26T03:54:54.413583Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.143:2380"} {"level":"info","ts":"2026-08-26T03:54:54.413647Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7bf20b54406e85d1","initial-advertise-peer-urls":["https://162.253.55.143:2380"],"listen-peer-urls":["https://162.253.55.143:2380"],"advertise-client-urls":["https://162.253.55.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-26T03:54:54.413718Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-26T03:54:54.996772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 is starting a new election at term 1"} {"level":"info","ts":"2026-08-26T03:54:54.996956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-26T03:54:54.997008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 received MsgPreVoteResp from 7bf20b54406e85d1 at term 1"} {"level":"info","ts":"2026-08-26T03:54:54.997069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became candidate at term 2"} {"level":"info","ts":"2026-08-26T03:54:54.997103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 received MsgVoteResp from 7bf20b54406e85d1 at term 2"} {"level":"info","ts":"2026-08-26T03:54:54.997143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became leader at term 2"} {"level":"info","ts":"2026-08-26T03:54:54.997195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7bf20b54406e85d1 elected leader 7bf20b54406e85d1 at term 2"} {"level":"info","ts":"2026-08-26T03:54:54.998105Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T03:54:54.998805Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7bf20b54406e85d1","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.143:2379]}","request-path":"/0/members/7bf20b54406e85d1/attributes","cluster-id":"de54e01795e71fe2","publish-timeout":"7s"} {"level":"info","ts":"2026-08-26T03:54:54.998933Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-26T03:54:54.999013Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-26T03:54:54.999289Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"de54e01795e71fe2","local-member-id":"7bf20b54406e85d1","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T03:54:54.999424Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T03:54:54.99946Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T03:54:55.002416Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-26T03:54:55.007617Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-26T03:54:55.007655Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-26T03:54:55.015048Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.143:2379"} {"level":"info","ts":"2026-08-26T03:55:11.236613Z","caller":"traceutil/trace.go:171","msg":"trace[889672943] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"279.36434ms","start":"2026-08-26T03:55:10.957219Z","end":"2026-08-26T03:55:11.236584Z","steps":["trace[889672943] 'process raft request' (duration: 279.202885ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:11.439632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.069054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-08-26T03:55:11.439778Z","caller":"traceutil/trace.go:171","msg":"trace[2068435017] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:370; }","duration":"169.267271ms","start":"2026-08-26T03:55:11.270487Z","end":"2026-08-26T03:55:11.439754Z","steps":["trace[2068435017] 'range keys from in-memory index tree' (duration: 168.93561ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:38.956116Z","caller":"traceutil/trace.go:171","msg":"trace[1523324483] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"238.306899ms","start":"2026-08-26T03:55:38.717779Z","end":"2026-08-26T03:55:38.956086Z","steps":["trace[1523324483] 'process raft request' (duration: 236.616553ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:38.956733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.206178ms","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-08-26T03:55:38.956781Z","caller":"traceutil/trace.go:171","msg":"trace[275162112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:584; }","duration":"100.315404ms","start":"2026-08-26T03:55:38.856453Z","end":"2026-08-26T03:55:38.956768Z","steps":["trace[275162112] 'agreement among raft nodes before linearized reading' (duration: 99.542104ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:39.321472Z","caller":"traceutil/trace.go:171","msg":"trace[1338189723] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"360.040574ms","start":"2026-08-26T03:55:38.961396Z","end":"2026-08-26T03:55:39.321437Z","steps":["trace[1338189723] 'process raft request' (duration: 304.03997ms)","trace[1338189723] 'compare' (duration: 55.725273ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T03:55:39.322191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:55:38.961373Z","time spent":"360.185881ms","remote":"127.0.0.1:47150","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-08-26T03:55:39.345884Z","caller":"traceutil/trace.go:171","msg":"trace[1356110886] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:606; }","duration":"259.439494ms","start":"2026-08-26T03:55:39.086427Z","end":"2026-08-26T03:55:39.345867Z","steps":["trace[1356110886] 'read index received' (duration: 179.10721ms)","trace[1356110886] 'applied index is now lower than readState.Index' (duration: 80.331154ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T03:55:39.346077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.652173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-g8n9z\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-26T03:55:39.346157Z","caller":"traceutil/trace.go:171","msg":"trace[1420810984] range","detail":"{range_begin:/registry/pods/kube-system/cilium-g8n9z; range_end:; response_count:1; response_revision:586; }","duration":"259.772728ms","start":"2026-08-26T03:55:39.086374Z","end":"2026-08-26T03:55:39.346146Z","steps":["trace[1420810984] 'agreement among raft nodes before linearized reading' (duration: 259.54874ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:39.346467Z","caller":"traceutil/trace.go:171","msg":"trace[241974426] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"328.028036ms","start":"2026-08-26T03:55:39.018372Z","end":"2026-08-26T03:55:39.3464Z","steps":["trace[241974426] 'process raft request' (duration: 327.429903ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:39.346837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:55:39.018332Z","time spent":"328.3616ms","remote":"127.0.0.1:47090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-26T03:55:39.901864Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9642664457622798395,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T03:55:41.027471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.063489821s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T03:55:41.027636Z","caller":"traceutil/trace.go:171","msg":"trace[1622618298] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:586; }","duration":"1.06366952s","start":"2026-08-26T03:55:39.963943Z","end":"2026-08-26T03:55:41.027612Z","steps":["trace[1622618298] 'range keys from in-memory index tree' (duration: 1.063477031s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:41.028785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"899.276194ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-26T03:55:41.02956Z","caller":"traceutil/trace.go:171","msg":"trace[1273047935] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"1.662398167s","start":"2026-08-26T03:55:39.367107Z","end":"2026-08-26T03:55:41.029505Z","steps":["trace[1273047935] 'process raft request' (duration: 762.077742ms)","trace[1273047935] 'compare' (duration: 898.781604ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T03:55:41.029766Z","caller":"traceutil/trace.go:171","msg":"trace[1580640523] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"1.283465049s","start":"2026-08-26T03:55:39.746163Z","end":"2026-08-26T03:55:41.029628Z","steps":["trace[1580640523] 'process raft request' (duration: 1.282900137s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:41.029886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:55:39.367085Z","time spent":"1.662636167s","remote":"127.0.0.1:47072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-26T03:55:41.029932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.62882204s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-26T03:55:41.029958Z","caller":"traceutil/trace.go:171","msg":"trace[943749623] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:589; }","duration":"1.628936115s","start":"2026-08-26T03:55:39.401016Z","end":"2026-08-26T03:55:41.029952Z","steps":["trace[943749623] 'agreement among raft nodes before linearized reading' (duration: 1.62881049s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:41.02998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:55:39.400989Z","time spent":"1.628985287s","remote":"127.0.0.1:47150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-26T03:55:41.029996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:55:39.746111Z","time spent":"1.28374374s","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036165,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T03:55:41.029805Z","caller":"traceutil/trace.go:171","msg":"trace[368982357] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:608; }","duration":"1.628706446s","start":"2026-08-26T03:55:39.401087Z","end":"2026-08-26T03:55:41.029793Z","steps":["trace[368982357] 'read index received' (duration: 728.184162ms)","trace[368982357] 'applied index is now lower than readState.Index' (duration: 900.520863ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T03:55:41.030328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.466112718s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T03:55:41.030353Z","caller":"traceutil/trace.go:171","msg":"trace[140705710] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"1.466193352s","start":"2026-08-26T03:55:39.564153Z","end":"2026-08-26T03:55:41.030347Z","steps":["trace[140705710] 'agreement among raft nodes before linearized reading' (duration: 1.466154461s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:41.030376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:55:39.564124Z","time spent":"1.466248505s","remote":"127.0.0.1:46854","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-08-26T03:55:41.030529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.42540555s","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-26T03:55:41.03056Z","caller":"traceutil/trace.go:171","msg":"trace[474709879] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:589; }","duration":"1.425476283s","start":"2026-08-26T03:55:39.605078Z","end":"2026-08-26T03:55:41.030555Z","steps":["trace[474709879] 'agreement among raft nodes before linearized reading' (duration: 1.42540724s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:41.030581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:55:39.605067Z","time spent":"1.425510035s","remote":"127.0.0.1:47150","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-26T03:55:41.031058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.260395ms","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-26T03:55:41.031133Z","caller":"traceutil/trace.go:171","msg":"trace[355461108] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:589; }","duration":"590.377809ms","start":"2026-08-26T03:55:40.44074Z","end":"2026-08-26T03:55:41.031118Z","steps":["trace[355461108] 'agreement among raft nodes before linearized reading' (duration: 589.565966ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:41.03117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:55:40.440708Z","time spent":"590.454242ms","remote":"127.0.0.1:47150","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-26T03:55:44.276233Z","caller":"traceutil/trace.go:171","msg":"trace[1755267759] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"142.02162ms","start":"2026-08-26T03:55:44.134162Z","end":"2026-08-26T03:55:44.276184Z","steps":["trace[1755267759] 'process raft request' (duration: 133.978824ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:45.667152Z","caller":"traceutil/trace.go:171","msg":"trace[1164913515] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"494.593296ms","start":"2026-08-26T03:55:45.172532Z","end":"2026-08-26T03:55:45.667125Z","steps":["trace[1164913515] 'read index received' (duration: 494.400388ms)","trace[1164913515] 'applied index is now lower than readState.Index' (duration: 191.518µs)"],"step_count":2} {"level":"info","ts":"2026-08-26T03:55:45.667203Z","caller":"traceutil/trace.go:171","msg":"trace[1715386930] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"518.853605ms","start":"2026-08-26T03:55:45.148308Z","end":"2026-08-26T03:55:45.667162Z","steps":["trace[1715386930] 'process raft request' (duration: 518.651527ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:45.667513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.958401ms","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-26T03:55:45.6676Z","caller":"traceutil/trace.go:171","msg":"trace[1969891206] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:629; }","duration":"495.099767ms","start":"2026-08-26T03:55:45.172479Z","end":"2026-08-26T03:55:45.667578Z","steps":["trace[1969891206] 'agreement among raft nodes before linearized reading' (duration: 494.742623ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:45.667525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.430421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-26T03:55:45.667647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:55:45.172453Z","time spent":"495.18201ms","remote":"127.0.0.1:47150","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-26T03:55:45.667647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.904289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-08-26T03:55:45.667696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:55:45.148281Z","time spent":"519.317784ms","remote":"127.0.0.1:46946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":712,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-26T03:55:45.667706Z","caller":"traceutil/trace.go:171","msg":"trace[1301752482] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:629; }","duration":"325.627179ms","start":"2026-08-26T03:55:45.342055Z","end":"2026-08-26T03:55:45.667682Z","steps":["trace[1301752482] 'agreement among raft nodes before linearized reading' (duration: 325.308086ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:45.667525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.52086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T03:55:45.667758Z","caller":"traceutil/trace.go:171","msg":"trace[1173339075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"105.816022ms","start":"2026-08-26T03:55:45.56193Z","end":"2026-08-26T03:55:45.667746Z","steps":["trace[1173339075] 'agreement among raft nodes before linearized reading' (duration: 105.52724ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:45.66776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:55:45.34204Z","time spent":"325.706373ms","remote":"127.0.0.1:47150","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":"info","ts":"2026-08-26T03:55:45.667713Z","caller":"traceutil/trace.go:171","msg":"trace[264636219] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:629; }","duration":"495.020334ms","start":"2026-08-26T03:55:45.172676Z","end":"2026-08-26T03:55:45.667696Z","steps":["trace[264636219] 'agreement among raft nodes before linearized reading' (duration: 494.841426ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:45.667884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:55:45.172631Z","time spent":"495.238642ms","remote":"127.0.0.1:47150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-26T03:55:45.667512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.91961ms","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-26T03:55:45.667997Z","caller":"traceutil/trace.go:171","msg":"trace[1346554595] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:629; }","duration":"495.483672ms","start":"2026-08-26T03:55:45.172498Z","end":"2026-08-26T03:55:45.667982Z","steps":["trace[1346554595] 'agreement among raft nodes before linearized reading' (duration: 494.830936ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:45.668072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:55:45.172472Z","time spent":"495.554275ms","remote":"127.0.0.1:47150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-26T03:55:45.890005Z","caller":"traceutil/trace.go:171","msg":"trace[781058213] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"217.776405ms","start":"2026-08-26T03:55:45.672195Z","end":"2026-08-26T03:55:45.889972Z","steps":["trace[781058213] 'process raft request' (duration: 208.103101ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:45.894141Z","caller":"traceutil/trace.go:171","msg":"trace[1892932523] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"221.672234ms","start":"2026-08-26T03:55:45.67244Z","end":"2026-08-26T03:55:45.894113Z","steps":["trace[1892932523] 'process raft request' (duration: 221.476216ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:45.894468Z","caller":"traceutil/trace.go:171","msg":"trace[1645861796] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"221.542558ms","start":"2026-08-26T03:55:45.672893Z","end":"2026-08-26T03:55:45.894436Z","steps":["trace[1645861796] 'process raft request' (duration: 221.171983ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:45.89454Z","caller":"traceutil/trace.go:171","msg":"trace[2113513856] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"221.599201ms","start":"2026-08-26T03:55:45.672929Z","end":"2026-08-26T03:55:45.894528Z","steps":["trace[2113513856] 'process raft request' (duration: 221.396243ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:46.589171Z","caller":"traceutil/trace.go:171","msg":"trace[1586637808] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"286.376876ms","start":"2026-08-26T03:55:46.302764Z","end":"2026-08-26T03:55:46.58914Z","steps":["trace[1586637808] 'process raft request' (duration: 283.270498ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:46.59218Z","caller":"traceutil/trace.go:171","msg":"trace[775208003] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"286.23011ms","start":"2026-08-26T03:55:46.305927Z","end":"2026-08-26T03:55:46.592157Z","steps":["trace[775208003] 'process raft request' (duration: 286.030962ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:48.068235Z","caller":"traceutil/trace.go:171","msg":"trace[910691149] linearizableReadLoop","detail":"{readStateIndex:701; appliedIndex:700; }","duration":"126.897903ms","start":"2026-08-26T03:55:47.941314Z","end":"2026-08-26T03:55:48.068212Z","steps":["trace[910691149] 'read index received' (duration: 126.362531ms)","trace[910691149] 'applied index is now lower than readState.Index' (duration: 534.142µs)"],"step_count":2} {"level":"info","ts":"2026-08-26T03:55:48.068297Z","caller":"traceutil/trace.go:171","msg":"trace[1568949355] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"167.007252ms","start":"2026-08-26T03:55:47.901272Z","end":"2026-08-26T03:55:48.068279Z","steps":["trace[1568949355] 'process raft request' (duration: 166.403937ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:48.068478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.266506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-08-26T03:55:48.068508Z","caller":"traceutil/trace.go:171","msg":"trace[74477749] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:678; }","duration":"169.331688ms","start":"2026-08-26T03:55:47.899169Z","end":"2026-08-26T03:55:48.068501Z","steps":["trace[74477749] 'agreement among raft nodes before linearized reading' (duration: 169.14156ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:48.068547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.407179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T03:55:48.068892Z","caller":"traceutil/trace.go:171","msg":"trace[1492951051] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:678; }","duration":"167.781604ms","start":"2026-08-26T03:55:47.901058Z","end":"2026-08-26T03:55:48.06884Z","steps":["trace[1492951051] 'agreement among raft nodes before linearized reading' (duration: 167.344636ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:48.12366Z","caller":"traceutil/trace.go:171","msg":"trace[2078105235] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"135.449535ms","start":"2026-08-26T03:55:47.988181Z","end":"2026-08-26T03:55:48.123631Z","steps":["trace[2078105235] 'process raft request' (duration: 135.384531ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:48.123813Z","caller":"traceutil/trace.go:171","msg":"trace[1039099088] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"138.958519ms","start":"2026-08-26T03:55:47.984835Z","end":"2026-08-26T03:55:48.123794Z","steps":["trace[1039099088] 'process raft request' (duration: 138.691447ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:48.124043Z","caller":"traceutil/trace.go:171","msg":"trace[64105714] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"178.883481ms","start":"2026-08-26T03:55:47.945144Z","end":"2026-08-26T03:55:48.124028Z","steps":["trace[64105714] 'process raft request' (duration: 178.227023ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:54.313713Z","caller":"traceutil/trace.go:171","msg":"trace[850181240] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"198.562395ms","start":"2026-08-26T03:55:54.115085Z","end":"2026-08-26T03:55:54.313647Z","steps":["trace[850181240] 'process raft request' (duration: 198.351646ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:54.382863Z","caller":"traceutil/trace.go:171","msg":"trace[1121882601] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"238.843703ms","start":"2026-08-26T03:55:54.143999Z","end":"2026-08-26T03:55:54.382843Z","steps":["trace[1121882601] 'process raft request' (duration: 238.689216ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:54.382862Z","caller":"traceutil/trace.go:171","msg":"trace[1581423991] linearizableReadLoop","detail":"{readStateIndex:749; appliedIndex:747; }","duration":"234.734408ms","start":"2026-08-26T03:55:54.1481Z","end":"2026-08-26T03:55:54.382835Z","steps":["trace[1581423991] 'read index received' (duration: 165.390339ms)","trace[1581423991] 'applied index is now lower than readState.Index' (duration: 69.340049ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T03:55:54.383144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.020111ms","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-26T03:55:54.383215Z","caller":"traceutil/trace.go:171","msg":"trace[59912051] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:723; }","duration":"235.144196ms","start":"2026-08-26T03:55:54.148059Z","end":"2026-08-26T03:55:54.383203Z","steps":["trace[59912051] 'agreement among raft nodes before linearized reading' (duration: 234.877585ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:55:54.383609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.164531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-08-26T03:55:54.383592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.634874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-08-26T03:55:54.383718Z","caller":"traceutil/trace.go:171","msg":"trace[901908644] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:723; }","duration":"220.313528ms","start":"2026-08-26T03:55:54.163363Z","end":"2026-08-26T03:55:54.383677Z","steps":["trace[901908644] 'agreement among raft nodes before linearized reading' (duration: 220.032306ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:54.383718Z","caller":"traceutil/trace.go:171","msg":"trace[286603593] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:723; }","duration":"230.790561ms","start":"2026-08-26T03:55:54.152896Z","end":"2026-08-26T03:55:54.383687Z","steps":["trace[286603593] 'agreement among raft nodes before linearized reading' (duration: 230.338522ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:55:54.61987Z","caller":"traceutil/trace.go:171","msg":"trace[1523860062] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"117.924128ms","start":"2026-08-26T03:55:54.501901Z","end":"2026-08-26T03:55:54.619825Z","steps":["trace[1523860062] 'process raft request' (duration: 101.716592ms)","trace[1523860062] 'compare' (duration: 15.734736ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T03:56:01.823635Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9642664457622798757,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T03:56:02.254758Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.023707027s","expected-duration":"1s"} {"level":"info","ts":"2026-08-26T03:56:02.25521Z","caller":"traceutil/trace.go:171","msg":"trace[1527766385] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"1.024271962s","start":"2026-08-26T03:56:01.23091Z","end":"2026-08-26T03:56:02.255182Z","steps":["trace[1527766385] 'process raft request' (duration: 1.024091684s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:56:02.255375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:56:01.230881Z","time spent":"1.024407808s","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5052,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T03:56:02.352702Z","caller":"traceutil/trace.go:171","msg":"trace[296752115] linearizableReadLoop","detail":"{readStateIndex:803; appliedIndex:800; }","duration":"1.029426781s","start":"2026-08-26T03:56:01.323246Z","end":"2026-08-26T03:56:02.352673Z","steps":["trace[296752115] 'read index received' (duration: 931.842531ms)","trace[296752115] 'applied index is now lower than readState.Index' (duration: 97.582909ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T03:56:02.352742Z","caller":"traceutil/trace.go:171","msg":"trace[1650489803] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"1.107462005s","start":"2026-08-26T03:56:01.245232Z","end":"2026-08-26T03:56:02.352694Z","steps":["trace[1650489803] 'process raft request' (duration: 1.085245966s)","trace[1650489803] 'compare' (duration: 21.640354ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T03:56:02.352808Z","caller":"traceutil/trace.go:171","msg":"trace[1000781290] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"678.436213ms","start":"2026-08-26T03:56:01.674343Z","end":"2026-08-26T03:56:02.352779Z","steps":["trace[1000781290] 'process raft request' (duration: 678.191513ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:56:02.352971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.464221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-26T03:56:02.353008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.029738044s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-26T03:56:02.353054Z","caller":"traceutil/trace.go:171","msg":"trace[1854759142] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:775; }","duration":"817.559915ms","start":"2026-08-26T03:56:01.535476Z","end":"2026-08-26T03:56:02.353036Z","steps":["trace[1854759142] 'agreement among raft nodes before linearized reading' (duration: 817.423829ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:56:02.353035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:56:01.245223Z","time spent":"1.107603091s","remote":"127.0.0.1:47128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T03:56:02.353055Z","caller":"traceutil/trace.go:171","msg":"trace[776199225] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:775; }","duration":"1.029819038s","start":"2026-08-26T03:56:01.323224Z","end":"2026-08-26T03:56:02.353043Z","steps":["trace[776199225] 'agreement among raft nodes before linearized reading' (duration: 1.029656471s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:56:02.353098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:56:01.535397Z","time spent":"817.691161ms","remote":"127.0.0.1:47072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":12,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-08-26T03:56:02.353089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:56:01.674313Z","time spent":"678.684804ms","remote":"127.0.0.1:47150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-26T03:56:02.35314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:56:01.323151Z","time spent":"1.029976165s","remote":"127.0.0.1:47224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":14,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-08-26T03:56:02.353294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.792178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-26T03:56:02.353388Z","caller":"traceutil/trace.go:171","msg":"trace[949205003] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:775; }","duration":"316.945594ms","start":"2026-08-26T03:56:02.036421Z","end":"2026-08-26T03:56:02.353367Z","steps":["trace[949205003] 'agreement among raft nodes before linearized reading' (duration: 316.63792ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:56:02.353459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:56:02.036397Z","time spent":"317.052618ms","remote":"127.0.0.1:47150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-26T03:56:02.533959Z","caller":"traceutil/trace.go:171","msg":"trace[1622997971] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"176.113796ms","start":"2026-08-26T03:56:02.357808Z","end":"2026-08-26T03:56:02.533921Z","steps":["trace[1622997971] 'process raft request' (duration: 117.819082ms)","trace[1622997971] 'compare' (duration: 58.158378ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T03:56:02.538127Z","caller":"traceutil/trace.go:171","msg":"trace[914378955] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"179.818778ms","start":"2026-08-26T03:56:02.358291Z","end":"2026-08-26T03:56:02.53811Z","steps":["trace[914378955] 'process raft request' (duration: 179.302766ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:56:03.386887Z","caller":"traceutil/trace.go:171","msg":"trace[749067059] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"140.039723ms","start":"2026-08-26T03:56:03.246821Z","end":"2026-08-26T03:56:03.38686Z","steps":["trace[749067059] 'process raft request' (duration: 139.894217ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:56:34.922336Z","caller":"traceutil/trace.go:171","msg":"trace[201710201] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"174.543481ms","start":"2026-08-26T03:56:34.747756Z","end":"2026-08-26T03:56:34.922299Z","steps":["trace[201710201] 'process raft request' (duration: 174.176584ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:56:34.922501Z","caller":"traceutil/trace.go:171","msg":"trace[229868661] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"174.101949ms","start":"2026-08-26T03:56:34.748371Z","end":"2026-08-26T03:56:34.922473Z","steps":["trace[229868661] 'process raft request' (duration: 173.831016ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:56:34.922661Z","caller":"traceutil/trace.go:171","msg":"trace[287018410] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"171.463154ms","start":"2026-08-26T03:56:34.750988Z","end":"2026-08-26T03:56:34.922451Z","steps":["trace[287018410] 'process raft request' (duration: 171.394061ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:56:53.213215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.08169ms","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-26T03:56:53.213331Z","caller":"traceutil/trace.go:171","msg":"trace[1436733454] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1072; }","duration":"196.212766ms","start":"2026-08-26T03:56:53.017092Z","end":"2026-08-26T03:56:53.213305Z","steps":["trace[1436733454] 'range keys from in-memory index tree' (duration: 195.802156ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:56:53.213354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.940624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-08-26T03:56:53.213414Z","caller":"traceutil/trace.go:171","msg":"trace[1383977109] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1072; }","duration":"160.052149ms","start":"2026-08-26T03:56:53.053349Z","end":"2026-08-26T03:56:53.213401Z","steps":["trace[1383977109] 'range keys from in-memory index tree' (duration: 159.756744ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:56:53.213254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.801318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-08-26T03:56:53.213719Z","caller":"traceutil/trace.go:171","msg":"trace[1967282239] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1072; }","duration":"159.314233ms","start":"2026-08-26T03:56:53.054376Z","end":"2026-08-26T03:56:53.21369Z","steps":["trace[1967282239] 'range keys from in-memory index tree' (duration: 158.566747ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:56:54.254511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.923708ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-26T03:56:54.254818Z","caller":"traceutil/trace.go:171","msg":"trace[87347281] linearizableReadLoop","detail":"{readStateIndex:1115; appliedIndex:1114; }","duration":"691.004278ms","start":"2026-08-26T03:56:53.563759Z","end":"2026-08-26T03:56:54.254763Z","steps":["trace[87347281] 'read index received' (duration: 178.968194ms)","trace[87347281] 'applied index is now lower than readState.Index' (duration: 512.022273ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T03:56:54.254939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.161705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T03:56:54.255038Z","caller":"traceutil/trace.go:171","msg":"trace[1634279981] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1075; }","duration":"691.322103ms","start":"2026-08-26T03:56:53.563692Z","end":"2026-08-26T03:56:54.255014Z","steps":["trace[1634279981] 'agreement among raft nodes before linearized reading' (duration: 691.154135ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:56:54.255081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:56:53.563665Z","time spent":"691.407807ms","remote":"127.0.0.1:46854","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-26T03:56:54.255095Z","caller":"traceutil/trace.go:171","msg":"trace[947104977] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"520.362041ms","start":"2026-08-26T03:56:53.734672Z","end":"2026-08-26T03:56:54.255034Z","steps":["trace[947104977] 'process raft request' (duration: 519.980932ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:56:54.255275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T03:56:53.734641Z","time spent":"520.537889ms","remote":"127.0.0.1:47150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T03:56:55.036667Z","caller":"traceutil/trace.go:171","msg":"trace[1955637294] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"145.047728ms","start":"2026-08-26T03:56:54.891565Z","end":"2026-08-26T03:56:55.036613Z","steps":["trace[1955637294] 'process raft request' (duration: 141.353327ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:56:57.247851Z","caller":"traceutil/trace.go:171","msg":"trace[1194827546] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"201.129808ms","start":"2026-08-26T03:56:57.046696Z","end":"2026-08-26T03:56:57.247826Z","steps":["trace[1194827546] 'process raft request' (duration: 200.877316ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:56:57.540293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.576398ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-26T03:56:57.540503Z","caller":"traceutil/trace.go:171","msg":"trace[861723843] linearizableReadLoop","detail":"{readStateIndex:1126; appliedIndex:1125; }","duration":"226.978827ms","start":"2026-08-26T03:56:57.313505Z","end":"2026-08-26T03:56:57.540484Z","steps":["trace[861723843] 'read index received' (duration: 113.01681ms)","trace[861723843] 'applied index is now lower than readState.Index' (duration: 113.959897ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T03:56:57.540568Z","caller":"traceutil/trace.go:171","msg":"trace[1360619743] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"230.154564ms","start":"2026-08-26T03:56:57.310364Z","end":"2026-08-26T03:56:57.540519Z","steps":["trace[1360619743] 'process raft request' (duration: 116.250699ms)","trace[1360619743] 'compare' (duration: 113.460242ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T03:56:57.54088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.252763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-26T03:56:57.540956Z","caller":"traceutil/trace.go:171","msg":"trace[1881724301] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1086; }","duration":"225.365579ms","start":"2026-08-26T03:56:57.315572Z","end":"2026-08-26T03:56:57.540937Z","steps":["trace[1881724301] 'agreement among raft nodes before linearized reading' (duration: 225.118767ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:56:57.54099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.446651ms","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-26T03:56:57.541137Z","caller":"traceutil/trace.go:171","msg":"trace[628023761] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1086; }","duration":"227.633291ms","start":"2026-08-26T03:56:57.313469Z","end":"2026-08-26T03:56:57.541103Z","steps":["trace[628023761] 'agreement among raft nodes before linearized reading' (duration: 227.183519ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:57:13.293354Z","caller":"traceutil/trace.go:171","msg":"trace[1448636702] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"231.609061ms","start":"2026-08-26T03:57:13.061712Z","end":"2026-08-26T03:57:13.293321Z","steps":["trace[1448636702] 'process raft request' (duration: 231.445812ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T03:57:16.164088Z","caller":"traceutil/trace.go:171","msg":"trace[1065342661] transaction","detail":"{read_only:false; response_revision:1148; number_of_response:1; }","duration":"200.760973ms","start":"2026-08-26T03:57:15.963296Z","end":"2026-08-26T03:57:16.164057Z","steps":["trace[1065342661] 'process raft request' (duration: 200.49416ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T03:57:40.111859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.298361ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T03:57:40.111971Z","caller":"traceutil/trace.go:171","msg":"trace[690245343] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"213.109929ms","start":"2026-08-26T03:57:39.89882Z","end":"2026-08-26T03:57:40.11193Z","steps":["trace[690245343] 'process raft request' (duration: 124.304814ms)","trace[690245343] 'compare' (duration: 88.484889ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T03:57:40.112034Z","caller":"traceutil/trace.go:171","msg":"trace[468667590] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1226; }","duration":"148.511243ms","start":"2026-08-26T03:57:39.963498Z","end":"2026-08-26T03:57:40.11201Z","steps":["trace[468667590] 'range keys from in-memory index tree' (duration: 148.27231ms)"],"step_count":1}