{"level":"warn","ts":"2026-05-26T01:31:01.640591Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T01:31:01.640687Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.116: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.116:2380","--initial-cluster=instance=https://199.204.45.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.116:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-26T01:31:01.640755Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T01:31:01.640768Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-05-26T01:31:01.640791Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-26T01:31:01.641467Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"]} {"level":"info","ts":"2026-05-26T01:31:01.641558Z","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.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.116:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-26T01:31:01.646933Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.125466ms"} {"level":"info","ts":"2026-05-26T01:31:01.652531Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5caa70ef1dd6dc04","cluster-id":"45afccab143d2c82"} {"level":"info","ts":"2026-05-26T01:31:01.652597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=()"} {"level":"info","ts":"2026-05-26T01:31:01.652618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 0"} {"level":"info","ts":"2026-05-26T01:31:01.652628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5caa70ef1dd6dc04 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-26T01:31:01.65264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 1"} {"level":"info","ts":"2026-05-26T01:31:01.652676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"warn","ts":"2026-05-26T01:31:01.661458Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-26T01:31:01.662587Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-26T01:31:01.663651Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-26T01:31:01.667017Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5caa70ef1dd6dc04","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-26T01:31:01.667099Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5caa70ef1dd6dc04","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-26T01:31:01.667387Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-26T01:31:01.667479Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-26T01:31:01.667513Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-26T01:31:01.668439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"info","ts":"2026-05-26T01:31:01.669388Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","added-peer-id":"5caa70ef1dd6dc04","added-peer-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-05-26T01:31:01.673306Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-26T01:31:01.673582Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5caa70ef1dd6dc04","initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-26T01:31:01.673624Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-26T01:31:01.673648Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-05-26T01:31:01.673662Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-05-26T01:31:01.753397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 is starting a new election at term 1"} {"level":"info","ts":"2026-05-26T01:31:01.753437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-26T01:31:01.753455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgPreVoteResp from 5caa70ef1dd6dc04 at term 1"} {"level":"info","ts":"2026-05-26T01:31:01.753468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became candidate at term 2"} {"level":"info","ts":"2026-05-26T01:31:01.753475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgVoteResp from 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-05-26T01:31:01.753492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became leader at term 2"} {"level":"info","ts":"2026-05-26T01:31:01.753503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5caa70ef1dd6dc04 elected leader 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-05-26T01:31:01.754145Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5caa70ef1dd6dc04","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.116:2379]}","request-path":"/0/members/5caa70ef1dd6dc04/attributes","cluster-id":"45afccab143d2c82","publish-timeout":"7s"} {"level":"info","ts":"2026-05-26T01:31:01.754322Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T01:31:01.754432Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T01:31:01.754494Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-26T01:31:01.754539Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-26T01:31:01.75438Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T01:31:01.755231Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T01:31:01.755297Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T01:31:01.755321Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T01:31:01.757509Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-26T01:31:01.75837Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.116:2379"} {"level":"info","ts":"2026-05-26T01:31:55.559795Z","caller":"traceutil/trace.go:171","msg":"trace[153399452] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"164.894978ms","start":"2026-05-26T01:31:55.394875Z","end":"2026-05-26T01:31:55.55977Z","steps":["trace[153399452] 'process raft request' (duration: 164.702094ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:31:57.257311Z","caller":"traceutil/trace.go:171","msg":"trace[2106285906] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"171.276484ms","start":"2026-05-26T01:31:57.086001Z","end":"2026-05-26T01:31:57.257277Z","steps":["trace[2106285906] 'process raft request' (duration: 171.080439ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:32:03.456208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.563417ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-26T01:32:03.456553Z","caller":"traceutil/trace.go:171","msg":"trace[139453874] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"215.64573ms","start":"2026-05-26T01:32:03.240733Z","end":"2026-05-26T01:32:03.456379Z","steps":["trace[139453874] 'process raft request' (duration: 63.452213ms)","trace[139453874] 'compare' (duration: 150.28325ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:32:03.880925Z","caller":"traceutil/trace.go:171","msg":"trace[465408455] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"233.357474ms","start":"2026-05-26T01:32:03.647519Z","end":"2026-05-26T01:32:03.880877Z","steps":["trace[465408455] 'read index received' (duration: 233.177929ms)","trace[465408455] 'applied index is now lower than readState.Index' (duration: 178.454µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:32:03.881012Z","caller":"traceutil/trace.go:171","msg":"trace[148248858] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"241.023982ms","start":"2026-05-26T01:32:03.639955Z","end":"2026-05-26T01:32:03.880979Z","steps":["trace[148248858] 'process raft request' (duration: 240.721485ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:32:03.881209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.64651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sknbv\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-26T01:32:03.881296Z","caller":"traceutil/trace.go:171","msg":"trace[1085061377] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sknbv; range_end:; response_count:1; response_revision:633; }","duration":"233.796464ms","start":"2026-05-26T01:32:03.647478Z","end":"2026-05-26T01:32:03.881274Z","steps":["trace[1085061377] 'agreement among raft nodes before linearized reading' (duration: 233.592319ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:32:03.911929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.62823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-26T01:32:03.912063Z","caller":"traceutil/trace.go:171","msg":"trace[1656379746] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:634; }","duration":"204.761034ms","start":"2026-05-26T01:32:03.707249Z","end":"2026-05-26T01:32:03.91201Z","steps":["trace[1656379746] 'agreement among raft nodes before linearized reading' (duration: 204.504658ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:32:03.91243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.159618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-26T01:32:03.9125Z","caller":"traceutil/trace.go:171","msg":"trace[1353337687] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:634; }","duration":"177.319211ms","start":"2026-05-26T01:32:03.735164Z","end":"2026-05-26T01:32:03.912483Z","steps":["trace[1353337687] 'agreement among raft nodes before linearized reading' (duration: 177.080955ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:32:04.489588Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853970731594062194,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T01:32:04.783398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"801.28278ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T01:32:04.783815Z","caller":"traceutil/trace.go:171","msg":"trace[381663890] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"867.553242ms","start":"2026-05-26T01:32:03.91624Z","end":"2026-05-26T01:32:04.783793Z","steps":["trace[381663890] 'process raft request' (duration: 867.257275ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:32:04.783923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:32:03.916217Z","time spent":"867.655245ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:32:04.783995Z","caller":"traceutil/trace.go:171","msg":"trace[932816558] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"866.555588ms","start":"2026-05-26T01:32:03.917369Z","end":"2026-05-26T01:32:04.783925Z","steps":["trace[932816558] 'process raft request' (duration: 866.20595ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:32:04.78408Z","caller":"traceutil/trace.go:171","msg":"trace[1976324621] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"887.686305ms","start":"2026-05-26T01:32:03.896217Z","end":"2026-05-26T01:32:04.783904Z","steps":["trace[1976324621] 'process raft request' (duration: 85.024861ms)","trace[1976324621] 'compare' (duration: 800.787648ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T01:32:04.784234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:32:03.896195Z","time spent":"887.965073ms","remote":"127.0.0.1:49842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T01:32:04.784285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:32:03.917349Z","time spent":"866.735892ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:32:04.784595Z","caller":"traceutil/trace.go:171","msg":"trace[865820814] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:668; }","duration":"796.002632ms","start":"2026-05-26T01:32:03.988562Z","end":"2026-05-26T01:32:04.784565Z","steps":["trace[865820814] 'read index received' (duration: 790.393384ms)","trace[865820814] 'applied index is now lower than readState.Index' (duration: 5.607247ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:32:04.784656Z","caller":"traceutil/trace.go:171","msg":"trace[116353515] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"820.150292ms","start":"2026-05-26T01:32:03.964486Z","end":"2026-05-26T01:32:04.784636Z","steps":["trace[116353515] 'process raft request' (duration: 819.135157ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:32:04.78573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:32:03.964456Z","time spent":"821.228178ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T01:32:04.785778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.111277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T01:32:04.78494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.37285ms","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-05-26T01:32:04.785873Z","caller":"traceutil/trace.go:171","msg":"trace[1901768991] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"576.24347ms","start":"2026-05-26T01:32:04.209582Z","end":"2026-05-26T01:32:04.785825Z","steps":["trace[1901768991] 'agreement among raft nodes before linearized reading' (duration: 576.120097ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:32:04.785927Z","caller":"traceutil/trace.go:171","msg":"trace[1775002133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:638; }","duration":"797.361854ms","start":"2026-05-26T01:32:03.98855Z","end":"2026-05-26T01:32:04.785912Z","steps":["trace[1775002133] 'agreement among raft nodes before linearized reading' (duration: 796.188346ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:32:04.785972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:32:03.988513Z","time spent":"797.447966ms","remote":"127.0.0.1:49904","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":"warn","ts":"2026-05-26T01:32:04.785968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:32:04.209561Z","time spent":"576.394324ms","remote":"127.0.0.1:49690","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-05-26T01:32:20.382843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.320083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T01:32:20.382934Z","caller":"traceutil/trace.go:171","msg":"trace[1592841851] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:800; }","duration":"467.454496ms","start":"2026-05-26T01:32:19.915455Z","end":"2026-05-26T01:32:20.38291Z","steps":["trace[1592841851] 'count revisions from in-memory index tree' (duration: 467.236681ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:32:20.383022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:32:19.915434Z","time spent":"467.572219ms","remote":"127.0.0.1:50094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":2,"response size":29,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-05-26T01:32:20.383105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.984783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T01:32:20.383237Z","caller":"traceutil/trace.go:171","msg":"trace[817784738] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:800; }","duration":"168.127157ms","start":"2026-05-26T01:32:20.215051Z","end":"2026-05-26T01:32:20.383178Z","steps":["trace[817784738] 'count revisions from in-memory index tree' (duration: 167.902241ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:32:20.383313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.991247ms","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-05-26T01:32:20.383404Z","caller":"traceutil/trace.go:171","msg":"trace[1148048424] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:800; }","duration":"336.147101ms","start":"2026-05-26T01:32:20.047238Z","end":"2026-05-26T01:32:20.383385Z","steps":["trace[1148048424] 'range keys from in-memory index tree' (duration: 335.787683ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:32:20.383451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:32:20.047192Z","time spent":"336.249163ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T01:32:20.383508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.272503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T01:32:20.383533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.153269ms","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-05-26T01:32:20.383583Z","caller":"traceutil/trace.go:171","msg":"trace[437650403] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:800; }","duration":"360.236761ms","start":"2026-05-26T01:32:20.023333Z","end":"2026-05-26T01:32:20.383569Z","steps":["trace[437650403] 'range keys from in-memory index tree' (duration: 359.972615ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:32:20.383619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:32:20.023314Z","time spent":"360.297672ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-26T01:32:20.383541Z","caller":"traceutil/trace.go:171","msg":"trace[2031737994] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:800; }","duration":"173.361735ms","start":"2026-05-26T01:32:20.210169Z","end":"2026-05-26T01:32:20.383531Z","steps":["trace[2031737994] 'range keys from in-memory index tree' (duration: 173.14895ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:32:55.05688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.385041ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T01:32:55.05702Z","caller":"traceutil/trace.go:171","msg":"trace[844206096] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"499.906754ms","start":"2026-05-26T01:32:54.557075Z","end":"2026-05-26T01:32:55.056982Z","steps":["trace[844206096] 'process raft request' (duration: 302.34712ms)","trace[844206096] 'compare' (duration: 197.267107ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:32:55.057086Z","caller":"traceutil/trace.go:171","msg":"trace[1903528501] linearizableReadLoop","detail":"{readStateIndex:1062; appliedIndex:1061; }","duration":"242.828742ms","start":"2026-05-26T01:32:54.814221Z","end":"2026-05-26T01:32:55.05705Z","steps":["trace[1903528501] 'read index received' (duration: 45.134114ms)","trace[1903528501] 'applied index is now lower than readState.Index' (duration: 197.691058ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T01:32:55.057199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:32:54.55706Z","time spent":"500.028317ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T01:32:55.057495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.248563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-26T01:32:55.057564Z","caller":"traceutil/trace.go:171","msg":"trace[106503879] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:1016; }","duration":"243.345825ms","start":"2026-05-26T01:32:54.814191Z","end":"2026-05-26T01:32:55.057537Z","steps":["trace[106503879] 'agreement among raft nodes before linearized reading' (duration: 243.032327ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:32:55.057586Z","caller":"traceutil/trace.go:171","msg":"trace[177552487] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"151.401396ms","start":"2026-05-26T01:32:54.905629Z","end":"2026-05-26T01:32:55.057031Z","steps":["trace[177552487] 'process raft request' (duration: 151.351904ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:33:16.798913Z","caller":"traceutil/trace.go:171","msg":"trace[1070650894] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"109.209623ms","start":"2026-05-26T01:33:16.689668Z","end":"2026-05-26T01:33:16.798878Z","steps":["trace[1070650894] 'process raft request' (duration: 109.018178ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:33:17.311194Z","caller":"traceutil/trace.go:171","msg":"trace[546432081] linearizableReadLoop","detail":"{readStateIndex:1142; appliedIndex:1141; }","duration":"154.157042ms","start":"2026-05-26T01:33:17.157015Z","end":"2026-05-26T01:33:17.311172Z","steps":["trace[546432081] 'read index received' (duration: 154.016759ms)","trace[546432081] 'applied index is now lower than readState.Index' (duration: 139.173µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:33:17.311266Z","caller":"traceutil/trace.go:171","msg":"trace[2109226698] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"156.11822ms","start":"2026-05-26T01:33:17.155115Z","end":"2026-05-26T01:33:17.311233Z","steps":["trace[2109226698] 'process raft request' (duration: 155.875384ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:17.311735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.687045ms","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-05-26T01:33:17.311826Z","caller":"traceutil/trace.go:171","msg":"trace[326980730] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1090; }","duration":"154.813258ms","start":"2026-05-26T01:33:17.156995Z","end":"2026-05-26T01:33:17.311808Z","steps":["trace[326980730] 'agreement among raft nodes before linearized reading' (duration: 154.326077ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:33:17.327998Z","caller":"traceutil/trace.go:171","msg":"trace[1683256393] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"169.078957ms","start":"2026-05-26T01:33:17.158891Z","end":"2026-05-26T01:33:17.32797Z","steps":["trace[1683256393] 'process raft request' (duration: 168.864642ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:17.328098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.987681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-26T01:33:17.328238Z","caller":"traceutil/trace.go:171","msg":"trace[975795183] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1091; }","duration":"168.159755ms","start":"2026-05-26T01:33:17.160055Z","end":"2026-05-26T01:33:17.328215Z","steps":["trace[975795183] 'agreement among raft nodes before linearized reading' (duration: 167.869448ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:19.781118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.835912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-26T01:33:19.781192Z","caller":"traceutil/trace.go:171","msg":"trace[676302345] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1096; }","duration":"412.948614ms","start":"2026-05-26T01:33:19.368225Z","end":"2026-05-26T01:33:19.781173Z","steps":["trace[676302345] 'range keys from in-memory index tree' (duration: 412.690758ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:19.781211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.577883ms","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-05-26T01:33:19.781227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:19.368211Z","time spent":"413.009616ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-26T01:33:19.781235Z","caller":"traceutil/trace.go:171","msg":"trace[285376290] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1096; }","duration":"465.652335ms","start":"2026-05-26T01:33:19.315576Z","end":"2026-05-26T01:33:19.781228Z","steps":["trace[285376290] 'range keys from in-memory index tree' (duration: 465.46015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:19.781253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:19.315553Z","time spent":"465.695295ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T01:33:19.78151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.787135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-26T01:33:19.781634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.53848ms","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-05-26T01:33:19.781727Z","caller":"traceutil/trace.go:171","msg":"trace[1541994938] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1096; }","duration":"434.029501ms","start":"2026-05-26T01:33:19.347663Z","end":"2026-05-26T01:33:19.781692Z","steps":["trace[1541994938] 'range keys from in-memory index tree' (duration: 433.59139ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:19.782158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:19.347648Z","time spent":"434.489021ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-26T01:33:19.781838Z","caller":"traceutil/trace.go:171","msg":"trace[468663077] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1096; }","duration":"449.789056ms","start":"2026-05-26T01:33:19.332027Z","end":"2026-05-26T01:33:19.781816Z","steps":["trace[468663077] 'range keys from in-memory index tree' (duration: 449.108779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:19.782726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:19.332006Z","time spent":"450.695468ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-26T01:33:20.248447Z","caller":"traceutil/trace.go:171","msg":"trace[333851671] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"462.362404ms","start":"2026-05-26T01:33:19.78606Z","end":"2026-05-26T01:33:20.248422Z","steps":["trace[333851671] 'process raft request' (duration: 462.163399ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:20.248601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:19.786034Z","time spent":"462.482207ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T01:33:20.514847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.546503ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T01:33:20.515175Z","caller":"traceutil/trace.go:171","msg":"trace[44236060] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"728.793363ms","start":"2026-05-26T01:33:19.786333Z","end":"2026-05-26T01:33:20.515126Z","steps":["trace[44236060] 'process raft request' (duration: 622.869721ms)","trace[44236060] 'compare' (duration: 105.026211ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T01:33:20.515429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:19.786316Z","time spent":"728.990239ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:33:20.515623Z","caller":"traceutil/trace.go:171","msg":"trace[1162495017] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"729.210344ms","start":"2026-05-26T01:33:19.786379Z","end":"2026-05-26T01:33:20.515589Z","steps":["trace[1162495017] 'process raft request' (duration: 728.940877ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:20.515784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:19.786365Z","time spent":"729.334967ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:33:20.515854Z","caller":"traceutil/trace.go:171","msg":"trace[730976980] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"729.43196ms","start":"2026-05-26T01:33:19.786366Z","end":"2026-05-26T01:33:20.515798Z","steps":["trace[730976980] 'process raft request' (duration: 729.146743ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:20.516012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:19.786342Z","time spent":"729.582613ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:33:20.560631Z","caller":"traceutil/trace.go:171","msg":"trace[10234544] linearizableReadLoop","detail":"{readStateIndex:1153; appliedIndex:1148; }","duration":"350.711022ms","start":"2026-05-26T01:33:20.20989Z","end":"2026-05-26T01:33:20.560601Z","steps":["trace[10234544] 'read index received' (duration: 38.40231ms)","trace[10234544] 'applied index is now lower than readState.Index' (duration: 312.306972ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T01:33:20.560859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.916637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T01:33:20.560923Z","caller":"traceutil/trace.go:171","msg":"trace[616774429] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1100; }","duration":"351.057401ms","start":"2026-05-26T01:33:20.209851Z","end":"2026-05-26T01:33:20.560909Z","steps":["trace[616774429] 'agreement among raft nodes before linearized reading' (duration: 350.891097ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:20.561002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:20.209834Z","time spent":"351.155553ms","remote":"127.0.0.1:49690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-26T01:33:34.777305Z","caller":"traceutil/trace.go:171","msg":"trace[1088081717] linearizableReadLoop","detail":"{readStateIndex:1251; appliedIndex:1250; }","duration":"197.662756ms","start":"2026-05-26T01:33:34.579619Z","end":"2026-05-26T01:33:34.777281Z","steps":["trace[1088081717] 'read index received' (duration: 197.469532ms)","trace[1088081717] 'applied index is now lower than readState.Index' (duration: 192.134µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:33:34.777406Z","caller":"traceutil/trace.go:171","msg":"trace[353829476] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"473.902086ms","start":"2026-05-26T01:33:34.303472Z","end":"2026-05-26T01:33:34.777374Z","steps":["trace[353829476] 'process raft request' (duration: 473.63367ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:34.777512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.895902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-26T01:33:34.777539Z","caller":"traceutil/trace.go:171","msg":"trace[1566535500] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1193; }","duration":"197.969573ms","start":"2026-05-26T01:33:34.579562Z","end":"2026-05-26T01:33:34.777532Z","steps":["trace[1566535500] 'agreement among raft nodes before linearized reading' (duration: 197.82927ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:34.77754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:34.30346Z","time spent":"474.009179ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T01:33:34.777544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.901972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-26T01:33:34.77765Z","caller":"traceutil/trace.go:171","msg":"trace[1543620736] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1193; }","duration":"198.040986ms","start":"2026-05-26T01:33:34.579598Z","end":"2026-05-26T01:33:34.777639Z","steps":["trace[1543620736] 'agreement among raft nodes before linearized reading' (duration: 197.819381ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:34.777675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.018005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-26T01:33:34.777744Z","caller":"traceutil/trace.go:171","msg":"trace[733229781] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1193; }","duration":"198.130028ms","start":"2026-05-26T01:33:34.579595Z","end":"2026-05-26T01:33:34.777725Z","steps":["trace[733229781] 'agreement among raft nodes before linearized reading' (duration: 197.961624ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:33:35.045715Z","caller":"traceutil/trace.go:171","msg":"trace[1987010695] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"264.459662ms","start":"2026-05-26T01:33:34.781224Z","end":"2026-05-26T01:33:35.045684Z","steps":["trace[1987010695] 'process raft request' (duration: 262.692538ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:33:35.053249Z","caller":"traceutil/trace.go:171","msg":"trace[1499315172] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"271.594597ms","start":"2026-05-26T01:33:34.781638Z","end":"2026-05-26T01:33:35.053233Z","steps":["trace[1499315172] 'process raft request' (duration: 271.473954ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:33:35.053372Z","caller":"traceutil/trace.go:171","msg":"trace[2003265985] linearizableReadLoop","detail":"{readStateIndex:1254; appliedIndex:1251; }","duration":"238.413264ms","start":"2026-05-26T01:33:34.814953Z","end":"2026-05-26T01:33:35.053367Z","steps":["trace[2003265985] 'read index received' (duration: 228.972082ms)","trace[2003265985] 'applied index is now lower than readState.Index' (duration: 9.440642ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:33:35.053412Z","caller":"traceutil/trace.go:171","msg":"trace[2088690446] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"271.74911ms","start":"2026-05-26T01:33:34.781659Z","end":"2026-05-26T01:33:35.053408Z","steps":["trace[2088690446] 'process raft request' (duration: 271.552435ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:35.053515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.548487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-26T01:33:35.05353Z","caller":"traceutil/trace.go:171","msg":"trace[898143917] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:1196; }","duration":"238.591569ms","start":"2026-05-26T01:33:34.814934Z","end":"2026-05-26T01:33:35.053525Z","steps":["trace[898143917] 'agreement among raft nodes before linearized reading' (duration: 238.513367ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:35.053707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.84727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T01:33:35.053673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.046144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-26T01:33:35.053756Z","caller":"traceutil/trace.go:171","msg":"trace[302909915] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1196; }","duration":"137.158587ms","start":"2026-05-26T01:33:34.916581Z","end":"2026-05-26T01:33:35.053739Z","steps":["trace[302909915] 'agreement among raft nodes before linearized reading' (duration: 136.973272ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:33:35.053723Z","caller":"traceutil/trace.go:171","msg":"trace[407081537] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1196; }","duration":"125.8785ms","start":"2026-05-26T01:33:34.927841Z","end":"2026-05-26T01:33:35.053719Z","steps":["trace[407081537] 'agreement among raft nodes before linearized reading' (duration: 125.84887ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:33:53.2951Z","caller":"traceutil/trace.go:171","msg":"trace[32358207] linearizableReadLoop","detail":"{readStateIndex:1344; appliedIndex:1342; }","duration":"137.063034ms","start":"2026-05-26T01:33:53.15802Z","end":"2026-05-26T01:33:53.295083Z","steps":["trace[32358207] 'read index received' (duration: 15.441258ms)","trace[32358207] 'applied index is now lower than readState.Index' (duration: 121.621186ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:33:53.295185Z","caller":"traceutil/trace.go:171","msg":"trace[563149534] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"156.317405ms","start":"2026-05-26T01:33:53.13886Z","end":"2026-05-26T01:33:53.295178Z","steps":["trace[563149534] 'process raft request' (duration: 100.777656ms)","trace[563149534] 'compare' (duration: 55.366104ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T01:33:53.295301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.273779ms","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-05-26T01:33:53.295345Z","caller":"traceutil/trace.go:171","msg":"trace[1235799827] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1282; }","duration":"137.32822ms","start":"2026-05-26T01:33:53.158008Z","end":"2026-05-26T01:33:53.295336Z","steps":["trace[1235799827] 'agreement among raft nodes before linearized reading' (duration: 137.183467ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:53.295436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.552719ms","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-05-26T01:33:53.295457Z","caller":"traceutil/trace.go:171","msg":"trace[917367728] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1282; }","duration":"131.587649ms","start":"2026-05-26T01:33:53.163865Z","end":"2026-05-26T01:33:53.295452Z","steps":["trace[917367728] 'agreement among raft nodes before linearized reading' (duration: 131.537898ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:55.073294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.132436ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T01:33:55.073427Z","caller":"traceutil/trace.go:171","msg":"trace[1435886764] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"155.990097ms","start":"2026-05-26T01:33:54.917414Z","end":"2026-05-26T01:33:55.073404Z","steps":["trace[1435886764] 'process raft request' (duration: 29.645476ms)","trace[1435886764] 'compare' (duration: 125.86718ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T01:33:55.371054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.774456ms","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-05-26T01:33:55.371107Z","caller":"traceutil/trace.go:171","msg":"trace[1688399949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1287; }","duration":"194.852307ms","start":"2026-05-26T01:33:55.176243Z","end":"2026-05-26T01:33:55.371095Z","steps":["trace[1688399949] 'range keys from in-memory index tree' (duration: 194.707964ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:55.371202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.658582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T01:33:55.371245Z","caller":"traceutil/trace.go:171","msg":"trace[256968126] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1287; }","duration":"160.715423ms","start":"2026-05-26T01:33:55.210503Z","end":"2026-05-26T01:33:55.371218Z","steps":["trace[256968126] 'range keys from in-memory index tree' (duration: 160.58985ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:33:55.654205Z","caller":"traceutil/trace.go:171","msg":"trace[2130665090] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"279.676393ms","start":"2026-05-26T01:33:55.374504Z","end":"2026-05-26T01:33:55.65418Z","steps":["trace[2130665090] 'process raft request' (duration: 279.5352ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:33:55.883697Z","caller":"traceutil/trace.go:171","msg":"trace[1671634110] linearizableReadLoop","detail":"{readStateIndex:1353; appliedIndex:1351; }","duration":"503.390578ms","start":"2026-05-26T01:33:55.38023Z","end":"2026-05-26T01:33:55.883621Z","steps":["trace[1671634110] 'read index received' (duration: 274.050946ms)","trace[1671634110] 'applied index is now lower than readState.Index' (duration: 229.338592ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:33:55.883722Z","caller":"traceutil/trace.go:171","msg":"trace[863241664] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"506.962825ms","start":"2026-05-26T01:33:55.376713Z","end":"2026-05-26T01:33:55.883676Z","steps":["trace[863241664] 'process raft request' (duration: 506.826552ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:33:55.883829Z","caller":"traceutil/trace.go:171","msg":"trace[1236845210] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"508.584995ms","start":"2026-05-26T01:33:55.375201Z","end":"2026-05-26T01:33:55.883786Z","steps":["trace[1236845210] 'process raft request' (duration: 508.164185ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:55.883983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.722316ms","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-05-26T01:33:55.883751Z","caller":"traceutil/trace.go:171","msg":"trace[1056534340] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"454.219595ms","start":"2026-05-26T01:33:55.429498Z","end":"2026-05-26T01:33:55.883717Z","steps":["trace[1056534340] 'process raft request' (duration: 454.084372ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:55.884026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:55.375194Z","time spent":"508.741728ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:33:55.884039Z","caller":"traceutil/trace.go:171","msg":"trace[1367926543] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1291; }","duration":"503.811719ms","start":"2026-05-26T01:33:55.380216Z","end":"2026-05-26T01:33:55.884028Z","steps":["trace[1367926543] 'agreement among raft nodes before linearized reading' (duration: 503.604563ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:33:55.884083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:55.380197Z","time spent":"503.876801ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T01:33:55.88414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:55.429475Z","time spent":"454.582804ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T01:33:55.884175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:33:55.376706Z","time spent":"507.195502ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:33:56.043906Z","caller":"traceutil/trace.go:171","msg":"trace[1824459763] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"155.23065ms","start":"2026-05-26T01:33:55.888651Z","end":"2026-05-26T01:33:56.043881Z","steps":["trace[1824459763] 'process raft request' (duration: 114.108103ms)","trace[1824459763] 'compare' (duration: 41.014064ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T01:34:04.419275Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853970731594063809,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T01:34:04.920323Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853970731594063809,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T01:34:05.211362Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.304911472s","expected-duration":"1s"} {"level":"info","ts":"2026-05-26T01:34:05.211673Z","caller":"traceutil/trace.go:171","msg":"trace[336316129] linearizableReadLoop","detail":"{readStateIndex:1419; appliedIndex:1418; }","duration":"1.292896028s","start":"2026-05-26T01:34:03.91876Z","end":"2026-05-26T01:34:05.211656Z","steps":["trace[336316129] 'read index received' (duration: 1.292749995s)","trace[336316129] 'applied index is now lower than readState.Index' (duration: 145.143µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:34:05.211784Z","caller":"traceutil/trace.go:171","msg":"trace[1535595527] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"1.305477156s","start":"2026-05-26T01:34:03.906281Z","end":"2026-05-26T01:34:05.211759Z","steps":["trace[1535595527] 'process raft request' (duration: 1.30524797s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.211846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.293075172s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-26T01:34:05.211876Z","caller":"traceutil/trace.go:171","msg":"trace[1402870631] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1355; }","duration":"1.293156214s","start":"2026-05-26T01:34:03.918711Z","end":"2026-05-26T01:34:05.211867Z","steps":["trace[1402870631] 'agreement among raft nodes before linearized reading' (duration: 1.293050792s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.211901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:03.918691Z","time spent":"1.293203015s","remote":"127.0.0.1:49904","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-05-26T01:34:05.212043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.290244513s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-26T01:34:05.212081Z","caller":"traceutil/trace.go:171","msg":"trace[1060515744] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1355; }","duration":"1.290304305s","start":"2026-05-26T01:34:03.921771Z","end":"2026-05-26T01:34:05.212075Z","steps":["trace[1060515744] 'agreement among raft nodes before linearized reading' (duration: 1.290219982s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.212048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.62182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T01:34:05.212106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:03.921763Z","time spent":"1.290335235s","remote":"127.0.0.1:49904","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-05-26T01:34:05.212117Z","caller":"traceutil/trace.go:171","msg":"trace[2031012816] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1355; }","duration":"283.701232ms","start":"2026-05-26T01:34:04.928401Z","end":"2026-05-26T01:34:05.212103Z","steps":["trace[2031012816] 'agreement among raft nodes before linearized reading' (duration: 283.59196ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.212223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.39554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"warn","ts":"2026-05-26T01:34:05.212236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"974.256391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T01:34:05.212281Z","caller":"traceutil/trace.go:171","msg":"trace[1904168735] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1355; }","duration":"452.488972ms","start":"2026-05-26T01:34:04.759774Z","end":"2026-05-26T01:34:05.212263Z","steps":["trace[1904168735] 'agreement among raft nodes before linearized reading' (duration: 452.297427ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:05.212312Z","caller":"traceutil/trace.go:171","msg":"trace[239621107] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1355; }","duration":"974.374214ms","start":"2026-05-26T01:34:04.237917Z","end":"2026-05-26T01:34:05.212291Z","steps":["trace[239621107] 'agreement among raft nodes before linearized reading' (duration: 974.249951ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.212322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:04.759755Z","time spent":"452.558514ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-05-26T01:34:05.212353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:04.23789Z","time spent":"974.452655ms","remote":"127.0.0.1:49752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-05-26T01:34:05.212425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.996904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-05-26T01:34:05.212415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.133350864s","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-05-26T01:34:05.212496Z","caller":"traceutil/trace.go:171","msg":"trace[1304635470] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1355; }","duration":"1.133474046s","start":"2026-05-26T01:34:04.079003Z","end":"2026-05-26T01:34:05.212477Z","steps":["trace[1304635470] 'agreement among raft nodes before linearized reading' (duration: 1.133193049s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.212538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:04.078987Z","time spent":"1.133542528s","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T01:34:05.212534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:03.906249Z","time spent":"1.305590629s","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:34:05.212448Z","caller":"traceutil/trace.go:171","msg":"trace[1402766961] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:1355; }","duration":"397.057405ms","start":"2026-05-26T01:34:04.815384Z","end":"2026-05-26T01:34:05.212441Z","steps":["trace[1402766961] 'agreement among raft nodes before linearized reading' (duration: 396.984024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.212676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:04.815364Z","time spent":"397.303743ms","remote":"127.0.0.1:49712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.116\" "} {"level":"warn","ts":"2026-05-26T01:34:05.816045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.548137ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T01:34:05.816282Z","caller":"traceutil/trace.go:171","msg":"trace[1394970999] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"600.424353ms","start":"2026-05-26T01:34:05.215833Z","end":"2026-05-26T01:34:05.816258Z","steps":["trace[1394970999] 'process raft request' (duration: 388.563428ms)","trace[1394970999] 'compare' (duration: 211.396713ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T01:34:05.816366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:05.215812Z","time spent":"600.512274ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:34:05.816646Z","caller":"traceutil/trace.go:171","msg":"trace[1243893531] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"599.257084ms","start":"2026-05-26T01:34:05.217367Z","end":"2026-05-26T01:34:05.816624Z","steps":["trace[1243893531] 'process raft request' (duration: 599.149022ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:05.816694Z","caller":"traceutil/trace.go:171","msg":"trace[1562296435] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"599.310465ms","start":"2026-05-26T01:34:05.217347Z","end":"2026-05-26T01:34:05.816657Z","steps":["trace[1562296435] 'process raft request' (duration: 598.825313ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.816756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:05.217346Z","time spent":"599.366826ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:34:05.81685Z","caller":"traceutil/trace.go:171","msg":"trace[1353284269] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"599.026029ms","start":"2026-05-26T01:34:05.217812Z","end":"2026-05-26T01:34:05.816838Z","steps":["trace[1353284269] 'process raft request' (duration: 598.884715ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:05.816872Z","caller":"traceutil/trace.go:171","msg":"trace[801078263] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"599.162522ms","start":"2026-05-26T01:34:05.217693Z","end":"2026-05-26T01:34:05.816855Z","steps":["trace[801078263] 'process raft request' (duration: 598.896456ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.816872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:05.217334Z","time spent":"599.444669ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T01:34:05.816995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:05.217801Z","time spent":"599.08225ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T01:34:05.817011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:05.217673Z","time spent":"599.240143ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T01:34:05.873985Z","caller":"traceutil/trace.go:171","msg":"trace[83209768] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"628.06504ms","start":"2026-05-26T01:34:05.245906Z","end":"2026-05-26T01:34:05.873971Z","steps":["trace[83209768] 'process raft request' (duration: 627.919257ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.874064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:05.245886Z","time spent":"628.137531ms","remote":"127.0.0.1:49712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T01:34:05.874111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.959968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T01:34:05.874164Z","caller":"traceutil/trace.go:171","msg":"trace[1032051195] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1361; }","duration":"315.07634ms","start":"2026-05-26T01:34:05.559075Z","end":"2026-05-26T01:34:05.874151Z","steps":["trace[1032051195] 'agreement among raft nodes before linearized reading' (duration: 314.944477ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:34:05.873977Z","caller":"traceutil/trace.go:171","msg":"trace[983078210] linearizableReadLoop","detail":"{readStateIndex:1426; appliedIndex:1420; }","duration":"314.821025ms","start":"2026-05-26T01:34:05.559133Z","end":"2026-05-26T01:34:05.873954Z","steps":["trace[983078210] 'read index received' (duration: 45.35709ms)","trace[983078210] 'applied index is now lower than readState.Index' (duration: 269.462825ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T01:34:05.874217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T01:34:05.559052Z","time spent":"315.154663ms","remote":"127.0.0.1:42878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-26T01:34:05.874375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.234211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T01:34:05.874434Z","caller":"traceutil/trace.go:171","msg":"trace[1238312115] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1361; }","duration":"263.360294ms","start":"2026-05-26T01:34:05.611057Z","end":"2026-05-26T01:34:05.874418Z","steps":["trace[1238312115] 'agreement among raft nodes before linearized reading' (duration: 263.226431ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:34:05.874677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.183424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-26T01:34:05.874711Z","caller":"traceutil/trace.go:171","msg":"trace[1795917718] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1361; }","duration":"172.249256ms","start":"2026-05-26T01:34:05.702452Z","end":"2026-05-26T01:34:05.874702Z","steps":["trace[1795917718] 'agreement among raft nodes before linearized reading' (duration: 172.124983ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T01:37:53.001595Z","caller":"traceutil/trace.go:171","msg":"trace[1004332308] linearizableReadLoop","detail":"{readStateIndex:2536; appliedIndex:2535; }","duration":"161.178108ms","start":"2026-05-26T01:37:52.840394Z","end":"2026-05-26T01:37:53.001572Z","steps":["trace[1004332308] 'read index received' (duration: 161.017934ms)","trace[1004332308] 'applied index is now lower than readState.Index' (duration: 158.874µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T01:37:53.001787Z","caller":"traceutil/trace.go:171","msg":"trace[1784431586] transaction","detail":"{read_only:false; response_revision:2425; number_of_response:1; }","duration":"200.071709ms","start":"2026-05-26T01:37:52.801681Z","end":"2026-05-26T01:37:53.001752Z","steps":["trace[1784431586] 'process raft request' (duration: 199.724261ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:37:53.001918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.476791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-26T01:37:53.00196Z","caller":"traceutil/trace.go:171","msg":"trace[815303610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2425; }","duration":"126.572182ms","start":"2026-05-26T01:37:52.875377Z","end":"2026-05-26T01:37:53.001949Z","steps":["trace[815303610] 'agreement among raft nodes before linearized reading' (duration: 126.428219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T01:37:53.001963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.539968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-05-26T01:37:53.002039Z","caller":"traceutil/trace.go:171","msg":"trace[708853217] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2425; }","duration":"161.62752ms","start":"2026-05-26T01:37:52.840389Z","end":"2026-05-26T01:37:53.002016Z","steps":["trace[708853217] 'agreement among raft nodes before linearized reading' (duration: 161.413924ms)"],"step_count":1}