{"level":"warn","ts":"2026-08-13T08:01:58.697188Z","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-13T08:01:58.697272Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.141: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.19.213.141:2380","--initial-cluster=instance=https://199.19.213.141:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.141:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.141: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-13T08:01:58.697339Z","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-13T08:01:58.697347Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.141:2380"]} {"level":"info","ts":"2026-08-13T08:01:58.697364Z","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-13T08:01:58.697973Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.141:2379"]} {"level":"info","ts":"2026-08-13T08:01:58.698101Z","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.19.213.141:2380"],"listen-peer-urls":["https://199.19.213.141:2380"],"advertise-client-urls":["https://199.19.213.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.141: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-13T08:01:58.702341Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.810464ms"} {"level":"info","ts":"2026-08-13T08:01:58.710982Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fe263d225de0d201","cluster-id":"24f15cf84c3a7bc3"} {"level":"info","ts":"2026-08-13T08:01:58.711059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 switched to configuration voters=()"} {"level":"info","ts":"2026-08-13T08:01:58.711082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 became follower at term 0"} {"level":"info","ts":"2026-08-13T08:01:58.711098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fe263d225de0d201 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-13T08:01:58.71111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 became follower at term 1"} {"level":"info","ts":"2026-08-13T08:01:58.711154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 switched to configuration voters=(18313392152561897985)"} {"level":"warn","ts":"2026-08-13T08:01:58.716927Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-13T08:01:58.719428Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-13T08:01:58.720904Z","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-13T08:01:58.72527Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fe263d225de0d201","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-13T08:01:58.727913Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fe263d225de0d201","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-13T08:01:58.727717Z","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-13T08:01:58.728067Z","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-13T08:01:58.728077Z","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-13T08:01:58.728664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 switched to configuration voters=(18313392152561897985)"} {"level":"info","ts":"2026-08-13T08:01:58.730004Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"24f15cf84c3a7bc3","local-member-id":"fe263d225de0d201","added-peer-id":"fe263d225de0d201","added-peer-peer-urls":["https://199.19.213.141:2380"]} {"level":"info","ts":"2026-08-13T08:01:58.73059Z","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-13T08:01:58.730671Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.141:2380"} {"level":"info","ts":"2026-08-13T08:01:58.730713Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.141:2380"} {"level":"info","ts":"2026-08-13T08:01:58.73086Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fe263d225de0d201","initial-advertise-peer-urls":["https://199.19.213.141:2380"],"listen-peer-urls":["https://199.19.213.141:2380"],"advertise-client-urls":["https://199.19.213.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-13T08:01:58.730899Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-13T08:01:59.612322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 is starting a new election at term 1"} {"level":"info","ts":"2026-08-13T08:01:59.612375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-13T08:01:59.61239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 received MsgPreVoteResp from fe263d225de0d201 at term 1"} {"level":"info","ts":"2026-08-13T08:01:59.612401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 became candidate at term 2"} {"level":"info","ts":"2026-08-13T08:01:59.612407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 received MsgVoteResp from fe263d225de0d201 at term 2"} {"level":"info","ts":"2026-08-13T08:01:59.612414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 became leader at term 2"} {"level":"info","ts":"2026-08-13T08:01:59.612421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fe263d225de0d201 elected leader fe263d225de0d201 at term 2"} {"level":"info","ts":"2026-08-13T08:01:59.613555Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T08:01:59.615401Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fe263d225de0d201","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.141:2379]}","request-path":"/0/members/fe263d225de0d201/attributes","cluster-id":"24f15cf84c3a7bc3","publish-timeout":"7s"} {"level":"info","ts":"2026-08-13T08:01:59.615564Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T08:01:59.615649Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T08:01:59.616015Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"24f15cf84c3a7bc3","local-member-id":"fe263d225de0d201","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T08:01:59.616107Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T08:01:59.616131Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T08:01:59.618209Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-13T08:01:59.620143Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.141:2379"} {"level":"info","ts":"2026-08-13T08:01:59.622731Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-13T08:01:59.622753Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-13T08:02:15.450886Z","caller":"traceutil/trace.go:171","msg":"trace[113001849] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"226.953558ms","start":"2026-08-13T08:02:15.223851Z","end":"2026-08-13T08:02:15.450804Z","steps":["trace[113001849] 'process raft request' (duration: 226.836444ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.267988Z","caller":"traceutil/trace.go:171","msg":"trace[1455913576] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"674.606427ms","start":"2026-08-13T08:02:39.593356Z","end":"2026-08-13T08:02:40.267962Z","steps":["trace[1455913576] 'process raft request' (duration: 674.407681ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.268581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:39.593336Z","time spent":"674.738282ms","remote":"127.0.0.1:60772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T08:02:40.425191Z","caller":"traceutil/trace.go:171","msg":"trace[1845934087] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"823.309845ms","start":"2026-08-13T08:02:39.601858Z","end":"2026-08-13T08:02:40.425168Z","steps":["trace[1845934087] 'process raft request' (duration: 823.057856ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.425445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:39.601829Z","time spent":"823.530232ms","remote":"127.0.0.1:60772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T08:02:40.425485Z","caller":"traceutil/trace.go:171","msg":"trace[240755088] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"823.524862ms","start":"2026-08-13T08:02:39.601926Z","end":"2026-08-13T08:02:40.425451Z","steps":["trace[240755088] 'process raft request' (duration: 823.16762ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.425743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:39.601923Z","time spent":"823.637725ms","remote":"127.0.0.1:60772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T08:02:40.426688Z","caller":"traceutil/trace.go:171","msg":"trace[736342081] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"814.531262ms","start":"2026-08-13T08:02:39.61214Z","end":"2026-08-13T08:02:40.426672Z","steps":["trace[736342081] 'process raft request' (duration: 813.84111ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.426929Z","caller":"traceutil/trace.go:171","msg":"trace[1174850013] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"797.501082ms","start":"2026-08-13T08:02:39.629417Z","end":"2026-08-13T08:02:40.426918Z","steps":["trace[1174850013] 'process raft request' (duration: 797.12597ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.427002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:39.629391Z","time spent":"797.564404ms","remote":"127.0.0.1:60772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T08:02:40.426874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:39.612122Z","time spent":"814.676216ms","remote":"127.0.0.1:60772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T08:02:40.427174Z","caller":"traceutil/trace.go:171","msg":"trace[77757642] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"789.396761ms","start":"2026-08-13T08:02:39.637766Z","end":"2026-08-13T08:02:40.427162Z","steps":["trace[77757642] 'process raft request' (duration: 789.140823ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.427248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:39.637746Z","time spent":"789.453782ms","remote":"127.0.0.1:60772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T08:02:40.427431Z","caller":"traceutil/trace.go:171","msg":"trace[64301601] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"789.567626ms","start":"2026-08-13T08:02:39.637852Z","end":"2026-08-13T08:02:40.42742Z","steps":["trace[64301601] 'process raft request' (duration: 789.35917ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.427509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:39.637846Z","time spent":"789.612988ms","remote":"127.0.0.1:60772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T08:02:40.427691Z","caller":"traceutil/trace.go:171","msg":"trace[896603437] linearizableReadLoop","detail":"{readStateIndex:522; appliedIndex:510; }","duration":"623.701295ms","start":"2026-08-13T08:02:39.803973Z","end":"2026-08-13T08:02:40.427674Z","steps":["trace[896603437] 'read index received' (duration: 463.801235ms)","trace[896603437] 'applied index is now lower than readState.Index' (duration: 159.899399ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:02:40.427758Z","caller":"traceutil/trace.go:171","msg":"trace[297616657] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"644.886718ms","start":"2026-08-13T08:02:39.782862Z","end":"2026-08-13T08:02:40.427749Z","steps":["trace[297616657] 'process raft request' (duration: 644.697152ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.427757Z","caller":"traceutil/trace.go:171","msg":"trace[126759965] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"755.452706ms","start":"2026-08-13T08:02:39.672267Z","end":"2026-08-13T08:02:40.427719Z","steps":["trace[126759965] 'process raft request' (duration: 755.217568ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.427809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:39.782832Z","time spent":"644.94562ms","remote":"127.0.0.1:60772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T08:02:40.427688Z","caller":"traceutil/trace.go:171","msg":"trace[702301252] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"789.633378ms","start":"2026-08-13T08:02:39.63797Z","end":"2026-08-13T08:02:40.427603Z","steps":["trace[702301252] 'process raft request' (duration: 789.446782ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.427947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:39.672243Z","time spent":"755.59941ms","remote":"127.0.0.1:60772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T08:02:40.428002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:39.637965Z","time spent":"789.926988ms","remote":"127.0.0.1:60772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T08:02:40.428043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.059746ms","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-13T08:02:40.428092Z","caller":"traceutil/trace.go:171","msg":"trace[883714445] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:501; }","duration":"624.15909ms","start":"2026-08-13T08:02:39.803926Z","end":"2026-08-13T08:02:40.428085Z","steps":["trace[883714445] 'agreement among raft nodes before linearized reading' (duration: 624.050436ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.428114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:39.803901Z","time spent":"624.208491ms","remote":"127.0.0.1:60980","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-13T08:02:40.428206Z","caller":"traceutil/trace.go:171","msg":"trace[1909640828] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"790.265379ms","start":"2026-08-13T08:02:39.637924Z","end":"2026-08-13T08:02:40.428189Z","steps":["trace[1909640828] 'process raft request' (duration: 789.412552ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.428267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:39.637918Z","time spent":"790.324871ms","remote":"127.0.0.1:60772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T08:02:40.428308Z","caller":"traceutil/trace.go:171","msg":"trace[527411316] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"784.900666ms","start":"2026-08-13T08:02:39.643395Z","end":"2026-08-13T08:02:40.428296Z","steps":["trace[527411316] 'process raft request' (duration: 784.051328ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.428385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:39.64338Z","time spent":"784.983089ms","remote":"127.0.0.1:60772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T08:02:40.52023Z","caller":"traceutil/trace.go:171","msg":"trace[2104528427] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"246.594556ms","start":"2026-08-13T08:02:40.273614Z","end":"2026-08-13T08:02:40.520209Z","steps":["trace[2104528427] 'process raft request' (duration: 237.164212ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.520312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.23179ms","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-13T08:02:40.520368Z","caller":"traceutil/trace.go:171","msg":"trace[1864911738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:503; }","duration":"716.317623ms","start":"2026-08-13T08:02:39.804035Z","end":"2026-08-13T08:02:40.520353Z","steps":["trace[1864911738] 'agreement among raft nodes before linearized reading' (duration: 716.183339ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.520405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:39.804029Z","time spent":"716.366995ms","remote":"127.0.0.1:60980","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-13T08:02:40.520392Z","caller":"traceutil/trace.go:171","msg":"trace[1932628739] transaction","detail":"{read_only:false; number_of_response:1; response_revision:503; }","duration":"243.245398ms","start":"2026-08-13T08:02:40.277087Z","end":"2026-08-13T08:02:40.520333Z","steps":["trace[1932628739] 'process raft request' (duration: 243.097834ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.520456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.805941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:02:40.520538Z","caller":"traceutil/trace.go:171","msg":"trace[694801368] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:503; }","duration":"580.942175ms","start":"2026-08-13T08:02:39.939577Z","end":"2026-08-13T08:02:40.520519Z","steps":["trace[694801368] 'agreement among raft nodes before linearized reading' (duration: 580.798171ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.520586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:39.939559Z","time spent":"581.018647ms","remote":"127.0.0.1:60724","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-13T08:02:40.520586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.823848ms","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-13T08:02:40.520679Z","caller":"traceutil/trace.go:171","msg":"trace[1892180307] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:503; }","duration":"389.947712ms","start":"2026-08-13T08:02:40.130722Z","end":"2026-08-13T08:02:40.52067Z","steps":["trace[1892180307] 'agreement among raft nodes before linearized reading' (duration: 389.600111ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.52076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:40.130706Z","time spent":"390.043936ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-13T08:02:40.520778Z","caller":"traceutil/trace.go:171","msg":"trace[257650862] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"245.228182ms","start":"2026-08-13T08:02:40.275502Z","end":"2026-08-13T08:02:40.52073Z","steps":["trace[257650862] 'process raft request' (duration: 244.619153ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.521053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.86182ms","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-13T08:02:40.521291Z","caller":"traceutil/trace.go:171","msg":"trace[731147382] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:503; }","duration":"364.058757ms","start":"2026-08-13T08:02:40.157103Z","end":"2026-08-13T08:02:40.521162Z","steps":["trace[731147382] 'agreement among raft nodes before linearized reading' (duration: 363.434007ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:40.521394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:40.157073Z","time spent":"364.305845ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-13T08:02:40.618772Z","caller":"traceutil/trace.go:171","msg":"trace[711070723] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"181.491586ms","start":"2026-08-13T08:02:40.437238Z","end":"2026-08-13T08:02:40.618729Z","steps":["trace[711070723] 'process raft request' (duration: 181.170036ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.619181Z","caller":"traceutil/trace.go:171","msg":"trace[1047203082] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"187.250462ms","start":"2026-08-13T08:02:40.43191Z","end":"2026-08-13T08:02:40.61916Z","steps":["trace[1047203082] 'process raft request' (duration: 186.450456ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.61928Z","caller":"traceutil/trace.go:171","msg":"trace[346583877] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"170.850833ms","start":"2026-08-13T08:02:40.448388Z","end":"2026-08-13T08:02:40.619238Z","steps":["trace[346583877] 'process raft request' (duration: 170.260114ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.619355Z","caller":"traceutil/trace.go:171","msg":"trace[1533612580] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"166.528144ms","start":"2026-08-13T08:02:40.452799Z","end":"2026-08-13T08:02:40.619327Z","steps":["trace[1533612580] 'process raft request' (duration: 165.891523ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.619561Z","caller":"traceutil/trace.go:171","msg":"trace[1756600741] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"177.128916ms","start":"2026-08-13T08:02:40.442391Z","end":"2026-08-13T08:02:40.61952Z","steps":["trace[1756600741] 'process raft request' (duration: 176.143684ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.619542Z","caller":"traceutil/trace.go:171","msg":"trace[5981100] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"180.38559ms","start":"2026-08-13T08:02:40.439122Z","end":"2026-08-13T08:02:40.619507Z","steps":["trace[5981100] 'process raft request' (duration: 179.352337ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.619717Z","caller":"traceutil/trace.go:171","msg":"trace[1747868257] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"176.730253ms","start":"2026-08-13T08:02:40.442971Z","end":"2026-08-13T08:02:40.619701Z","steps":["trace[1747868257] 'process raft request' (duration: 175.637797ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.619773Z","caller":"traceutil/trace.go:171","msg":"trace[2141259404] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"126.260414ms","start":"2026-08-13T08:02:40.493486Z","end":"2026-08-13T08:02:40.619747Z","steps":["trace[2141259404] 'process raft request' (duration: 125.349715ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.619845Z","caller":"traceutil/trace.go:171","msg":"trace[1534940945] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"162.267706ms","start":"2026-08-13T08:02:40.457561Z","end":"2026-08-13T08:02:40.619829Z","steps":["trace[1534940945] 'process raft request' (duration: 161.197001ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.619902Z","caller":"traceutil/trace.go:171","msg":"trace[1796796574] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"188.066929ms","start":"2026-08-13T08:02:40.431815Z","end":"2026-08-13T08:02:40.619882Z","steps":["trace[1796796574] 'process raft request' (duration: 186.382474ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.643381Z","caller":"traceutil/trace.go:171","msg":"trace[894320584] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"113.848203ms","start":"2026-08-13T08:02:40.529493Z","end":"2026-08-13T08:02:40.643341Z","steps":["trace[894320584] 'process raft request' (duration: 94.656214ms)","trace[894320584] 'compare' (duration: 18.57854ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:02:40.643591Z","caller":"traceutil/trace.go:171","msg":"trace[224286008] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"113.847493ms","start":"2026-08-13T08:02:40.52971Z","end":"2026-08-13T08:02:40.643558Z","steps":["trace[224286008] 'process raft request' (duration: 113.43122ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.64391Z","caller":"traceutil/trace.go:171","msg":"trace[566957420] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"113.386938ms","start":"2026-08-13T08:02:40.530508Z","end":"2026-08-13T08:02:40.643894Z","steps":["trace[566957420] 'process raft request' (duration: 112.964675ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:40.64394Z","caller":"traceutil/trace.go:171","msg":"trace[167141132] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"107.084055ms","start":"2026-08-13T08:02:40.536836Z","end":"2026-08-13T08:02:40.64392Z","steps":["trace[167141132] 'process raft request' (duration: 106.715273ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:46.205411Z","caller":"traceutil/trace.go:171","msg":"trace[637646828] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"483.696098ms","start":"2026-08-13T08:02:45.7217Z","end":"2026-08-13T08:02:46.205396Z","steps":["trace[637646828] 'process raft request' (duration: 483.247333ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:46.207523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:45.721465Z","time spent":"485.898458ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:02:46.361819Z","caller":"traceutil/trace.go:171","msg":"trace[1975353584] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"106.159765ms","start":"2026-08-13T08:02:46.255637Z","end":"2026-08-13T08:02:46.361797Z","steps":["trace[1975353584] 'process raft request' (duration: 106.113463ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:46.361883Z","caller":"traceutil/trace.go:171","msg":"trace[1033808968] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"165.50545ms","start":"2026-08-13T08:02:46.19634Z","end":"2026-08-13T08:02:46.361845Z","steps":["trace[1033808968] 'process raft request' (duration: 163.081521ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:47.55687Z","caller":"traceutil/trace.go:171","msg":"trace[76754795] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"244.905462ms","start":"2026-08-13T08:02:47.311945Z","end":"2026-08-13T08:02:47.55685Z","steps":["trace[76754795] 'read index received' (duration: 244.351364ms)","trace[76754795] 'applied index is now lower than readState.Index' (duration: 553.328µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:02:47.557042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.081618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-98gmp\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-13T08:02:47.557068Z","caller":"traceutil/trace.go:171","msg":"trace[178820499] range","detail":"{range_begin:/registry/pods/kube-system/cilium-98gmp; range_end:; response_count:1; response_revision:601; }","duration":"245.14812ms","start":"2026-08-13T08:02:47.311911Z","end":"2026-08-13T08:02:47.557059Z","steps":["trace[178820499] 'agreement among raft nodes before linearized reading' (duration: 245.028406ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:47.557346Z","caller":"traceutil/trace.go:171","msg":"trace[933727297] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"251.497855ms","start":"2026-08-13T08:02:47.305817Z","end":"2026-08-13T08:02:47.557315Z","steps":["trace[933727297] 'process raft request' (duration: 250.643137ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:02:47.844744Z","caller":"traceutil/trace.go:171","msg":"trace[933488883] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"232.713409ms","start":"2026-08-13T08:02:47.612002Z","end":"2026-08-13T08:02:47.844715Z","steps":["trace[933488883] 'process raft request' (duration: 138.312543ms)","trace[933488883] 'compare' (duration: 94.219791ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:02:48.641306Z","caller":"traceutil/trace.go:171","msg":"trace[804610159] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"360.094419ms","start":"2026-08-13T08:02:48.281189Z","end":"2026-08-13T08:02:48.641284Z","steps":["trace[804610159] 'process raft request' (duration: 354.539889ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:02:48.641441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:02:48.281158Z","time spent":"360.205682ms","remote":"127.0.0.1:60830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:03:01.706595Z","caller":"traceutil/trace.go:171","msg":"trace[281733291] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"288.445667ms","start":"2026-08-13T08:03:01.418115Z","end":"2026-08-13T08:03:01.706561Z","steps":["trace[281733291] 'process raft request' (duration: 288.298322ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:04.934379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.050208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T08:03:04.934608Z","caller":"traceutil/trace.go:171","msg":"trace[1624099784] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:767; }","duration":"435.352077ms","start":"2026-08-13T08:03:04.499224Z","end":"2026-08-13T08:03:04.934576Z","steps":["trace[1624099784] 'count revisions from in-memory index tree' (duration: 434.959975ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:04.934657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.290239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-13T08:03:04.934691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:04.499207Z","time spent":"435.46366ms","remote":"127.0.0.1:32826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":14,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-08-13T08:03:04.934685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.267005ms","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-13T08:03:04.934706Z","caller":"traceutil/trace.go:171","msg":"trace[193994038] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:767; }","duration":"194.369421ms","start":"2026-08-13T08:03:04.740319Z","end":"2026-08-13T08:03:04.934688Z","steps":["trace[193994038] 'range keys from in-memory index tree' (duration: 194.177845ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:03:04.934742Z","caller":"traceutil/trace.go:171","msg":"trace[1202866253] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:767; }","duration":"647.367068ms","start":"2026-08-13T08:03:04.287359Z","end":"2026-08-13T08:03:04.934726Z","steps":["trace[1202866253] 'count revisions from in-memory index tree' (duration: 647.210453ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:04.934776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:04.287343Z","time spent":"647.42415ms","remote":"127.0.0.1:32812","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-13T08:03:04.934992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.590745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-mg6xr\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-08-13T08:03:04.935024Z","caller":"traceutil/trace.go:171","msg":"trace[1799165005] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-mg6xr; range_end:; response_count:1; response_revision:767; }","duration":"514.648485ms","start":"2026-08-13T08:03:04.420364Z","end":"2026-08-13T08:03:04.935012Z","steps":["trace[1799165005] 'range keys from in-memory index tree' (duration: 514.400198ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:04.935054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:04.420348Z","time spent":"514.699158ms","remote":"127.0.0.1:60914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-mg6xr\" "} {"level":"warn","ts":"2026-08-13T08:03:04.935102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.206821ms","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-13T08:03:04.935132Z","caller":"traceutil/trace.go:171","msg":"trace[285589258] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:767; }","duration":"165.238922ms","start":"2026-08-13T08:03:04.769884Z","end":"2026-08-13T08:03:04.935123Z","steps":["trace[285589258] 'range keys from in-memory index tree' (duration: 165.093987ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:04.934466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.111427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-13T08:03:04.935332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.100092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-13T08:03:04.935379Z","caller":"traceutil/trace.go:171","msg":"trace[966284765] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:767; }","duration":"167.187335ms","start":"2026-08-13T08:03:04.768178Z","end":"2026-08-13T08:03:04.935365Z","steps":["trace[966284765] 'range keys from in-memory index tree' (duration: 166.973198ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:03:04.935485Z","caller":"traceutil/trace.go:171","msg":"trace[1540938740] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:767; }","duration":"169.903022ms","start":"2026-08-13T08:03:04.765273Z","end":"2026-08-13T08:03:04.935176Z","steps":["trace[1540938740] 'range keys from in-memory index tree' (duration: 168.892779ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:03:18.872584Z","caller":"traceutil/trace.go:171","msg":"trace[1973647844] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"236.975676ms","start":"2026-08-13T08:03:18.635556Z","end":"2026-08-13T08:03:18.872532Z","steps":["trace[1973647844] 'process raft request' (duration: 236.876003ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:03:19.191664Z","caller":"traceutil/trace.go:171","msg":"trace[26573127] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"161.043747ms","start":"2026-08-13T08:03:19.030599Z","end":"2026-08-13T08:03:19.191643Z","steps":["trace[26573127] 'process raft request' (duration: 160.910002ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:03:19.192321Z","caller":"traceutil/trace.go:171","msg":"trace[478903417] linearizableReadLoop","detail":"{readStateIndex:937; appliedIndex:935; }","duration":"159.996882ms","start":"2026-08-13T08:03:19.032312Z","end":"2026-08-13T08:03:19.192309Z","steps":["trace[478903417] 'read index received' (duration: 159.216487ms)","trace[478903417] 'applied index is now lower than readState.Index' (duration: 779.715µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:03:19.192389Z","caller":"traceutil/trace.go:171","msg":"trace[1751032922] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"161.718818ms","start":"2026-08-13T08:03:19.030662Z","end":"2026-08-13T08:03:19.192381Z","steps":["trace[1751032922] 'process raft request' (duration: 161.589194ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:19.192494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.169368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-13T08:03:19.192531Z","caller":"traceutil/trace.go:171","msg":"trace[1655955377] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:905; }","duration":"160.245001ms","start":"2026-08-13T08:03:19.032277Z","end":"2026-08-13T08:03:19.192522Z","steps":["trace[1655955377] 'agreement among raft nodes before linearized reading' (duration: 160.105296ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:19.192605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.748715ms","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-13T08:03:19.192632Z","caller":"traceutil/trace.go:171","msg":"trace[2017870286] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:905; }","duration":"155.799837ms","start":"2026-08-13T08:03:19.036825Z","end":"2026-08-13T08:03:19.192625Z","steps":["trace[2017870286] 'agreement among raft nodes before linearized reading' (duration: 155.730445ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:22.438288Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643258555,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:03:22.859948Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.066666726s","expected-duration":"1s"} {"level":"info","ts":"2026-08-13T08:03:22.860403Z","caller":"traceutil/trace.go:171","msg":"trace[1658281420] linearizableReadLoop","detail":"{readStateIndex:951; appliedIndex:950; }","duration":"922.67205ms","start":"2026-08-13T08:03:21.937711Z","end":"2026-08-13T08:03:22.860383Z","steps":["trace[1658281420] 'read index received' (duration: 922.447983ms)","trace[1658281420] 'applied index is now lower than readState.Index' (duration: 223.247µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:03:22.860719Z","caller":"traceutil/trace.go:171","msg":"trace[1037870750] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"1.067555815s","start":"2026-08-13T08:03:21.793156Z","end":"2026-08-13T08:03:22.860712Z","steps":["trace[1037870750] 'process raft request' (duration: 1.06709719s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:22.860808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:21.793128Z","time spent":"1.067614497s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:03:22.861009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"923.30733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:03:22.861034Z","caller":"traceutil/trace.go:171","msg":"trace[489794459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:919; }","duration":"923.379503ms","start":"2026-08-13T08:03:21.937647Z","end":"2026-08-13T08:03:22.861027Z","steps":["trace[489794459] 'agreement among raft nodes before linearized reading' (duration: 923.29538ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:22.861057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:21.937626Z","time spent":"923.422564ms","remote":"127.0.0.1:60724","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-13T08:03:22.861239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.186139ms","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-13T08:03:22.861265Z","caller":"traceutil/trace.go:171","msg":"trace[1208483167] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:919; }","duration":"743.234121ms","start":"2026-08-13T08:03:22.118025Z","end":"2026-08-13T08:03:22.861259Z","steps":["trace[1208483167] 'agreement among raft nodes before linearized reading' (duration: 743.134687ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:22.861283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:22.118009Z","time spent":"743.269161ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-13T08:03:23.413855Z","caller":"traceutil/trace.go:171","msg":"trace[460093890] linearizableReadLoop","detail":"{readStateIndex:952; appliedIndex:951; }","duration":"447.915612ms","start":"2026-08-13T08:03:22.965922Z","end":"2026-08-13T08:03:23.413837Z","steps":["trace[460093890] 'read index received' (duration: 447.781348ms)","trace[460093890] 'applied index is now lower than readState.Index' (duration: 133.184µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:03:23.413948Z","caller":"traceutil/trace.go:171","msg":"trace[71595946] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"546.454712ms","start":"2026-08-13T08:03:22.86748Z","end":"2026-08-13T08:03:23.413934Z","steps":["trace[71595946] 'process raft request' (duration: 546.237245ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:23.414016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.078477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-13T08:03:23.41404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:22.86746Z","time spent":"546.520394ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:03:23.414045Z","caller":"traceutil/trace.go:171","msg":"trace[1383306405] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:920; }","duration":"448.15093ms","start":"2026-08-13T08:03:22.965887Z","end":"2026-08-13T08:03:23.414038Z","steps":["trace[1383306405] 'agreement among raft nodes before linearized reading' (duration: 448.046216ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:23.414093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:22.965863Z","time spent":"448.223432ms","remote":"127.0.0.1:60916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-08-13T08:03:23.492641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.524729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-08-13T08:03:23.492726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.28129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-13T08:03:23.492739Z","caller":"traceutil/trace.go:171","msg":"trace[79569315] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:921; }","duration":"288.663654ms","start":"2026-08-13T08:03:23.204051Z","end":"2026-08-13T08:03:23.492715Z","steps":["trace[79569315] 'agreement among raft nodes before linearized reading' (duration: 288.375885ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:03:23.492758Z","caller":"traceutil/trace.go:171","msg":"trace[1455834963] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:921; }","duration":"283.316011ms","start":"2026-08-13T08:03:23.20943Z","end":"2026-08-13T08:03:23.492746Z","steps":["trace[1455834963] 'agreement among raft nodes before linearized reading' (duration: 283.262759ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:23.49266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.829708ms","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-13T08:03:23.492881Z","caller":"traceutil/trace.go:171","msg":"trace[180340498] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:921; }","duration":"284.090116ms","start":"2026-08-13T08:03:23.208787Z","end":"2026-08-13T08:03:23.492877Z","steps":["trace[180340498] 'agreement among raft nodes before linearized reading' (duration: 283.750785ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:03:23.492933Z","caller":"traceutil/trace.go:171","msg":"trace[729464354] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"176.191885ms","start":"2026-08-13T08:03:23.316729Z","end":"2026-08-13T08:03:23.492921Z","steps":["trace[729464354] 'process raft request' (duration: 175.525283ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:23.49289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.878272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.141\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-13T08:03:23.493053Z","caller":"traceutil/trace.go:171","msg":"trace[1403266759] range","detail":"{range_begin:/registry/masterleases/199.19.213.141; range_end:; response_count:1; response_revision:921; }","duration":"135.12004ms","start":"2026-08-13T08:03:23.357903Z","end":"2026-08-13T08:03:23.493023Z","steps":["trace[1403266759] 'agreement among raft nodes before linearized reading' (duration: 134.623134ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:23.493208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.838515ms","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-13T08:03:23.493322Z","caller":"traceutil/trace.go:171","msg":"trace[6208515] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:921; }","duration":"287.035581ms","start":"2026-08-13T08:03:23.206261Z","end":"2026-08-13T08:03:23.493297Z","steps":["trace[6208515] 'agreement among raft nodes before linearized reading' (duration: 286.560816ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:03:43.962218Z","caller":"traceutil/trace.go:171","msg":"trace[389287781] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"115.407936ms","start":"2026-08-13T08:03:43.846762Z","end":"2026-08-13T08:03:43.96217Z","steps":["trace[389287781] 'process raft request' (duration: 93.441231ms)","trace[389287781] 'compare' (duration: 21.565512ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:03:54.228104Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643258838,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-13T08:03:54.283387Z","caller":"traceutil/trace.go:171","msg":"trace[1349336433] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"563.483774ms","start":"2026-08-13T08:03:53.719884Z","end":"2026-08-13T08:03:54.283368Z","steps":["trace[1349336433] 'process raft request' (duration: 563.37001ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:54.286624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:53.71987Z","time spent":"566.628585ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:03:54.303955Z","caller":"traceutil/trace.go:171","msg":"trace[1404302893] linearizableReadLoop","detail":"{readStateIndex:1065; appliedIndex:1064; }","duration":"576.167432ms","start":"2026-08-13T08:03:53.72777Z","end":"2026-08-13T08:03:54.303938Z","steps":["trace[1404302893] 'read index received' (duration: 557.12289ms)","trace[1404302893] 'applied index is now lower than readState.Index' (duration: 19.043892ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:03:54.304061Z","caller":"traceutil/trace.go:171","msg":"trace[962206348] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"297.591416ms","start":"2026-08-13T08:03:54.006456Z","end":"2026-08-13T08:03:54.304047Z","steps":["trace[962206348] 'process raft request' (duration: 287.74633ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:54.304262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.484571ms","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-13T08:03:54.304291Z","caller":"traceutil/trace.go:171","msg":"trace[1842440208] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1026; }","duration":"576.542414ms","start":"2026-08-13T08:03:53.727738Z","end":"2026-08-13T08:03:54.30428Z","steps":["trace[1842440208] 'agreement among raft nodes before linearized reading' (duration: 576.43376ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:54.304333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:53.727727Z","time spent":"576.593785ms","remote":"127.0.0.1:60980","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-13T08:03:54.304407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.183826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:03:54.304632Z","caller":"traceutil/trace.go:171","msg":"trace[1876857172] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1026; }","duration":"483.683341ms","start":"2026-08-13T08:03:53.820935Z","end":"2026-08-13T08:03:54.304618Z","steps":["trace[1876857172] 'agreement among raft nodes before linearized reading' (duration: 483.422913ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:54.304661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:53.820917Z","time spent":"483.736014ms","remote":"127.0.0.1:32782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-13T08:03:54.304703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.718744ms","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-13T08:03:54.304736Z","caller":"traceutil/trace.go:171","msg":"trace[1759268383] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1026; }","duration":"469.779085ms","start":"2026-08-13T08:03:53.834948Z","end":"2026-08-13T08:03:54.304727Z","steps":["trace[1759268383] 'agreement among raft nodes before linearized reading' (duration: 469.688212ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:54.304762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:53.834934Z","time spent":"469.821737ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-13T08:03:54.304851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.515039ms","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-13T08:03:54.304874Z","caller":"traceutil/trace.go:171","msg":"trace[54085686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1026; }","duration":"470.574171ms","start":"2026-08-13T08:03:53.834294Z","end":"2026-08-13T08:03:54.304868Z","steps":["trace[54085686] 'agreement among raft nodes before linearized reading' (duration: 470.488658ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:54.304891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:53.834277Z","time spent":"470.609672ms","remote":"127.0.0.1:60980","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-08-13T08:03:56.274647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.675035ms","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":"warn","ts":"2026-08-13T08:03:56.274693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.717301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:03:56.274714Z","caller":"traceutil/trace.go:171","msg":"trace[947422888] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1030; }","duration":"688.792698ms","start":"2026-08-13T08:03:55.585908Z","end":"2026-08-13T08:03:56.274701Z","steps":["trace[947422888] 'range keys from in-memory index tree' (duration: 688.534419ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:03:56.274736Z","caller":"traceutil/trace.go:171","msg":"trace[694082287] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1030; }","duration":"335.787073ms","start":"2026-08-13T08:03:55.938935Z","end":"2026-08-13T08:03:56.274722Z","steps":["trace[694082287] 'range keys from in-memory index tree' (duration: 335.667648ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:56.274747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:55.585889Z","time spent":"688.84963ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-13T08:03:56.27477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:55.938919Z","time spent":"335.842474ms","remote":"127.0.0.1:60724","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-13T08:03:56.794978Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643258853,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-13T08:03:56.854161Z","caller":"traceutil/trace.go:171","msg":"trace[335380699] linearizableReadLoop","detail":"{readStateIndex:1070; appliedIndex:1069; }","duration":"559.697412ms","start":"2026-08-13T08:03:56.294423Z","end":"2026-08-13T08:03:56.85412Z","steps":["trace[335380699] 'read index received' (duration: 559.403743ms)","trace[335380699] 'applied index is now lower than readState.Index' (duration: 291.349µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:03:56.854232Z","caller":"traceutil/trace.go:171","msg":"trace[1512288265] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"575.932044ms","start":"2026-08-13T08:03:56.278269Z","end":"2026-08-13T08:03:56.854201Z","steps":["trace[1512288265] 'process raft request' (duration: 575.593313ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:56.854488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.050674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-13T08:03:56.85457Z","caller":"traceutil/trace.go:171","msg":"trace[1720845295] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1031; }","duration":"560.172468ms","start":"2026-08-13T08:03:56.294376Z","end":"2026-08-13T08:03:56.854549Z","steps":["trace[1720845295] 'agreement among raft nodes before linearized reading' (duration: 559.93109ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:56.854618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:56.29436Z","time spent":"560.246521ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-13T08:03:56.854775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.83935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-13T08:03:56.854831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.11564ms","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-13T08:03:56.854993Z","caller":"traceutil/trace.go:171","msg":"trace[1551080582] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1031; }","duration":"532.968344ms","start":"2026-08-13T08:03:56.321884Z","end":"2026-08-13T08:03:56.854853Z","steps":["trace[1551080582] 'agreement among raft nodes before linearized reading' (duration: 532.638314ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:56.85506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:56.321828Z","time spent":"533.220902ms","remote":"127.0.0.1:60980","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-13T08:03:56.855001Z","caller":"traceutil/trace.go:171","msg":"trace[884897821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1031; }","duration":"543.377608ms","start":"2026-08-13T08:03:56.311589Z","end":"2026-08-13T08:03:56.854966Z","steps":["trace[884897821] 'agreement among raft nodes before linearized reading' (duration: 542.850511ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:56.855136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.897446ms","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-13T08:03:56.855907Z","caller":"traceutil/trace.go:171","msg":"trace[1468764485] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1031; }","duration":"530.714732ms","start":"2026-08-13T08:03:56.32515Z","end":"2026-08-13T08:03:56.855865Z","steps":["trace[1468764485] 'agreement among raft nodes before linearized reading' (duration: 529.298697ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:56.855973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:56.32513Z","time spent":"530.826546ms","remote":"127.0.0.1:60980","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-13T08:03:56.855267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:56.31156Z","time spent":"543.689228ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-13T08:03:56.855274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:56.278248Z","time spent":"576.045518ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:03:57.215545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.207172ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:03:57.215664Z","caller":"traceutil/trace.go:171","msg":"trace[137738918] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"354.194563ms","start":"2026-08-13T08:03:56.861451Z","end":"2026-08-13T08:03:57.215645Z","steps":["trace[137738918] 'process raft request' (duration: 175.66166ms)","trace[137738918] 'compare' (duration: 178.042517ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:03:57.215728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:56.861422Z","time spent":"354.273056ms","remote":"127.0.0.1:60980","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-13T08:03:57.278091Z","caller":"traceutil/trace.go:171","msg":"trace[1004926566] linearizableReadLoop","detail":"{readStateIndex:1074; appliedIndex:1071; }","duration":"226.163273ms","start":"2026-08-13T08:03:57.051909Z","end":"2026-08-13T08:03:57.278072Z","steps":["trace[1004926566] 'read index received' (duration: 226.023398ms)","trace[1004926566] 'applied index is now lower than readState.Index' (duration: 138.945µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:03:57.278169Z","caller":"traceutil/trace.go:171","msg":"trace[2083842872] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"416.640359ms","start":"2026-08-13T08:03:56.861508Z","end":"2026-08-13T08:03:57.278148Z","steps":["trace[2083842872] 'process raft request' (duration: 416.503705ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:03:57.278175Z","caller":"traceutil/trace.go:171","msg":"trace[1812768281] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"416.66752ms","start":"2026-08-13T08:03:56.861478Z","end":"2026-08-13T08:03:57.278146Z","steps":["trace[1812768281] 'process raft request' (duration: 416.415562ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:57.278237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.324997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T08:03:57.278261Z","caller":"traceutil/trace.go:171","msg":"trace[2139084910] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1035; }","duration":"226.423491ms","start":"2026-08-13T08:03:57.051831Z","end":"2026-08-13T08:03:57.278254Z","steps":["trace[2139084910] 'agreement among raft nodes before linearized reading' (duration: 226.322937ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:57.278317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:56.861463Z","time spent":"416.758162ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:03:57.278326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:56.861454Z","time spent":"416.777523ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:03:57.278374Z","caller":"traceutil/trace.go:171","msg":"trace[936719211] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"416.441413ms","start":"2026-08-13T08:03:56.861886Z","end":"2026-08-13T08:03:57.278327Z","steps":["trace[936719211] 'process raft request' (duration: 416.159724ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:03:57.278551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:56.861876Z","time spent":"416.573147ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:03:57.546451Z","caller":"traceutil/trace.go:171","msg":"trace[2045604980] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"436.489846ms","start":"2026-08-13T08:03:57.109943Z","end":"2026-08-13T08:03:57.546433Z","steps":["trace[2045604980] 'process raft request' (duration: 415.576744ms)","trace[2045604980] 'compare' (duration: 20.165198ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:03:57.548796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:03:57.10992Z","time spent":"438.759039ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:04:13.043673Z","caller":"traceutil/trace.go:171","msg":"trace[679281353] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"102.346047ms","start":"2026-08-13T08:04:12.941296Z","end":"2026-08-13T08:04:13.043642Z","steps":["trace[679281353] 'process raft request' (duration: 102.180051ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:13.453333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.738947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-13T08:04:13.453432Z","caller":"traceutil/trace.go:171","msg":"trace[1442457799] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1084; }","duration":"110.874841ms","start":"2026-08-13T08:04:13.342529Z","end":"2026-08-13T08:04:13.453404Z","steps":["trace[1442457799] 'range keys from in-memory index tree' (duration: 110.579042ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:13.453757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.240739ms","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-13T08:04:13.453877Z","caller":"traceutil/trace.go:171","msg":"trace[1730993040] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1084; }","duration":"100.494048ms","start":"2026-08-13T08:04:13.353355Z","end":"2026-08-13T08:04:13.453849Z","steps":["trace[1730993040] 'range keys from in-memory index tree' (duration: 99.6364ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:15.182132Z","caller":"traceutil/trace.go:171","msg":"trace[697541844] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"126.73931ms","start":"2026-08-13T08:04:15.054994Z","end":"2026-08-13T08:04:15.181733Z","steps":["trace[697541844] 'process raft request' (duration: 126.526843ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:17.816319Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643259125,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:04:18.316992Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643259125,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:04:18.465746Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.275748587s","expected-duration":"1s"} {"level":"info","ts":"2026-08-13T08:04:18.466397Z","caller":"traceutil/trace.go:171","msg":"trace[1164335954] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"1.27649522s","start":"2026-08-13T08:04:17.18988Z","end":"2026-08-13T08:04:18.466375Z","steps":["trace[1164335954] 'process raft request' (duration: 1.276355696s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:18.466546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:17.189859Z","time spent":"1.276591254s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:04:18.51321Z","caller":"traceutil/trace.go:171","msg":"trace[992167792] transaction","detail":"{read_only:false; response_revision:1150; number_of_response:1; }","duration":"847.740381ms","start":"2026-08-13T08:04:17.665449Z","end":"2026-08-13T08:04:18.51319Z","steps":["trace[992167792] 'process raft request' (duration: 847.587376ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:18.513522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:17.66543Z","time spent":"847.837975ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:04:18.51354Z","caller":"traceutil/trace.go:171","msg":"trace[1493721798] linearizableReadLoop","detail":"{readStateIndex:1196; appliedIndex:1193; }","duration":"1.198105073s","start":"2026-08-13T08:04:17.315405Z","end":"2026-08-13T08:04:18.51351Z","steps":["trace[1493721798] 'read index received' (duration: 1.150831575s)","trace[1493721798] 'applied index is now lower than readState.Index' (duration: 47.271618ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:04:18.513635Z","caller":"traceutil/trace.go:171","msg":"trace[293764332] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"255.390831ms","start":"2026-08-13T08:04:18.258238Z","end":"2026-08-13T08:04:18.513628Z","steps":["trace[293764332] 'process raft request' (duration: 254.905325ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:18.513717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.166922181s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:04:18.513738Z","caller":"traceutil/trace.go:171","msg":"trace[1513700426] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1151; }","duration":"1.166964853s","start":"2026-08-13T08:04:17.346766Z","end":"2026-08-13T08:04:18.513731Z","steps":["trace[1513700426] 'agreement among raft nodes before linearized reading' (duration: 1.166924772s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:18.51376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:17.346753Z","time spent":"1.166997773s","remote":"127.0.0.1:35356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-08-13T08:04:18.513794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.198362191s","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-13T08:04:18.513827Z","caller":"traceutil/trace.go:171","msg":"trace[917843928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1151; }","duration":"1.198439214s","start":"2026-08-13T08:04:17.315378Z","end":"2026-08-13T08:04:18.513817Z","steps":["trace[917843928] 'agreement among raft nodes before linearized reading' (duration: 1.198267608s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:18.513869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:17.315362Z","time spent":"1.198499375s","remote":"127.0.0.1:60980","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-08-13T08:04:18.513959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.544567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-13T08:04:18.514003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"901.56912ms","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-13T08:04:18.514016Z","caller":"traceutil/trace.go:171","msg":"trace[2072721598] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1151; }","duration":"881.63294ms","start":"2026-08-13T08:04:17.63237Z","end":"2026-08-13T08:04:18.514003Z","steps":["trace[2072721598] 'agreement among raft nodes before linearized reading' (duration: 881.473754ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:18.514027Z","caller":"traceutil/trace.go:171","msg":"trace[1441302551] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1151; }","duration":"901.663333ms","start":"2026-08-13T08:04:17.612357Z","end":"2026-08-13T08:04:18.51402Z","steps":["trace[1441302551] 'agreement among raft nodes before linearized reading' (duration: 901.57725ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:18.514047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:17.632354Z","time spent":"881.684362ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-13T08:04:18.514052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:17.612335Z","time spent":"901.709375ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-13T08:04:18.514158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.576238ms","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-13T08:04:18.514179Z","caller":"traceutil/trace.go:171","msg":"trace[323440344] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1151; }","duration":"881.6217ms","start":"2026-08-13T08:04:17.632552Z","end":"2026-08-13T08:04:18.514174Z","steps":["trace[323440344] 'agreement among raft nodes before linearized reading' (duration: 881.562248ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:18.514196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:17.632532Z","time spent":"881.659661ms","remote":"127.0.0.1:60980","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-13T08:04:30.972916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.557818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-13T08:04:30.972997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.663911ms","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-13T08:04:30.973057Z","caller":"traceutil/trace.go:171","msg":"trace[1990721907] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1192; }","duration":"163.755225ms","start":"2026-08-13T08:04:30.809279Z","end":"2026-08-13T08:04:30.973034Z","steps":["trace[1990721907] 'range keys from in-memory index tree' (duration: 163.200807ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:30.97309Z","caller":"traceutil/trace.go:171","msg":"trace[229106866] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1192; }","duration":"163.813506ms","start":"2026-08-13T08:04:30.809261Z","end":"2026-08-13T08:04:30.973074Z","steps":["trace[229106866] 'range keys from in-memory index tree' (duration: 163.402203ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:31.080917Z","caller":"traceutil/trace.go:171","msg":"trace[737666661] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"104.771554ms","start":"2026-08-13T08:04:30.976113Z","end":"2026-08-13T08:04:31.080885Z","steps":["trace[737666661] 'process raft request' (duration: 104.562437ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:31.092436Z","caller":"traceutil/trace.go:171","msg":"trace[364554467] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"115.170693ms","start":"2026-08-13T08:04:30.977236Z","end":"2026-08-13T08:04:31.092407Z","steps":["trace[364554467] 'process raft request' (duration: 115.013988ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:32.749557Z","caller":"traceutil/trace.go:171","msg":"trace[1358801474] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"216.818707ms","start":"2026-08-13T08:04:32.532704Z","end":"2026-08-13T08:04:32.749523Z","steps":["trace[1358801474] 'process raft request' (duration: 216.657322ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:32.766652Z","caller":"traceutil/trace.go:171","msg":"trace[1548610119] linearizableReadLoop","detail":"{readStateIndex:1244; appliedIndex:1242; }","duration":"105.252949ms","start":"2026-08-13T08:04:32.661381Z","end":"2026-08-13T08:04:32.766634Z","steps":["trace[1548610119] 'read index received' (duration: 87.94633ms)","trace[1548610119] 'applied index is now lower than readState.Index' (duration: 17.305999ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:04:32.766698Z","caller":"traceutil/trace.go:171","msg":"trace[935617147] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"202.824543ms","start":"2026-08-13T08:04:32.56386Z","end":"2026-08-13T08:04:32.766684Z","steps":["trace[935617147] 'process raft request' (duration: 202.676169ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:32.766808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.416824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-13T08:04:32.766839Z","caller":"traceutil/trace.go:171","msg":"trace[1403816264] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1196; }","duration":"105.504846ms","start":"2026-08-13T08:04:32.661326Z","end":"2026-08-13T08:04:32.766831Z","steps":["trace[1403816264] 'agreement among raft nodes before linearized reading' (duration: 105.383682ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:32.931979Z","caller":"traceutil/trace.go:171","msg":"trace[228825881] linearizableReadLoop","detail":"{readStateIndex:1245; appliedIndex:1244; }","duration":"134.673782ms","start":"2026-08-13T08:04:32.797285Z","end":"2026-08-13T08:04:32.931959Z","steps":["trace[228825881] 'read index received' (duration: 40.309769ms)","trace[228825881] 'applied index is now lower than readState.Index' (duration: 94.363093ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:04:32.932075Z","caller":"traceutil/trace.go:171","msg":"trace[27140009] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"161.444271ms","start":"2026-08-13T08:04:32.770597Z","end":"2026-08-13T08:04:32.932041Z","steps":["trace[27140009] 'process raft request' (duration: 66.980794ms)","trace[27140009] 'compare' (duration: 94.2639ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:04:32.932124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.135314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:04:32.932153Z","caller":"traceutil/trace.go:171","msg":"trace[536793728] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1197; }","duration":"122.226627ms","start":"2026-08-13T08:04:32.809917Z","end":"2026-08-13T08:04:32.932144Z","steps":["trace[536793728] 'agreement among raft nodes before linearized reading' (duration: 122.155945ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:32.932219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.917529ms","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-13T08:04:32.932274Z","caller":"traceutil/trace.go:171","msg":"trace[1145952035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1197; }","duration":"135.030113ms","start":"2026-08-13T08:04:32.797231Z","end":"2026-08-13T08:04:32.932261Z","steps":["trace[1145952035] 'agreement among raft nodes before linearized reading' (duration: 134.831766ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:35.347913Z","caller":"traceutil/trace.go:171","msg":"trace[1295064024] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"250.131784ms","start":"2026-08-13T08:04:35.097761Z","end":"2026-08-13T08:04:35.347893Z","steps":["trace[1295064024] 'process raft request' (duration: 250.019331ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:35.377779Z","caller":"traceutil/trace.go:171","msg":"trace[693208060] linearizableReadLoop","detail":"{readStateIndex:1256; appliedIndex:1254; }","duration":"255.325868ms","start":"2026-08-13T08:04:35.122433Z","end":"2026-08-13T08:04:35.377759Z","steps":["trace[693208060] 'read index received' (duration: 225.41242ms)","trace[693208060] 'applied index is now lower than readState.Index' (duration: 29.912478ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:04:35.377871Z","caller":"traceutil/trace.go:171","msg":"trace[840961608] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"258.703096ms","start":"2026-08-13T08:04:35.119155Z","end":"2026-08-13T08:04:35.377859Z","steps":["trace[840961608] 'process raft request' (duration: 258.49556ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:35.378096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.436501ms","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-13T08:04:35.378176Z","caller":"traceutil/trace.go:171","msg":"trace[1215342690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1207; }","duration":"173.555775ms","start":"2026-08-13T08:04:35.204604Z","end":"2026-08-13T08:04:35.37816Z","steps":["trace[1215342690] 'agreement among raft nodes before linearized reading' (duration: 173.295667ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:35.378156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.706491ms","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-13T08:04:35.378228Z","caller":"traceutil/trace.go:171","msg":"trace[1046640203] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1207; }","duration":"255.823975ms","start":"2026-08-13T08:04:35.12239Z","end":"2026-08-13T08:04:35.378214Z","steps":["trace[1046640203] 'agreement among raft nodes before linearized reading' (duration: 255.542636ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:35.547108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.056976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T08:04:35.547337Z","caller":"traceutil/trace.go:171","msg":"trace[1207922655] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"163.406714ms","start":"2026-08-13T08:04:35.383908Z","end":"2026-08-13T08:04:35.547315Z","steps":["trace[1207922655] 'process raft request' (duration: 163.333891ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:35.547761Z","caller":"traceutil/trace.go:171","msg":"trace[1249800019] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"164.26108ms","start":"2026-08-13T08:04:35.383482Z","end":"2026-08-13T08:04:35.547744Z","steps":["trace[1249800019] 'process raft request' (duration: 15.470351ms)","trace[1249800019] 'compare' (duration: 147.716985ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:04:36.814237Z","caller":"traceutil/trace.go:171","msg":"trace[44702928] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"399.291875ms","start":"2026-08-13T08:04:36.414902Z","end":"2026-08-13T08:04:36.814194Z","steps":["trace[44702928] 'process raft request' (duration: 399.140401ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:36.814453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:36.414877Z","time spent":"399.498902ms","remote":"127.0.0.1:60806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":751,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-13T08:04:39.072713Z","caller":"traceutil/trace.go:171","msg":"trace[870086406] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"104.652099ms","start":"2026-08-13T08:04:38.968021Z","end":"2026-08-13T08:04:39.072673Z","steps":["trace[870086406] 'process raft request' (duration: 104.172724ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:40.042917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.921858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:04:40.043003Z","caller":"traceutil/trace.go:171","msg":"trace[1905526987] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1249; }","duration":"105.059502ms","start":"2026-08-13T08:04:39.937924Z","end":"2026-08-13T08:04:40.042984Z","steps":["trace[1905526987] 'range keys from in-memory index tree' (duration: 104.824985ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:47.606901Z","caller":"traceutil/trace.go:171","msg":"trace[66665814] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"486.658516ms","start":"2026-08-13T08:04:47.120206Z","end":"2026-08-13T08:04:47.606865Z","steps":["trace[66665814] 'process raft request' (duration: 486.44342ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:47.607133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:47.120192Z","time spent":"486.851913ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:04:47.62119Z","caller":"traceutil/trace.go:171","msg":"trace[1903887579] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"499.014388ms","start":"2026-08-13T08:04:47.122139Z","end":"2026-08-13T08:04:47.621153Z","steps":["trace[1903887579] 'process raft request' (duration: 498.75579ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:47.621342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:47.12213Z","time spent":"499.138362ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:04:52.96469Z","caller":"traceutil/trace.go:171","msg":"trace[1253799955] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"115.417451ms","start":"2026-08-13T08:04:52.849239Z","end":"2026-08-13T08:04:52.964656Z","steps":["trace[1253799955] 'process raft request' (duration: 115.213164ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:04:53.082126Z","caller":"traceutil/trace.go:171","msg":"trace[158433103] linearizableReadLoop","detail":"{readStateIndex:1385; appliedIndex:1383; }","duration":"186.986901ms","start":"2026-08-13T08:04:52.895108Z","end":"2026-08-13T08:04:53.082095Z","steps":["trace[158433103] 'read index received' (duration: 69.489264ms)","trace[158433103] 'applied index is now lower than readState.Index' (duration: 117.496497ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:04:53.082281Z","caller":"traceutil/trace.go:171","msg":"trace[639522862] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"205.443477ms","start":"2026-08-13T08:04:52.87682Z","end":"2026-08-13T08:04:53.082263Z","steps":["trace[639522862] 'process raft request' (duration: 192.491655ms)","trace[639522862] 'compare' (duration: 12.662092ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:04:53.082474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.415323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:04:53.082553Z","caller":"traceutil/trace.go:171","msg":"trace[701071131] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1333; }","duration":"145.543717ms","start":"2026-08-13T08:04:52.936994Z","end":"2026-08-13T08:04:53.082538Z","steps":["trace[701071131] 'agreement among raft nodes before linearized reading' (duration: 145.420443ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:53.082594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.479307ms","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-08-13T08:04:53.082629Z","caller":"traceutil/trace.go:171","msg":"trace[1099508351] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1333; }","duration":"187.541789ms","start":"2026-08-13T08:04:52.895079Z","end":"2026-08-13T08:04:53.082621Z","steps":["trace[1099508351] 'agreement among raft nodes before linearized reading' (duration: 187.403694ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:54.001117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.411885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-13T08:04:54.001183Z","caller":"traceutil/trace.go:171","msg":"trace[849394467] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1335; }","duration":"326.509818ms","start":"2026-08-13T08:04:53.674657Z","end":"2026-08-13T08:04:54.001167Z","steps":["trace[849394467] 'range keys from in-memory index tree' (duration: 326.219219ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:54.00137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:53.674652Z","time spent":"326.56231ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-13T08:04:54.001674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.571042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-13T08:04:54.001708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.122056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-13T08:04:54.001742Z","caller":"traceutil/trace.go:171","msg":"trace[753340802] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:1335; }","duration":"518.178667ms","start":"2026-08-13T08:04:53.483555Z","end":"2026-08-13T08:04:54.001734Z","steps":["trace[753340802] 'range keys from in-memory index tree' (duration: 518.064494ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:54.001765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:53.48354Z","time spent":"518.218129ms","remote":"127.0.0.1:60754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"info","ts":"2026-08-13T08:04:54.001929Z","caller":"traceutil/trace.go:171","msg":"trace[2055120082] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1335; }","duration":"327.697465ms","start":"2026-08-13T08:04:53.674071Z","end":"2026-08-13T08:04:54.001768Z","steps":["trace[2055120082] 'range keys from in-memory index tree' (duration: 327.492749ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:54.002002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:53.674056Z","time spent":"327.938474ms","remote":"127.0.0.1:60980","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-13T08:04:54.002114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.401626ms","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-13T08:04:54.002178Z","caller":"traceutil/trace.go:171","msg":"trace[1497406489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1335; }","duration":"327.471558ms","start":"2026-08-13T08:04:53.674698Z","end":"2026-08-13T08:04:54.00217Z","steps":["trace[1497406489] 'range keys from in-memory index tree' (duration: 327.352385ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:54.002234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:53.674695Z","time spent":"327.531971ms","remote":"127.0.0.1:60980","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-08-13T08:04:54.002438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.822874ms","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-13T08:04:54.002462Z","caller":"traceutil/trace.go:171","msg":"trace[43185747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1335; }","duration":"318.867476ms","start":"2026-08-13T08:04:53.683589Z","end":"2026-08-13T08:04:54.002457Z","steps":["trace[43185747] 'range keys from in-memory index tree' (duration: 318.766043ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:04:54.00253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:04:53.683579Z","time spent":"318.942838ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-13T08:05:10.353661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.949688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-13T08:05:10.35375Z","caller":"traceutil/trace.go:171","msg":"trace[1168760752] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1413; }","duration":"116.090413ms","start":"2026-08-13T08:05:10.237639Z","end":"2026-08-13T08:05:10.353729Z","steps":["trace[1168760752] 'range keys from in-memory index tree' (duration: 115.761722ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:10.353857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.253868ms","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-13T08:05:10.353927Z","caller":"traceutil/trace.go:171","msg":"trace[1194904145] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1413; }","duration":"116.380172ms","start":"2026-08-13T08:05:10.237529Z","end":"2026-08-13T08:05:10.353909Z","steps":["trace[1194904145] 'range keys from in-memory index tree' (duration: 115.975498ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:05:10.472164Z","caller":"traceutil/trace.go:171","msg":"trace[1315689735] transaction","detail":"{read_only:false; response_revision:1414; number_of_response:1; }","duration":"114.201433ms","start":"2026-08-13T08:05:10.357931Z","end":"2026-08-13T08:05:10.472132Z","steps":["trace[1315689735] 'process raft request' (duration: 114.046248ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:05:10.540105Z","caller":"traceutil/trace.go:171","msg":"trace[2101750147] transaction","detail":"{read_only:false; response_revision:1415; number_of_response:1; }","duration":"180.890848ms","start":"2026-08-13T08:05:10.359184Z","end":"2026-08-13T08:05:10.540075Z","steps":["trace[2101750147] 'process raft request' (duration: 180.740483ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:05:20.846157Z","caller":"traceutil/trace.go:171","msg":"trace[49260851] transaction","detail":"{read_only:false; response_revision:1462; number_of_response:1; }","duration":"130.585692ms","start":"2026-08-13T08:05:20.715536Z","end":"2026-08-13T08:05:20.846121Z","steps":["trace[49260851] 'process raft request' (duration: 95.50437ms)","trace[49260851] 'compare' (duration: 34.918687ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:05:21.4294Z","caller":"traceutil/trace.go:171","msg":"trace[118259460] transaction","detail":"{read_only:false; response_revision:1464; number_of_response:1; }","duration":"149.508542ms","start":"2026-08-13T08:05:21.279873Z","end":"2026-08-13T08:05:21.429382Z","steps":["trace[118259460] 'process raft request' (duration: 81.582747ms)","trace[118259460] 'compare' (duration: 67.835932ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:05:30.21311Z","caller":"traceutil/trace.go:171","msg":"trace[2060235166] transaction","detail":"{read_only:false; response_revision:1503; number_of_response:1; }","duration":"253.881344ms","start":"2026-08-13T08:05:29.959208Z","end":"2026-08-13T08:05:30.21309Z","steps":["trace[2060235166] 'process raft request' (duration: 252.715798ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:05:51.867383Z","caller":"traceutil/trace.go:171","msg":"trace[1356230245] transaction","detail":"{read_only:false; response_revision:1601; number_of_response:1; }","duration":"545.049199ms","start":"2026-08-13T08:05:51.322297Z","end":"2026-08-13T08:05:51.867346Z","steps":["trace[1356230245] 'process raft request' (duration: 544.861683ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:05:51.86728Z","caller":"traceutil/trace.go:171","msg":"trace[1912986952] linearizableReadLoop","detail":"{readStateIndex:1665; appliedIndex:1664; }","duration":"299.085252ms","start":"2026-08-13T08:05:51.568179Z","end":"2026-08-13T08:05:51.867264Z","steps":["trace[1912986952] 'read index received' (duration: 298.962258ms)","trace[1912986952] 'applied index is now lower than readState.Index' (duration: 122.334µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:05:51.867527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:51.322276Z","time spent":"545.180913ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:05:51.868062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.163174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-08-13T08:05:51.868089Z","caller":"traceutil/trace.go:171","msg":"trace[1152312529] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1601; }","duration":"227.253666ms","start":"2026-08-13T08:05:51.640825Z","end":"2026-08-13T08:05:51.868079Z","steps":["trace[1152312529] 'agreement among raft nodes before linearized reading' (duration: 227.168974ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:51.867682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.483415ms","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-08-13T08:05:51.868182Z","caller":"traceutil/trace.go:171","msg":"trace[954346385] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1601; }","duration":"300.037593ms","start":"2026-08-13T08:05:51.568136Z","end":"2026-08-13T08:05:51.868173Z","steps":["trace[954346385] 'agreement among raft nodes before linearized reading' (duration: 299.431274ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:51.868207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:51.568114Z","time spent":"300.085544ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-13T08:05:52.43811Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643260187,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:05:52.938821Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643260187,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:05:53.799143Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643260187,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:05:54.773824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.83748895s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-13T08:05:54.773986Z","caller":"traceutil/trace.go:171","msg":"trace[294279695] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.837685196s","start":"2026-08-13T08:05:51.93627Z","end":"2026-08-13T08:05:54.773955Z","steps":["trace[294279695] 'agreement among raft nodes before linearized reading' (duration: 2.837481729s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:54.774066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:51.936209Z","time spent":"2.837844431s","remote":"127.0.0.1:60724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-13T08:05:54.774374Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643260187,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:05:55.276209Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643260187,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:05:55.776919Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643260187,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:05:56.255224Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.369963758s","expected-duration":"1s"} {"level":"info","ts":"2026-08-13T08:05:56.264812Z","caller":"traceutil/trace.go:171","msg":"trace[1938005232] transaction","detail":"{read_only:false; response_revision:1603; number_of_response:1; }","duration":"4.381129777s","start":"2026-08-13T08:05:51.883665Z","end":"2026-08-13T08:05:56.264795Z","steps":["trace[1938005232] 'process raft request' (duration: 4.372158509s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:56.264931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:51.883643Z","time spent":"4.38122271s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:05:56.265013Z","caller":"traceutil/trace.go:171","msg":"trace[1013498527] linearizableReadLoop","detail":"{readStateIndex:1668; appliedIndex:1666; }","duration":"4.328718964s","start":"2026-08-13T08:05:51.936276Z","end":"2026-08-13T08:05:56.264995Z","steps":["trace[1013498527] 'read index received' (duration: 4.319568611s)","trace[1013498527] 'applied index is now lower than readState.Index' (duration: 9.149423ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:05:56.265177Z","caller":"traceutil/trace.go:171","msg":"trace[387559442] transaction","detail":"{read_only:false; response_revision:1604; number_of_response:1; }","duration":"1.893015943s","start":"2026-08-13T08:05:54.372152Z","end":"2026-08-13T08:05:56.265168Z","steps":["trace[387559442] 'process raft request' (duration: 1.892597949s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:56.265219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:54.372121Z","time spent":"1.893074094s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:05:56.265303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.830794597s","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-13T08:05:56.26533Z","caller":"traceutil/trace.go:171","msg":"trace[1026102601] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1604; }","duration":"3.830893991s","start":"2026-08-13T08:05:52.434428Z","end":"2026-08-13T08:05:56.265322Z","steps":["trace[1026102601] 'agreement among raft nodes before linearized reading' (duration: 3.830779287s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:56.265351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:52.434414Z","time spent":"3.830931782s","remote":"127.0.0.1:60980","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-13T08:05:56.265459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.465782562s","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-13T08:05:56.265484Z","caller":"traceutil/trace.go:171","msg":"trace[822274564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1604; }","duration":"2.465814543s","start":"2026-08-13T08:05:53.799662Z","end":"2026-08-13T08:05:56.265477Z","steps":["trace[822274564] 'agreement among raft nodes before linearized reading' (duration: 2.46571894s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:56.265507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:53.799659Z","time spent":"2.465843134s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-13T08:05:56.265548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.465886666s","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":"info","ts":"2026-08-13T08:05:56.26557Z","caller":"traceutil/trace.go:171","msg":"trace[589005120] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1604; }","duration":"2.465921446s","start":"2026-08-13T08:05:53.799642Z","end":"2026-08-13T08:05:56.265564Z","steps":["trace[589005120] 'agreement among raft nodes before linearized reading' (duration: 2.465859044s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:56.265588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:53.799639Z","time spent":"2.465944777s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-08-13T08:05:56.265634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"978.102177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-08-13T08:05:56.2657Z","caller":"traceutil/trace.go:171","msg":"trace[1417438171] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1604; }","duration":"978.133058ms","start":"2026-08-13T08:05:55.287515Z","end":"2026-08-13T08:05:56.265648Z","steps":["trace[1417438171] 'agreement among raft nodes before linearized reading' (duration: 978.073576ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:56.265724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:55.287509Z","time spent":"978.20805ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-08-13T08:05:56.265729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.466098342s","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:534"} {"level":"info","ts":"2026-08-13T08:05:56.265753Z","caller":"traceutil/trace.go:171","msg":"trace[503887321] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1604; }","duration":"2.466126313s","start":"2026-08-13T08:05:53.799617Z","end":"2026-08-13T08:05:56.265744Z","steps":["trace[503887321] 'agreement among raft nodes before linearized reading' (duration: 2.466065421s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:56.265771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:53.799614Z","time spent":"2.466152134s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-08-13T08:05:56.265814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.319208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:05:56.265834Z","caller":"traceutil/trace.go:171","msg":"trace[800019079] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1604; }","duration":"989.36499ms","start":"2026-08-13T08:05:55.276462Z","end":"2026-08-13T08:05:56.265827Z","steps":["trace[800019079] 'agreement among raft nodes before linearized reading' (duration: 989.332879ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:56.265851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:55.276448Z","time spent":"989.3987ms","remote":"127.0.0.1:60724","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-13T08:05:56.265898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.466408033s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T08:05:56.265919Z","caller":"traceutil/trace.go:171","msg":"trace[1594397393] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1604; }","duration":"2.466440633s","start":"2026-08-13T08:05:53.799472Z","end":"2026-08-13T08:05:56.265912Z","steps":["trace[1594397393] 'agreement among raft nodes before linearized reading' (duration: 2.466397682s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:56.265935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.435707342s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T08:05:56.265939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:53.799468Z","time spent":"2.466465134s","remote":"127.0.0.1:60972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"info","ts":"2026-08-13T08:05:56.265954Z","caller":"traceutil/trace.go:171","msg":"trace[1358942590] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1604; }","duration":"1.435737294s","start":"2026-08-13T08:05:54.830211Z","end":"2026-08-13T08:05:56.265948Z","steps":["trace[1358942590] 'agreement among raft nodes before linearized reading' (duration: 1.435708273s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:56.265971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:54.830205Z","time spent":"1.435762494s","remote":"127.0.0.1:60736","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-13T08:05:56.266057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.46665024s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.141\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-13T08:05:56.266078Z","caller":"traceutil/trace.go:171","msg":"trace[1799523] range","detail":"{range_begin:/registry/masterleases/199.19.213.141; range_end:; response_count:1; response_revision:1604; }","duration":"2.466699202s","start":"2026-08-13T08:05:53.799373Z","end":"2026-08-13T08:05:56.266072Z","steps":["trace[1799523] 'agreement among raft nodes before linearized reading' (duration: 2.46664352s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:56.266085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.436110855s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:525"} {"level":"warn","ts":"2026-08-13T08:05:56.266094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:53.799358Z","time spent":"2.466731392s","remote":"127.0.0.1:60754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.141\" "} {"level":"info","ts":"2026-08-13T08:05:56.26611Z","caller":"traceutil/trace.go:171","msg":"trace[2070851879] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1604; }","duration":"1.436180388s","start":"2026-08-13T08:05:54.829921Z","end":"2026-08-13T08:05:56.266101Z","steps":["trace[2070851879] 'agreement among raft nodes before linearized reading' (duration: 1.436117015s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:56.266128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:54.829899Z","time spent":"1.436224569s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-08-13T08:05:56.266216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.44561103s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-13T08:05:56.266228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.513316185s","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-13T08:05:56.266234Z","caller":"traceutil/trace.go:171","msg":"trace[1568868059] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1604; }","duration":"1.445672813s","start":"2026-08-13T08:05:54.820556Z","end":"2026-08-13T08:05:56.266229Z","steps":["trace[1568868059] 'agreement among raft nodes before linearized reading' (duration: 1.445638792s)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:05:56.266248Z","caller":"traceutil/trace.go:171","msg":"trace[1574612634] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1604; }","duration":"3.513336566s","start":"2026-08-13T08:05:52.752905Z","end":"2026-08-13T08:05:56.266242Z","steps":["trace[1574612634] 'agreement among raft nodes before linearized reading' (duration: 3.513275994s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:56.266256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:54.820528Z","time spent":"1.445719593s","remote":"127.0.0.1:60970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-08-13T08:05:56.266264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:52.752861Z","time spent":"3.513398849s","remote":"127.0.0.1:60980","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-08-13T08:05:56.266423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.723103201s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:05:56.266447Z","caller":"traceutil/trace.go:171","msg":"trace[12338326] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1604; }","duration":"3.723154122s","start":"2026-08-13T08:05:52.543285Z","end":"2026-08-13T08:05:56.26644Z","steps":["trace[12338326] 'agreement among raft nodes before linearized reading' (duration: 3.723112981s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:56.266649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.828667269s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-13T08:05:56.266671Z","caller":"traceutil/trace.go:171","msg":"trace[580185217] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1604; }","duration":"3.828701181s","start":"2026-08-13T08:05:52.437964Z","end":"2026-08-13T08:05:56.266665Z","steps":["trace[580185217] 'agreement among raft nodes before linearized reading' (duration: 3.828634678s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:05:56.266689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:52.437958Z","time spent":"3.828726861s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-13T08:05:56.267694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:05:52.54327Z","time spent":"3.723189574s","remote":"127.0.0.1:35528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-08-13T08:06:01.607835Z","caller":"traceutil/trace.go:171","msg":"trace[42212131] linearizableReadLoop","detail":"{readStateIndex:1700; appliedIndex:1699; }","duration":"277.058616ms","start":"2026-08-13T08:06:01.330756Z","end":"2026-08-13T08:06:01.607814Z","steps":["trace[42212131] 'read index received' (duration: 276.746216ms)","trace[42212131] 'applied index is now lower than readState.Index' (duration: 311.39µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:06:01.608033Z","caller":"traceutil/trace.go:171","msg":"trace[298539821] transaction","detail":"{read_only:false; response_revision:1633; number_of_response:1; }","duration":"293.286137ms","start":"2026-08-13T08:06:01.314739Z","end":"2026-08-13T08:06:01.608025Z","steps":["trace[298539821] 'process raft request' (duration: 292.77657ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:01.608212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.441798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-08-13T08:06:01.608234Z","caller":"traceutil/trace.go:171","msg":"trace[1507421680] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1633; }","duration":"277.50428ms","start":"2026-08-13T08:06:01.330724Z","end":"2026-08-13T08:06:01.608229Z","steps":["trace[1507421680] 'agreement among raft nodes before linearized reading' (duration: 277.412737ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:01.60833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.527745ms","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-08-13T08:06:01.60835Z","caller":"traceutil/trace.go:171","msg":"trace[915745213] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1633; }","duration":"265.575097ms","start":"2026-08-13T08:06:01.342768Z","end":"2026-08-13T08:06:01.608343Z","steps":["trace[915745213] 'agreement among raft nodes before linearized reading' (duration: 265.530705ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:02.399099Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643260257,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:06:03.545103Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643260257,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:06:04.281513Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643260257,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:06:04.992396Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643260257,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:06:05.001244Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.389170652s","expected-duration":"1s"} {"level":"info","ts":"2026-08-13T08:06:05.075837Z","caller":"traceutil/trace.go:171","msg":"trace[324162473] transaction","detail":"{read_only:false; response_revision:1635; number_of_response:1; }","duration":"3.378012213s","start":"2026-08-13T08:06:01.697808Z","end":"2026-08-13T08:06:05.07582Z","steps":["trace[324162473] 'process raft request' (duration: 3.377953701s)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:06:05.075901Z","caller":"traceutil/trace.go:171","msg":"trace[1049094131] linearizableReadLoop","detail":"{readStateIndex:1703; appliedIndex:1700; }","duration":"3.177527234s","start":"2026-08-13T08:06:01.898364Z","end":"2026-08-13T08:06:05.075891Z","steps":["trace[1049094131] 'read index received' (duration: 3.103195068s)","trace[1049094131] 'applied index is now lower than readState.Index' (duration: 74.331556ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:06:05.07596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:01.697791Z","time spent":"3.378109207s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:06:05.076011Z","caller":"traceutil/trace.go:171","msg":"trace[2092716905] transaction","detail":"{read_only:false; response_revision:1636; number_of_response:1; }","duration":"2.780949864s","start":"2026-08-13T08:06:02.295054Z","end":"2026-08-13T08:06:05.076004Z","steps":["trace[2092716905] 'process raft request' (duration: 2.780743537s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:05.076081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:02.295012Z","time spent":"2.781023296s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:06:05.076098Z","caller":"traceutil/trace.go:171","msg":"trace[1269497550] transaction","detail":"{read_only:false; response_revision:1634; number_of_response:1; }","duration":"3.464086937s","start":"2026-08-13T08:06:01.612002Z","end":"2026-08-13T08:06:05.076089Z","steps":["trace[1269497550] 'process raft request' (duration: 3.393507561s)","trace[1269497550] 'compare' (duration: 69.954836ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:06:05.076134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:01.611989Z","time spent":"3.464125288s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T08:06:05.076222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.417042891s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T08:06:05.076255Z","caller":"traceutil/trace.go:171","msg":"trace[694641137] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1636; }","duration":"2.417108943s","start":"2026-08-13T08:06:02.659137Z","end":"2026-08-13T08:06:05.076246Z","steps":["trace[694641137] 'agreement among raft nodes before linearized reading' (duration: 2.417056241s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:05.076295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:02.659119Z","time spent":"2.417168995s","remote":"127.0.0.1:32918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-08-13T08:06:05.076327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.77491665s","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-08-13T08:06:05.076435Z","caller":"traceutil/trace.go:171","msg":"trace[2119303954] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1636; }","duration":"2.775088425s","start":"2026-08-13T08:06:02.301335Z","end":"2026-08-13T08:06:05.076423Z","steps":["trace[2119303954] 'agreement among raft nodes before linearized reading' (duration: 2.774830237s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:05.076471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:02.301317Z","time spent":"2.775147158s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-13T08:06:05.076482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.178115133s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-08-13T08:06:05.076505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.14914726s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.141\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-13T08:06:05.076515Z","caller":"traceutil/trace.go:171","msg":"trace[1639913432] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1636; }","duration":"3.178169405s","start":"2026-08-13T08:06:01.898338Z","end":"2026-08-13T08:06:05.076507Z","steps":["trace[1639913432] 'agreement among raft nodes before linearized reading' (duration: 3.178081192s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:05.076536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:01.898324Z","time spent":"3.178205916s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-08-13T08:06:05.076654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.642473798s","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":"info","ts":"2026-08-13T08:06:05.07668Z","caller":"traceutil/trace.go:171","msg":"trace[237850318] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1636; }","duration":"2.642532179s","start":"2026-08-13T08:06:02.434139Z","end":"2026-08-13T08:06:05.076671Z","steps":["trace[237850318] 'agreement among raft nodes before linearized reading' (duration: 2.642445417s)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:06:05.07654Z","caller":"traceutil/trace.go:171","msg":"trace[988753974] range","detail":"{range_begin:/registry/masterleases/199.19.213.141; range_end:; response_count:1; response_revision:1636; }","duration":"1.149199361s","start":"2026-08-13T08:06:03.927325Z","end":"2026-08-13T08:06:05.076524Z","steps":["trace[988753974] 'agreement among raft nodes before linearized reading' (duration: 1.149138809s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:05.076729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:03.92731Z","time spent":"1.149411758s","remote":"127.0.0.1:60754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.141\" "} {"level":"warn","ts":"2026-08-13T08:06:05.076753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.748082549s","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-13T08:06:05.076775Z","caller":"traceutil/trace.go:171","msg":"trace[119646749] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1636; }","duration":"2.748119961s","start":"2026-08-13T08:06:02.32865Z","end":"2026-08-13T08:06:05.07677Z","steps":["trace[119646749] 'agreement among raft nodes before linearized reading' (duration: 2.748062549s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:05.076797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:02.328641Z","time spent":"2.748152471s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-13T08:06:05.076702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:02.434116Z","time spent":"2.642580691s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-08-13T08:06:05.076975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.748356738s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-13T08:06:05.076996Z","caller":"traceutil/trace.go:171","msg":"trace[1786671133] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1636; }","duration":"2.748436391s","start":"2026-08-13T08:06:02.328555Z","end":"2026-08-13T08:06:05.076991Z","steps":["trace[1786671133] 'agreement among raft nodes before linearized reading' (duration: 2.748360488s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:05.077012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:02.328536Z","time spent":"2.748471741s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-13T08:06:05.077226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.728462399s","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-13T08:06:05.077248Z","caller":"traceutil/trace.go:171","msg":"trace[1792829859] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1636; }","duration":"2.72850024s","start":"2026-08-13T08:06:02.348742Z","end":"2026-08-13T08:06:05.077242Z","steps":["trace[1792829859] 'agreement among raft nodes before linearized reading' (duration: 2.728439578s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:05.077265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:02.348735Z","time spent":"2.728526331s","remote":"127.0.0.1:60980","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-08-13T08:06:05.076728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.733242572s","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-13T08:06:05.079516Z","caller":"traceutil/trace.go:171","msg":"trace[1213040013] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1636; }","duration":"2.736044522s","start":"2026-08-13T08:06:02.343462Z","end":"2026-08-13T08:06:05.079506Z","steps":["trace[1213040013] 'agreement among raft nodes before linearized reading' (duration: 2.733220842s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:05.079561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:02.343453Z","time spent":"2.736098904s","remote":"127.0.0.1:60980","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-13T08:06:17.681815Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643260399,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:06:19.608846Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643260399,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:06:20.109083Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643260399,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:06:20.358936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.298288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-13T08:06:20.358996Z","caller":"traceutil/trace.go:171","msg":"trace[1027214605] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"749.390321ms","start":"2026-08-13T08:06:19.609591Z","end":"2026-08-13T08:06:20.358981Z","steps":["trace[1027214605] 'agreement among raft nodes before linearized reading' (duration: 749.310068ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:20.35903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:19.609585Z","time spent":"749.439132ms","remote":"127.0.0.1:60724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/13 08:06:20 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-13T08:06:20.611681Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132552119643260399,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T08:06:21.006187Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.829862852s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-13T08:06:21.013294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.753873717s","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-13T08:06:21.013464Z","caller":"traceutil/trace.go:171","msg":"trace[881244039] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1692; }","duration":"2.754066333s","start":"2026-08-13T08:06:18.259371Z","end":"2026-08-13T08:06:21.013438Z","steps":["trace[881244039] 'range keys from in-memory index tree' (duration: 2.753848336s)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:06:21.024278Z","caller":"traceutil/trace.go:171","msg":"trace[489523408] transaction","detail":"{read_only:false; response_revision:1694; number_of_response:1; }","duration":"3.84413223s","start":"2026-08-13T08:06:17.180122Z","end":"2026-08-13T08:06:21.024254Z","steps":["trace[489523408] 'process raft request' (duration: 3.843734417s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:21.024398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:17.180114Z","time spent":"3.844219392s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:06:21.024536Z","caller":"traceutil/trace.go:171","msg":"trace[1494351988] transaction","detail":"{read_only:false; response_revision:1693; number_of_response:1; }","duration":"3.848295124s","start":"2026-08-13T08:06:17.176235Z","end":"2026-08-13T08:06:21.02453Z","steps":["trace[1494351988] 'process raft request' (duration: 3.830101649s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:21.024566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:17.176224Z","time spent":"3.848325725s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:06:21.024749Z","caller":"traceutil/trace.go:171","msg":"trace[469742790] transaction","detail":"{read_only:false; response_revision:1696; number_of_response:1; }","duration":"1.415412155s","start":"2026-08-13T08:06:19.60933Z","end":"2026-08-13T08:06:21.024742Z","steps":["trace[469742790] 'process raft request' (duration: 1.41463052s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:21.024799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:19.609305Z","time spent":"1.415472368s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:06:21.024877Z","caller":"traceutil/trace.go:171","msg":"trace[285901119] transaction","detail":"{read_only:false; response_revision:1695; number_of_response:1; }","duration":"3.844491002s","start":"2026-08-13T08:06:17.180379Z","end":"2026-08-13T08:06:21.02487Z","steps":["trace[285901119] 'process raft request' (duration: 3.843556122s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:21.024911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:17.18037Z","time spent":"3.844520782s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:06:21.025062Z","caller":"traceutil/trace.go:171","msg":"trace[1593083918] transaction","detail":"{read_only:false; response_revision:1697; number_of_response:1; }","duration":"1.36882962s","start":"2026-08-13T08:06:19.656205Z","end":"2026-08-13T08:06:21.025034Z","steps":["trace[1593083918] 'process raft request' (duration: 1.367782086s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:21.025194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:19.656185Z","time spent":"1.368937724s","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T08:06:21.034807Z","caller":"traceutil/trace.go:171","msg":"trace[906093098] linearizableReadLoop","detail":"{readStateIndex:1768; appliedIndex:1762; }","duration":"3.853359277s","start":"2026-08-13T08:06:17.181419Z","end":"2026-08-13T08:06:21.034778Z","steps":["trace[906093098] 'read index received' (duration: 3.824909113s)","trace[906093098] 'applied index is now lower than readState.Index' (duration: 28.449354ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:06:21.035126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.853670977s","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-13T08:06:21.035156Z","caller":"traceutil/trace.go:171","msg":"trace[506484464] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1698; }","duration":"3.853740008s","start":"2026-08-13T08:06:17.181403Z","end":"2026-08-13T08:06:21.035143Z","steps":["trace[506484464] 'agreement among raft nodes before linearized reading' (duration: 3.853573863s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:21.035188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:17.181397Z","time spent":"3.85378476s","remote":"127.0.0.1:60980","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-13T08:06:21.035214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.851673763s","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:531"} {"level":"info","ts":"2026-08-13T08:06:21.035285Z","caller":"traceutil/trace.go:171","msg":"trace[1149624575] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1698; }","duration":"3.851796086s","start":"2026-08-13T08:06:17.183472Z","end":"2026-08-13T08:06:21.035268Z","steps":["trace[1149624575] 'agreement among raft nodes before linearized reading' (duration: 3.85159813s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:21.035321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:17.183452Z","time spent":"3.851859408s","remote":"127.0.0.1:60980","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-08-13T08:06:21.035444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.099007506s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:06:21.035461Z","caller":"traceutil/trace.go:171","msg":"trace[514379051] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1698; }","duration":"1.099053687s","start":"2026-08-13T08:06:19.936402Z","end":"2026-08-13T08:06:21.035455Z","steps":["trace[514379051] 'agreement among raft nodes before linearized reading' (duration: 1.099024897s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:21.035477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:19.936382Z","time spent":"1.099091839s","remote":"127.0.0.1:60724","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-13T08:06:21.035536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.37501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-08-13T08:06:21.035603Z","caller":"traceutil/trace.go:171","msg":"trace[907702870] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1698; }","duration":"896.883107ms","start":"2026-08-13T08:06:20.138705Z","end":"2026-08-13T08:06:21.035588Z","steps":["trace[907702870] 'agreement among raft nodes before linearized reading' (duration: 896.703831ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:21.035631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:20.138686Z","time spent":"896.939368ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-08-13T08:06:21.035726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.434409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:06:21.035745Z","caller":"traceutil/trace.go:171","msg":"trace[1551721190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1698; }","duration":"676.475331ms","start":"2026-08-13T08:06:20.359262Z","end":"2026-08-13T08:06:21.035737Z","steps":["trace[1551721190] 'agreement among raft nodes before linearized reading' (duration: 676.44318ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:21.035761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:20.359249Z","time spent":"676.508511ms","remote":"127.0.0.1:60736","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-13T08:06:21.035864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.923164471s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T08:06:21.03589Z","caller":"traceutil/trace.go:171","msg":"trace[1239634413] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1698; }","duration":"2.923244273s","start":"2026-08-13T08:06:18.112639Z","end":"2026-08-13T08:06:21.035883Z","steps":["trace[1239634413] 'agreement among raft nodes before linearized reading' (duration: 2.923177501s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:21.035906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:18.112612Z","time spent":"2.923290525s","remote":"127.0.0.1:32826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":17,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-08-13T08:06:21.041873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.432329908s","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-08-13T08:06:21.041933Z","caller":"traceutil/trace.go:171","msg":"trace[101208460] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1698; }","duration":"1.432437882s","start":"2026-08-13T08:06:19.60948Z","end":"2026-08-13T08:06:21.041918Z","steps":["trace[101208460] 'agreement among raft nodes before linearized reading' (duration: 1.432300267s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:21.041968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:19.609471Z","time spent":"1.432489873s","remote":"127.0.0.1:60814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-08-13T08:06:21.042509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.820634765s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-13T08:06:21.042537Z","caller":"traceutil/trace.go:171","msg":"trace[1508391783] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1698; }","duration":"3.820702197s","start":"2026-08-13T08:06:17.221828Z","end":"2026-08-13T08:06:21.04253Z","steps":["trace[1508391783] 'agreement among raft nodes before linearized reading' (duration: 3.820584014s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:21.042557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:17.221807Z","time spent":"3.820745489s","remote":"127.0.0.1:60980","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-08-13T08:06:56.857765Z","caller":"traceutil/trace.go:171","msg":"trace[672405046] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"126.203647ms","start":"2026-08-13T08:06:56.731541Z","end":"2026-08-13T08:06:56.857745Z","steps":["trace[672405046] 'process raft request' (duration: 126.074843ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:57.463997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.18966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T08:06:57.464122Z","caller":"traceutil/trace.go:171","msg":"trace[1515991996] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1863; }","duration":"526.336125ms","start":"2026-08-13T08:06:56.937762Z","end":"2026-08-13T08:06:57.464098Z","steps":["trace[1515991996] 'range keys from in-memory index tree' (duration: 526.122899ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:57.464164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:06:56.937685Z","time spent":"526.46885ms","remote":"127.0.0.1:60736","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-13T08:06:57.464623Z","caller":"traceutil/trace.go:171","msg":"trace[1043176144] linearizableReadLoop","detail":"{readStateIndex:1942; appliedIndex:1941; }","duration":"238.846378ms","start":"2026-08-13T08:06:57.22576Z","end":"2026-08-13T08:06:57.464606Z","steps":["trace[1043176144] 'read index received' (duration: 224.128064ms)","trace[1043176144] 'applied index is now lower than readState.Index' (duration: 14.717204ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:06:57.464889Z","caller":"traceutil/trace.go:171","msg":"trace[781439377] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"281.829124ms","start":"2026-08-13T08:06:57.183045Z","end":"2026-08-13T08:06:57.464874Z","steps":["trace[781439377] 'process raft request' (duration: 266.946534ms)","trace[781439377] 'compare' (duration: 13.63899ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T08:06:57.465288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.028378ms","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-13T08:06:57.465327Z","caller":"traceutil/trace.go:171","msg":"trace[1215522792] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1864; }","duration":"227.1043ms","start":"2026-08-13T08:06:57.238214Z","end":"2026-08-13T08:06:57.465318Z","steps":["trace[1215522792] 'agreement among raft nodes before linearized reading' (duration: 226.936755ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:57.465324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.71737ms","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-13T08:06:57.465355Z","caller":"traceutil/trace.go:171","msg":"trace[1167480869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1864; }","duration":"218.760761ms","start":"2026-08-13T08:06:57.246584Z","end":"2026-08-13T08:06:57.465345Z","steps":["trace[1167480869] 'agreement among raft nodes before linearized reading' (duration: 218.662278ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:57.465433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.597822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-13T08:06:57.465471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.708446ms","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-13T08:06:57.465504Z","caller":"traceutil/trace.go:171","msg":"trace[925046483] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1864; }","duration":"239.764478ms","start":"2026-08-13T08:06:57.225731Z","end":"2026-08-13T08:06:57.465495Z","steps":["trace[925046483] 'agreement among raft nodes before linearized reading' (duration: 239.689666ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T08:06:57.465515Z","caller":"traceutil/trace.go:171","msg":"trace[409392800] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1864; }","duration":"180.730596ms","start":"2026-08-13T08:06:57.284763Z","end":"2026-08-13T08:06:57.465494Z","steps":["trace[409392800] 'agreement among raft nodes before linearized reading' (duration: 180.459527ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:57.465551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.177615ms","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:531"} {"level":"info","ts":"2026-08-13T08:06:57.465609Z","caller":"traceutil/trace.go:171","msg":"trace[1125451299] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1864; }","duration":"219.282788ms","start":"2026-08-13T08:06:57.246311Z","end":"2026-08-13T08:06:57.465594Z","steps":["trace[1125451299] 'agreement among raft nodes before linearized reading' (duration: 219.0455ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:06:57.46562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.82032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-13T08:06:57.46573Z","caller":"traceutil/trace.go:171","msg":"trace[1995881713] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1864; }","duration":"239.972445ms","start":"2026-08-13T08:06:57.225731Z","end":"2026-08-13T08:06:57.465703Z","steps":["trace[1995881713] 'agreement among raft nodes before linearized reading' (duration: 239.682935ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:07:11.972918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.920868ms","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-08-13T08:07:11.973087Z","caller":"traceutil/trace.go:171","msg":"trace[607104519] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1930; }","duration":"417.127025ms","start":"2026-08-13T08:07:11.555934Z","end":"2026-08-13T08:07:11.973061Z","steps":["trace[607104519] 'range keys from in-memory index tree' (duration: 416.726022ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:07:11.973319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.532899ms","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":"info","ts":"2026-08-13T08:07:11.973369Z","caller":"traceutil/trace.go:171","msg":"trace[829150718] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1930; }","duration":"404.603221ms","start":"2026-08-13T08:07:11.568752Z","end":"2026-08-13T08:07:11.973355Z","steps":["trace[829150718] 'range keys from in-memory index tree' (duration: 404.449216ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:07:11.9734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:07:11.568739Z","time spent":"404.651052ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-08-13T08:07:11.973149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:07:11.555917Z","time spent":"417.215957ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-13T08:07:11.973545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.05293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-13T08:07:11.973578Z","caller":"traceutil/trace.go:171","msg":"trace[245906801] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1930; }","duration":"416.113382ms","start":"2026-08-13T08:07:11.557457Z","end":"2026-08-13T08:07:11.97357Z","steps":["trace[245906801] 'range keys from in-memory index tree' (duration: 415.969247ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:07:11.9736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:07:11.557442Z","time spent":"416.150953ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-13T08:07:11.973684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.768097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-13T08:07:11.973708Z","caller":"traceutil/trace.go:171","msg":"trace[209618230] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1930; }","duration":"413.819318ms","start":"2026-08-13T08:07:11.559881Z","end":"2026-08-13T08:07:11.973701Z","steps":["trace[209618230] 'range keys from in-memory index tree' (duration: 413.689744ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:07:11.973733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:07:11.559864Z","time spent":"413.861529ms","remote":"127.0.0.1:60980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-13T08:07:21.877571Z","caller":"traceutil/trace.go:171","msg":"trace[8026144] linearizableReadLoop","detail":"{readStateIndex:2058; appliedIndex:2057; }","duration":"207.665673ms","start":"2026-08-13T08:07:21.669879Z","end":"2026-08-13T08:07:21.877545Z","steps":["trace[8026144] 'read index received' (duration: 206.375621ms)","trace[8026144] 'applied index is now lower than readState.Index' (duration: 1.288172ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T08:07:21.877638Z","caller":"traceutil/trace.go:171","msg":"trace[731757330] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"207.86489ms","start":"2026-08-13T08:07:21.669746Z","end":"2026-08-13T08:07:21.877611Z","steps":["trace[731757330] 'process raft request' (duration: 206.572268ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:07:21.877878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.021585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-13T08:07:21.877929Z","caller":"traceutil/trace.go:171","msg":"trace[1272642928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1975; }","duration":"208.152389ms","start":"2026-08-13T08:07:21.669755Z","end":"2026-08-13T08:07:21.877907Z","steps":["trace[1272642928] 'agreement among raft nodes before linearized reading' (duration: 207.8827ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:07:26.759066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.438885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:6772"} {"level":"info","ts":"2026-08-13T08:07:26.759183Z","caller":"traceutil/trace.go:171","msg":"trace[1514023939] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:2001; }","duration":"399.647892ms","start":"2026-08-13T08:07:26.35951Z","end":"2026-08-13T08:07:26.759158Z","steps":["trace[1514023939] 'range keys from in-memory index tree' (duration: 399.124714ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T08:07:26.759234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T08:07:26.359483Z","time spent":"399.737595ms","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":6795,"request content":"key:\"/registry/minions/instance\" "}