{"level":"warn","ts":"2026-09-04T15:57:52.983795Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-04T15:57:52.983945Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.121:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.121:2380","--initial-cluster=instance=https://162.253.55.121:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.121:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.121: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-09-04T15:57:52.98405Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-04T15:57:52.984066Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.121:2380"]} {"level":"info","ts":"2026-09-04T15:57:52.984107Z","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-09-04T15:57:52.985056Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.121:2379"]} {"level":"info","ts":"2026-09-04T15:57:52.98525Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.121:2380"],"listen-peer-urls":["https://162.253.55.121:2380"],"advertise-client-urls":["https://162.253.55.121:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.121:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.121: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-09-04T15:57:52.989328Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.817593ms"} {"level":"info","ts":"2026-09-04T15:57:52.994654Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e064f6438c9a029d","cluster-id":"46d59d02273d6950"} {"level":"info","ts":"2026-09-04T15:57:52.995572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d switched to configuration voters=()"} {"level":"info","ts":"2026-09-04T15:57:52.995599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d became follower at term 0"} {"level":"info","ts":"2026-09-04T15:57:52.995623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e064f6438c9a029d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-04T15:57:52.995638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d became follower at term 1"} {"level":"info","ts":"2026-09-04T15:57:52.995678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d switched to configuration voters=(16169319332149068445)"} {"level":"warn","ts":"2026-09-04T15:57:53.002394Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-04T15:57:53.003905Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-04T15:57:53.006386Z","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-09-04T15:57:53.008254Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e064f6438c9a029d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-04T15:57:53.008539Z","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-09-04T15:57:53.008585Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e064f6438c9a029d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-04T15:57:53.00862Z","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-09-04T15:57:53.008629Z","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-09-04T15:57:53.009481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d switched to configuration voters=(16169319332149068445)"} {"level":"info","ts":"2026-09-04T15:57:53.010005Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"46d59d02273d6950","local-member-id":"e064f6438c9a029d","added-peer-id":"e064f6438c9a029d","added-peer-peer-urls":["https://162.253.55.121:2380"]} {"level":"info","ts":"2026-09-04T15:57:53.011675Z","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-09-04T15:57:53.011766Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.121:2380"} {"level":"info","ts":"2026-09-04T15:57:53.011816Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.121:2380"} {"level":"info","ts":"2026-09-04T15:57:53.011899Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e064f6438c9a029d","initial-advertise-peer-urls":["https://162.253.55.121:2380"],"listen-peer-urls":["https://162.253.55.121:2380"],"advertise-client-urls":["https://162.253.55.121:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.121:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-04T15:57:53.01195Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-04T15:57:53.596522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d is starting a new election at term 1"} {"level":"info","ts":"2026-09-04T15:57:53.596611Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d became pre-candidate at term 1"} {"level":"info","ts":"2026-09-04T15:57:53.596659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d received MsgPreVoteResp from e064f6438c9a029d at term 1"} {"level":"info","ts":"2026-09-04T15:57:53.59668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d became candidate at term 2"} {"level":"info","ts":"2026-09-04T15:57:53.59669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d received MsgVoteResp from e064f6438c9a029d at term 2"} {"level":"info","ts":"2026-09-04T15:57:53.596715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e064f6438c9a029d became leader at term 2"} {"level":"info","ts":"2026-09-04T15:57:53.596729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e064f6438c9a029d elected leader e064f6438c9a029d at term 2"} {"level":"info","ts":"2026-09-04T15:57:53.59785Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e064f6438c9a029d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.121:2379]}","request-path":"/0/members/e064f6438c9a029d/attributes","cluster-id":"46d59d02273d6950","publish-timeout":"7s"} {"level":"info","ts":"2026-09-04T15:57:53.603602Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-04T15:57:53.603672Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-04T15:57:53.60391Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-04T15:57:53.604908Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"46d59d02273d6950","local-member-id":"e064f6438c9a029d","cluster-version":"3.5"} {"level":"info","ts":"2026-09-04T15:57:53.605021Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-04T15:57:53.605075Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-04T15:57:53.605624Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-04T15:57:53.605686Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-04T15:57:53.606207Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.121:2379"} {"level":"info","ts":"2026-09-04T15:57:53.627009Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-04T15:57:59.866694Z","caller":"traceutil/trace.go:171","msg":"trace[449562212] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"114.605957ms","start":"2026-09-04T15:57:59.752063Z","end":"2026-09-04T15:57:59.866668Z","steps":["trace[449562212] 'process raft request' (duration: 114.472235ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T15:58:00.182748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.435684ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-09-04T15:58:00.182963Z","caller":"traceutil/trace.go:171","msg":"trace[1286017015] linearizableReadLoop","detail":"{readStateIndex:325; appliedIndex:324; }","duration":"365.120113ms","start":"2026-09-04T15:57:59.81783Z","end":"2026-09-04T15:58:00.18295Z","steps":["trace[1286017015] 'read index received' (duration: 48.823767ms)","trace[1286017015] 'applied index is now lower than readState.Index' (duration: 316.295396ms)"],"step_count":2} {"level":"info","ts":"2026-09-04T15:58:00.183021Z","caller":"traceutil/trace.go:171","msg":"trace[2101107527] transaction","detail":"{read_only:false; number_of_response:0; response_revision:316; }","duration":"365.084703ms","start":"2026-09-04T15:57:59.817924Z","end":"2026-09-04T15:58:00.183009Z","steps":["trace[2101107527] 'process raft request' (duration: 364.935161ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:00.183046Z","caller":"traceutil/trace.go:171","msg":"trace[535880152] transaction","detail":"{read_only:false; number_of_response:0; response_revision:316; }","duration":"364.963261ms","start":"2026-09-04T15:57:59.818075Z","end":"2026-09-04T15:58:00.183038Z","steps":["trace[535880152] 'process raft request' (duration: 364.8365ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:00.183043Z","caller":"traceutil/trace.go:171","msg":"trace[570654176] transaction","detail":"{read_only:false; number_of_response:0; response_revision:316; }","duration":"364.974522ms","start":"2026-09-04T15:57:59.818011Z","end":"2026-09-04T15:58:00.182986Z","steps":["trace[570654176] 'process raft request' (duration: 364.87948ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T15:58:00.183115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-04T15:57:59.818069Z","time spent":"364.998512ms","remote":"127.0.0.1:34106","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-04T15:58:00.183185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-04T15:57:59.817915Z","time spent":"365.193504ms","remote":"127.0.0.1:34106","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-04T15:58:00.183246Z","caller":"traceutil/trace.go:171","msg":"trace[1912231573] transaction","detail":"{read_only:false; number_of_response:0; response_revision:316; }","duration":"365.010802ms","start":"2026-09-04T15:57:59.818208Z","end":"2026-09-04T15:58:00.183219Z","steps":["trace[1912231573] 'process raft request' (duration: 364.719198ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T15:58:00.183295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-04T15:57:59.8182Z","time spent":"365.069273ms","remote":"127.0.0.1:34106","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-04T15:58:00.183407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.491258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"warn","ts":"2026-09-04T15:58:00.183466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.105402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-09-04T15:58:00.183468Z","caller":"traceutil/trace.go:171","msg":"trace[1652690900] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:316; }","duration":"365.649301ms","start":"2026-09-04T15:57:59.8178Z","end":"2026-09-04T15:58:00.18345Z","steps":["trace[1652690900] 'agreement among raft nodes before linearized reading' (duration: 365.401988ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:00.183487Z","caller":"traceutil/trace.go:171","msg":"trace[358793923] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:1; response_revision:316; }","duration":"313.163642ms","start":"2026-09-04T15:57:59.870317Z","end":"2026-09-04T15:58:00.183481Z","steps":["trace[358793923] 'agreement among raft nodes before linearized reading' (duration: 313.124692ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T15:58:00.183504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-04T15:57:59.870301Z","time spent":"313.198353ms","remote":"127.0.0.1:34112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" "} {"level":"warn","ts":"2026-09-04T15:58:00.183503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-04T15:57:59.817787Z","time spent":"365.707681ms","remote":"127.0.0.1:34106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":5920,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"info","ts":"2026-09-04T15:58:00.182933Z","caller":"traceutil/trace.go:171","msg":"trace[593483319] transaction","detail":"{read_only:false; number_of_response:0; response_revision:316; }","duration":"369.859639ms","start":"2026-09-04T15:57:59.813049Z","end":"2026-09-04T15:58:00.182909Z","steps":["trace[593483319] 'process raft request' (duration: 181.717945ms)","trace[593483319] 'compare' (duration: 187.378463ms)"],"step_count":2} {"level":"warn","ts":"2026-09-04T15:58:00.183705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-04T15:57:59.813024Z","time spent":"370.613228ms","remote":"127.0.0.1:34106","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-04T15:58:00.183771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-04T15:57:59.817979Z","time spent":"365.165094ms","remote":"127.0.0.1:34106","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-04T15:58:00.453706Z","caller":"traceutil/trace.go:171","msg":"trace[1015445919] linearizableReadLoop","detail":"{readStateIndex:331; appliedIndex:330; }","duration":"172.079545ms","start":"2026-09-04T15:58:00.281603Z","end":"2026-09-04T15:58:00.453682Z","steps":["trace[1015445919] 'read index received' (duration: 171.850452ms)","trace[1015445919] 'applied index is now lower than readState.Index' (duration: 228.273µs)"],"step_count":2} {"level":"info","ts":"2026-09-04T15:58:00.453788Z","caller":"traceutil/trace.go:171","msg":"trace[1677402289] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"241.848885ms","start":"2026-09-04T15:58:00.211911Z","end":"2026-09-04T15:58:00.45376Z","steps":["trace[1677402289] 'process raft request' (duration: 241.640482ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T15:58:00.45389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.268067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-04T15:58:00.45392Z","caller":"traceutil/trace.go:171","msg":"trace[1636726939] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:0; response_revision:318; }","duration":"172.353649ms","start":"2026-09-04T15:58:00.281557Z","end":"2026-09-04T15:58:00.453911Z","steps":["trace[1636726939] 'agreement among raft nodes before linearized reading' (duration: 172.235587ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T15:58:00.454058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.899134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-04T15:58:00.454307Z","caller":"traceutil/trace.go:171","msg":"trace[941863804] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:318; }","duration":"156.111357ms","start":"2026-09-04T15:58:00.298057Z","end":"2026-09-04T15:58:00.454169Z","steps":["trace[941863804] 'agreement among raft nodes before linearized reading' (duration: 155.796703ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:31.655104Z","caller":"traceutil/trace.go:171","msg":"trace[856987173] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"127.863381ms","start":"2026-09-04T15:58:31.527222Z","end":"2026-09-04T15:58:31.655085Z","steps":["trace[856987173] 'process raft request' (duration: 127.740529ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T15:58:32.422584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.72433ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-04T15:58:32.422866Z","caller":"traceutil/trace.go:171","msg":"trace[626228822] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"205.840629ms","start":"2026-09-04T15:58:32.21698Z","end":"2026-09-04T15:58:32.422821Z","steps":["trace[626228822] 'process raft request' (duration: 96.775044ms)","trace[626228822] 'compare' (duration: 108.519958ms)"],"step_count":2} {"level":"info","ts":"2026-09-04T15:58:32.42315Z","caller":"traceutil/trace.go:171","msg":"trace[795863352] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"201.12021ms","start":"2026-09-04T15:58:32.222007Z","end":"2026-09-04T15:58:32.423127Z","steps":["trace[795863352] 'process raft request' (duration: 200.730256ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:32.430977Z","caller":"traceutil/trace.go:171","msg":"trace[1306472431] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"199.798823ms","start":"2026-09-04T15:58:32.231145Z","end":"2026-09-04T15:58:32.430943Z","steps":["trace[1306472431] 'process raft request' (duration: 199.460179ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:32.431243Z","caller":"traceutil/trace.go:171","msg":"trace[1080011957] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"198.362665ms","start":"2026-09-04T15:58:32.232861Z","end":"2026-09-04T15:58:32.431224Z","steps":["trace[1080011957] 'process raft request' (duration: 197.90775ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:32.431233Z","caller":"traceutil/trace.go:171","msg":"trace[1148199823] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"180.10714ms","start":"2026-09-04T15:58:32.251083Z","end":"2026-09-04T15:58:32.431191Z","steps":["trace[1148199823] 'process raft request' (duration: 179.957108ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:32.431244Z","caller":"traceutil/trace.go:171","msg":"trace[950741585] transaction","detail":"{read_only:false; number_of_response:1; response_revision:531; }","duration":"190.021383ms","start":"2026-09-04T15:58:32.241186Z","end":"2026-09-04T15:58:32.431208Z","steps":["trace[950741585] 'process raft request' (duration: 189.7937ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:32.431534Z","caller":"traceutil/trace.go:171","msg":"trace[722335770] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"176.690408ms","start":"2026-09-04T15:58:32.254811Z","end":"2026-09-04T15:58:32.431502Z","steps":["trace[722335770] 'process raft request' (duration: 176.324884ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:32.431525Z","caller":"traceutil/trace.go:171","msg":"trace[1297097160] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"191.002955ms","start":"2026-09-04T15:58:32.240505Z","end":"2026-09-04T15:58:32.431508Z","steps":["trace[1297097160] 'process raft request' (duration: 190.412388ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:32.43182Z","caller":"traceutil/trace.go:171","msg":"trace[1525146988] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"159.852751ms","start":"2026-09-04T15:58:32.271956Z","end":"2026-09-04T15:58:32.431808Z","steps":["trace[1525146988] 'process raft request' (duration: 159.513147ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:32.432191Z","caller":"traceutil/trace.go:171","msg":"trace[600603765] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"156.539801ms","start":"2026-09-04T15:58:32.275636Z","end":"2026-09-04T15:58:32.432175Z","steps":["trace[600603765] 'process raft request' (duration: 156.309308ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:32.432272Z","caller":"traceutil/trace.go:171","msg":"trace[724325517] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"156.398599ms","start":"2026-09-04T15:58:32.275854Z","end":"2026-09-04T15:58:32.432253Z","steps":["trace[724325517] 'process raft request' (duration: 156.232207ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:32.432421Z","caller":"traceutil/trace.go:171","msg":"trace[834819418] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"127.314099ms","start":"2026-09-04T15:58:32.305094Z","end":"2026-09-04T15:58:32.432408Z","steps":["trace[834819418] 'process raft request' (duration: 127.107687ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:32.432445Z","caller":"traceutil/trace.go:171","msg":"trace[1849481910] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"123.102738ms","start":"2026-09-04T15:58:32.309315Z","end":"2026-09-04T15:58:32.432418Z","steps":["trace[1849481910] 'process raft request' (duration: 123.010736ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:39.107008Z","caller":"traceutil/trace.go:171","msg":"trace[780323909] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"306.961598ms","start":"2026-09-04T15:58:38.800034Z","end":"2026-09-04T15:58:39.106995Z","steps":["trace[780323909] 'process raft request' (duration: 306.540613ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T15:58:39.107221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-04T15:58:38.800011Z","time spent":"307.046379ms","remote":"127.0.0.1:34042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-04T15:58:39.107221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.860365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-f8vdd\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-04T15:58:39.107297Z","caller":"traceutil/trace.go:171","msg":"trace[2036447869] range","detail":"{range_begin:/registry/pods/kube-system/cilium-f8vdd; range_end:; response_count:1; response_revision:635; }","duration":"181.022408ms","start":"2026-09-04T15:58:38.926255Z","end":"2026-09-04T15:58:39.107278Z","steps":["trace[2036447869] 'agreement among raft nodes before linearized reading' (duration: 180.832386ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:39.107394Z","caller":"traceutil/trace.go:171","msg":"trace[589336950] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"180.621862ms","start":"2026-09-04T15:58:38.926339Z","end":"2026-09-04T15:58:39.106961Z","steps":["trace[589336950] 'read index received' (duration: 180.016895ms)","trace[589336950] 'applied index is now lower than readState.Index' (duration: 604.497µs)"],"step_count":2} {"level":"info","ts":"2026-09-04T15:58:39.517226Z","caller":"traceutil/trace.go:171","msg":"trace[384174670] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"390.561475ms","start":"2026-09-04T15:58:39.126612Z","end":"2026-09-04T15:58:39.517173Z","steps":["trace[384174670] 'process raft request' (duration: 375.547403ms)","trace[384174670] 'compare' (duration: 14.770019ms)"],"step_count":2} {"level":"warn","ts":"2026-09-04T15:58:39.517381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-04T15:58:39.126585Z","time spent":"390.708306ms","remote":"127.0.0.1:34106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-04T15:58:39.723617Z","caller":"traceutil/trace.go:171","msg":"trace[714035259] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"532.86333ms","start":"2026-09-04T15:58:39.190716Z","end":"2026-09-04T15:58:39.72358Z","steps":["trace[714035259] 'process raft request' (duration: 495.870772ms)","trace[714035259] 'compare' (duration: 36.688635ms)"],"step_count":2} {"level":"info","ts":"2026-09-04T15:58:39.723656Z","caller":"traceutil/trace.go:171","msg":"trace[1380973981] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:659; }","duration":"378.877373ms","start":"2026-09-04T15:58:39.344748Z","end":"2026-09-04T15:58:39.723626Z","steps":["trace[1380973981] 'read index received' (duration: 157.372057ms)","trace[1380973981] 'applied index is now lower than readState.Index' (duration: 221.502756ms)"],"step_count":2} {"level":"warn","ts":"2026-09-04T15:58:39.72375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-04T15:58:39.190694Z","time spent":"532.988391ms","remote":"127.0.0.1:34158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-04T15:58:39.723872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.853794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-04T15:58:39.723938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.182046ms","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-09-04T15:58:39.723956Z","caller":"traceutil/trace.go:171","msg":"trace[966262077] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"280.981566ms","start":"2026-09-04T15:58:39.442951Z","end":"2026-09-04T15:58:39.723933Z","steps":["trace[966262077] 'agreement among raft nodes before linearized reading' (duration: 280.858785ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:39.723989Z","caller":"traceutil/trace.go:171","msg":"trace[163577819] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:638; }","duration":"379.279368ms","start":"2026-09-04T15:58:39.344695Z","end":"2026-09-04T15:58:39.723974Z","steps":["trace[163577819] 'agreement among raft nodes before linearized reading' (duration: 379.050955ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T15:58:39.724132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-04T15:58:39.344675Z","time spent":"379.44032ms","remote":"127.0.0.1:34176","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-09-04T15:58:39.724223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.423674ms","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-09-04T15:58:39.724508Z","caller":"traceutil/trace.go:171","msg":"trace[978343954] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"254.777219ms","start":"2026-09-04T15:58:39.469714Z","end":"2026-09-04T15:58:39.724491Z","steps":["trace[978343954] 'agreement among raft nodes before linearized reading' (duration: 254.193932ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T15:58:53.939201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.551478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-09-04T15:58:53.939266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.227744ms","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-09-04T15:58:53.93928Z","caller":"traceutil/trace.go:171","msg":"trace[1422381318] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:789; }","duration":"136.665329ms","start":"2026-09-04T15:58:53.802597Z","end":"2026-09-04T15:58:53.939263Z","steps":["trace[1422381318] 'range keys from in-memory index tree' (duration: 136.399256ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T15:58:53.939313Z","caller":"traceutil/trace.go:171","msg":"trace[515455032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:789; }","duration":"136.291046ms","start":"2026-09-04T15:58:53.803009Z","end":"2026-09-04T15:58:53.9393Z","steps":["trace[515455032] 'range keys from in-memory index tree' (duration: 136.142724ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T15:58:53.939733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.909693ms","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-09-04T15:58:53.939799Z","caller":"traceutil/trace.go:171","msg":"trace[2138892410] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:789; }","duration":"138.007235ms","start":"2026-09-04T15:58:53.801773Z","end":"2026-09-04T15:58:53.93978Z","steps":["trace[2138892410] 'range keys from in-memory index tree' (duration: 137.755782ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T16:00:13.553036Z","caller":"traceutil/trace.go:171","msg":"trace[1559135596] linearizableReadLoop","detail":"{readStateIndex:1946; appliedIndex:1945; }","duration":"136.562126ms","start":"2026-09-04T16:00:13.41643Z","end":"2026-09-04T16:00:13.552993Z","steps":["trace[1559135596] 'read index received' (duration: 121.413879ms)","trace[1559135596] 'applied index is now lower than readState.Index' (duration: 15.147067ms)"],"step_count":2} {"level":"info","ts":"2026-09-04T16:00:13.553108Z","caller":"traceutil/trace.go:171","msg":"trace[1363017120] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"311.470964ms","start":"2026-09-04T16:00:13.241595Z","end":"2026-09-04T16:00:13.553066Z","steps":["trace[1363017120] 'process raft request' (duration: 296.398439ms)","trace[1363017120] 'compare' (duration: 14.67186ms)"],"step_count":2} {"level":"warn","ts":"2026-09-04T16:00:13.553252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-04T16:00:13.241565Z","time spent":"311.606318ms","remote":"127.0.0.1:34176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-04T16:00:13.553321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.878416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-03e5f270-5ef2-473c-a5d6-635c07352201\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-04T16:00:13.553421Z","caller":"traceutil/trace.go:171","msg":"trace[803068156] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-03e5f270-5ef2-473c-a5d6-635c07352201; range_end:; response_count:1; response_revision:1873; }","duration":"137.00602ms","start":"2026-09-04T16:00:13.416377Z","end":"2026-09-04T16:00:13.553383Z","steps":["trace[803068156] 'agreement among raft nodes before linearized reading' (duration: 136.779483ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T16:00:13.553447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.231171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-04T16:00:13.553523Z","caller":"traceutil/trace.go:171","msg":"trace[1905216783] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1873; }","duration":"110.352596ms","start":"2026-09-04T16:00:13.443156Z","end":"2026-09-04T16:00:13.553508Z","steps":["trace[1905216783] 'agreement among raft nodes before linearized reading' (duration: 110.014834ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T16:00:42.244839Z","caller":"traceutil/trace.go:171","msg":"trace[2138063425] transaction","detail":"{read_only:false; response_revision:2080; number_of_response:1; }","duration":"129.806421ms","start":"2026-09-04T16:00:42.115005Z","end":"2026-09-04T16:00:42.244811Z","steps":["trace[2138063425] 'process raft request' (duration: 129.646825ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T16:00:48.432022Z","caller":"traceutil/trace.go:171","msg":"trace[432584091] linearizableReadLoop","detail":"{readStateIndex:2194; appliedIndex:2193; }","duration":"152.495838ms","start":"2026-09-04T16:00:48.279503Z","end":"2026-09-04T16:00:48.431999Z","steps":["trace[432584091] 'read index received' (duration: 152.300212ms)","trace[432584091] 'applied index is now lower than readState.Index' (duration: 194.856µs)"],"step_count":2} {"level":"warn","ts":"2026-09-04T16:00:48.432208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.682933ms","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-09-04T16:00:48.432235Z","caller":"traceutil/trace.go:171","msg":"trace[929079332] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"167.469291ms","start":"2026-09-04T16:00:48.264743Z","end":"2026-09-04T16:00:48.432213Z","steps":["trace[929079332] 'process raft request' (duration: 167.127351ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T16:00:48.43226Z","caller":"traceutil/trace.go:171","msg":"trace[1790679037] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2113; }","duration":"152.768546ms","start":"2026-09-04T16:00:48.279476Z","end":"2026-09-04T16:00:48.432244Z","steps":["trace[1790679037] 'agreement among raft nodes before linearized reading' (duration: 152.625552ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T16:00:48.885034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.141381ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-04T16:00:48.88515Z","caller":"traceutil/trace.go:171","msg":"trace[618848484] linearizableReadLoop","detail":"{readStateIndex:2197; appliedIndex:2196; }","duration":"223.201029ms","start":"2026-09-04T16:00:48.661932Z","end":"2026-09-04T16:00:48.885133Z","steps":["trace[618848484] 'read index received' (duration: 75.890843ms)","trace[618848484] 'applied index is now lower than readState.Index' (duration: 147.308915ms)"],"step_count":2} {"level":"info","ts":"2026-09-04T16:00:48.88527Z","caller":"traceutil/trace.go:171","msg":"trace[457708374] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"266.871079ms","start":"2026-09-04T16:00:48.618376Z","end":"2026-09-04T16:00:48.885248Z","steps":["trace[457708374] 'process raft request' (duration: 119.42428ms)","trace[457708374] 'compare' (duration: 146.986875ms)"],"step_count":2} {"level":"warn","ts":"2026-09-04T16:00:48.885619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.646322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-09-04T16:00:48.885624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.815252ms","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-09-04T16:00:48.88573Z","caller":"traceutil/trace.go:171","msg":"trace[1002964851] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2116; }","duration":"213.006207ms","start":"2026-09-04T16:00:48.672692Z","end":"2026-09-04T16:00:48.885699Z","steps":["trace[1002964851] 'agreement among raft nodes before linearized reading' (duration: 212.682148ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T16:00:48.885707Z","caller":"traceutil/trace.go:171","msg":"trace[1547379120] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2116; }","duration":"223.826357ms","start":"2026-09-04T16:00:48.661859Z","end":"2026-09-04T16:00:48.885686Z","steps":["trace[1547379120] 'agreement among raft nodes before linearized reading' (duration: 223.536168ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T16:00:49.186623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.931949ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-04T16:00:49.186821Z","caller":"traceutil/trace.go:171","msg":"trace[1106704735] linearizableReadLoop","detail":"{readStateIndex:2199; appliedIndex:2197; }","duration":"258.065056ms","start":"2026-09-04T16:00:48.928734Z","end":"2026-09-04T16:00:49.1868Z","steps":["trace[1106704735] 'read index received' (duration: 17.724375ms)","trace[1106704735] 'applied index is now lower than readState.Index' (duration: 240.338241ms)"],"step_count":2} {"level":"info","ts":"2026-09-04T16:00:49.187275Z","caller":"traceutil/trace.go:171","msg":"trace[546504556] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"296.944045ms","start":"2026-09-04T16:00:48.890292Z","end":"2026-09-04T16:00:49.187236Z","steps":["trace[546504556] 'process raft request' (duration: 156.288584ms)","trace[546504556] 'compare' (duration: 139.605469ms)"],"step_count":2} {"level":"warn","ts":"2026-09-04T16:00:49.187303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.527909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-04T16:00:49.187585Z","caller":"traceutil/trace.go:171","msg":"trace[1305112361] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:2118; }","duration":"258.869869ms","start":"2026-09-04T16:00:48.928689Z","end":"2026-09-04T16:00:49.187559Z","steps":["trace[1305112361] 'agreement among raft nodes before linearized reading' (duration: 258.527999ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T16:00:49.204705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.488033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-09-04T16:00:49.205129Z","caller":"traceutil/trace.go:171","msg":"trace[1781235138] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2119; }","duration":"178.849254ms","start":"2026-09-04T16:00:49.026176Z","end":"2026-09-04T16:00:49.205025Z","steps":["trace[1781235138] 'agreement among raft nodes before linearized reading' (duration: 178.37558ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T16:00:49.204738Z","caller":"traceutil/trace.go:171","msg":"trace[2119612794] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"194.236386ms","start":"2026-09-04T16:00:49.010483Z","end":"2026-09-04T16:00:49.20472Z","steps":["trace[2119612794] 'process raft request' (duration: 193.919657ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T16:06:45.391646Z","caller":"traceutil/trace.go:171","msg":"trace[920022755] transaction","detail":"{read_only:false; response_revision:4663; number_of_response:1; }","duration":"128.584618ms","start":"2026-09-04T16:06:45.263042Z","end":"2026-09-04T16:06:45.391626Z","steps":["trace[920022755] 'process raft request' (duration: 82.263053ms)","trace[920022755] 'compare' (duration: 46.236394ms)"],"step_count":2} {"level":"info","ts":"2026-09-04T16:06:50.617608Z","caller":"traceutil/trace.go:171","msg":"trace[93028117] transaction","detail":"{read_only:false; response_revision:4832; number_of_response:1; }","duration":"137.236145ms","start":"2026-09-04T16:06:50.480353Z","end":"2026-09-04T16:06:50.617589Z","steps":["trace[93028117] 'process raft request' (duration: 107.06474ms)","trace[93028117] 'compare' (duration: 30.075314ms)"],"step_count":2} {"level":"info","ts":"2026-09-04T16:06:50.635402Z","caller":"traceutil/trace.go:171","msg":"trace[2025418827] transaction","detail":"{read_only:false; response_revision:4833; number_of_response:1; }","duration":"123.573884ms","start":"2026-09-04T16:06:50.511806Z","end":"2026-09-04T16:06:50.63538Z","steps":["trace[2025418827] 'process raft request' (duration: 123.443472ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T16:06:50.635393Z","caller":"traceutil/trace.go:171","msg":"trace[450988857] linearizableReadLoop","detail":"{readStateIndex:5013; appliedIndex:5011; }","duration":"151.319363ms","start":"2026-09-04T16:06:50.484039Z","end":"2026-09-04T16:06:50.635359Z","steps":["trace[450988857] 'read index received' (duration: 103.398977ms)","trace[450988857] 'applied index is now lower than readState.Index' (duration: 47.919656ms)"],"step_count":2} {"level":"info","ts":"2026-09-04T16:06:50.635513Z","caller":"traceutil/trace.go:171","msg":"trace[501368243] transaction","detail":"{read_only:false; response_revision:4834; number_of_response:1; }","duration":"118.691335ms","start":"2026-09-04T16:06:50.516785Z","end":"2026-09-04T16:06:50.635477Z","steps":["trace[501368243] 'process raft request' (duration: 118.522483ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T16:06:50.635391Z","caller":"traceutil/trace.go:171","msg":"trace[860367045] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4832; }","duration":"154.347487ms","start":"2026-09-04T16:06:50.480952Z","end":"2026-09-04T16:06:50.6353Z","steps":["trace[860367045] 'process raft request' (duration: 154.199915ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T16:06:50.635691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.634378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-09-04T16:06:50.635719Z","caller":"traceutil/trace.go:171","msg":"trace[3360013] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4834; }","duration":"151.694929ms","start":"2026-09-04T16:06:50.484017Z","end":"2026-09-04T16:06:50.635712Z","steps":["trace[3360013] 'agreement among raft nodes before linearized reading' (duration: 151.595648ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T16:06:50.775867Z","caller":"traceutil/trace.go:171","msg":"trace[1983584315] transaction","detail":"{read_only:false; response_revision:4837; number_of_response:1; }","duration":"123.693204ms","start":"2026-09-04T16:06:50.652149Z","end":"2026-09-04T16:06:50.775843Z","steps":["trace[1983584315] 'process raft request' (duration: 123.591593ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T16:06:50.775889Z","caller":"traceutil/trace.go:171","msg":"trace[1361800623] transaction","detail":"{read_only:false; response_revision:4836; number_of_response:1; }","duration":"133.192029ms","start":"2026-09-04T16:06:50.642665Z","end":"2026-09-04T16:06:50.775857Z","steps":["trace[1361800623] 'process raft request' (duration: 132.880914ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T16:06:50.776252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.18645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-09-04T16:06:50.776313Z","caller":"traceutil/trace.go:171","msg":"trace[1736523268] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4837; }","duration":"136.324143ms","start":"2026-09-04T16:06:50.63997Z","end":"2026-09-04T16:06:50.776294Z","steps":["trace[1736523268] 'agreement among raft nodes before linearized reading' (duration: 136.1035ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T16:06:50.776916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.06505ms","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-09-04T16:06:50.776964Z","caller":"traceutil/trace.go:171","msg":"trace[1421199870] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4837; }","duration":"129.137421ms","start":"2026-09-04T16:06:50.647814Z","end":"2026-09-04T16:06:50.776952Z","steps":["trace[1421199870] 'agreement among raft nodes before linearized reading' (duration: 128.208098ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T16:06:56.860073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.728263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.121\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-04T16:06:56.860236Z","caller":"traceutil/trace.go:171","msg":"trace[973520046] range","detail":"{range_begin:/registry/masterleases/162.253.55.121; range_end:; response_count:1; response_revision:4958; }","duration":"109.960617ms","start":"2026-09-04T16:06:56.750245Z","end":"2026-09-04T16:06:56.860205Z","steps":["trace[973520046] 'range keys from in-memory index tree' (duration: 109.48478ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T16:07:10.006516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.555366ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-04T16:07:10.006624Z","caller":"traceutil/trace.go:171","msg":"trace[109971867] transaction","detail":"{read_only:false; response_revision:5128; number_of_response:1; }","duration":"254.141901ms","start":"2026-09-04T16:07:09.752465Z","end":"2026-09-04T16:07:10.006607Z","steps":["trace[109971867] 'process raft request' (duration: 150.414032ms)","trace[109971867] 'compare' (duration: 103.469094ms)"],"step_count":2} {"level":"info","ts":"2026-09-04T16:07:53.662393Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2891} {"level":"info","ts":"2026-09-04T16:07:53.740721Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2891,"took":"76.524991ms","hash":4201847269,"current-db-size-bytes":53678080,"current-db-size":"54 MB","current-db-size-in-use-bytes":28639232,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-09-04T16:07:53.740798Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4201847269,"revision":2891,"compact-revision":-1} {"level":"info","ts":"2026-09-04T16:11:12.412436Z","caller":"traceutil/trace.go:171","msg":"trace[2013342457] transaction","detail":"{read_only:false; response_revision:6905; number_of_response:1; }","duration":"201.972712ms","start":"2026-09-04T16:11:12.210432Z","end":"2026-09-04T16:11:12.412405Z","steps":["trace[2013342457] 'process raft request' (duration: 136.727667ms)","trace[2013342457] 'compare' (duration: 65.082701ms)"],"step_count":2} {"level":"info","ts":"2026-09-04T16:12:14.087464Z","caller":"traceutil/trace.go:171","msg":"trace[779787322] transaction","detail":"{read_only:false; response_revision:7242; number_of_response:1; }","duration":"108.063583ms","start":"2026-09-04T16:12:13.979376Z","end":"2026-09-04T16:12:14.08744Z","steps":["trace[779787322] 'process raft request' (duration: 59.567868ms)","trace[779787322] 'compare' (duration: 48.388633ms)"],"step_count":2} {"level":"info","ts":"2026-09-04T16:12:16.838706Z","caller":"traceutil/trace.go:171","msg":"trace[1681454845] transaction","detail":"{read_only:false; response_revision:7255; number_of_response:1; }","duration":"156.061447ms","start":"2026-09-04T16:12:16.682617Z","end":"2026-09-04T16:12:16.838678Z","steps":["trace[1681454845] 'process raft request' (duration: 128.406281ms)","trace[1681454845] 'compare' (duration: 27.437001ms)"],"step_count":2} {"level":"info","ts":"2026-09-04T16:12:16.838967Z","caller":"traceutil/trace.go:171","msg":"trace[1540154769] transaction","detail":"{read_only:false; response_revision:7256; number_of_response:1; }","duration":"125.013948ms","start":"2026-09-04T16:12:16.713942Z","end":"2026-09-04T16:12:16.838955Z","steps":["trace[1540154769] 'process raft request' (duration: 124.67393ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T16:12:17.282759Z","caller":"traceutil/trace.go:171","msg":"trace[1945981814] transaction","detail":"{read_only:false; response_revision:7261; number_of_response:1; }","duration":"102.188134ms","start":"2026-09-04T16:12:17.180545Z","end":"2026-09-04T16:12:17.282733Z","steps":["trace[1945981814] 'process raft request' (duration: 95.296794ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T16:12:23.244413Z","caller":"traceutil/trace.go:171","msg":"trace[1732761279] transaction","detail":"{read_only:false; response_revision:7288; number_of_response:1; }","duration":"121.914086ms","start":"2026-09-04T16:12:23.12247Z","end":"2026-09-04T16:12:23.244384Z","steps":["trace[1732761279] 'process raft request' (duration: 121.705822ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T16:12:23.295461Z","caller":"traceutil/trace.go:171","msg":"trace[1737950432] transaction","detail":"{read_only:false; response_revision:7289; number_of_response:1; }","duration":"171.993845ms","start":"2026-09-04T16:12:23.123436Z","end":"2026-09-04T16:12:23.29543Z","steps":["trace[1737950432] 'process raft request' (duration: 171.76267ms)"],"step_count":1} {"level":"warn","ts":"2026-09-04T16:12:23.73772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.782676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-rbd-overview\" ","response":"range_response_count:1 size:26148"} {"level":"info","ts":"2026-09-04T16:12:23.737813Z","caller":"traceutil/trace.go:171","msg":"trace[394379345] range","detail":"{range_begin:/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-rbd-overview; range_end:; response_count:1; response_revision:7291; }","duration":"163.93514ms","start":"2026-09-04T16:12:23.573857Z","end":"2026-09-04T16:12:23.737792Z","steps":["trace[394379345] 'range keys from in-memory index tree' (duration: 163.451738ms)"],"step_count":1} {"level":"info","ts":"2026-09-04T16:12:53.668555Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5512} {"level":"info","ts":"2026-09-04T16:12:53.795661Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5512,"took":"125.354459ms","hash":846663629,"current-db-size-bytes":53678080,"current-db-size":"54 MB","current-db-size-in-use-bytes":18485248,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-09-04T16:12:53.795709Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":846663629,"revision":5512,"compact-revision":2891}