{"level":"warn","ts":"2026-09-10T01:52:33.982407Z","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-10T01:52:33.98263Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.105: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.105:2380","--initial-cluster=instance=https://162.253.55.105:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.105:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.105: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-10T01:52:33.982781Z","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-10T01:52:33.982806Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.105:2380"]} {"level":"info","ts":"2026-09-10T01:52:33.982852Z","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-10T01:52:33.984268Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.105:2379"]} {"level":"info","ts":"2026-09-10T01:52:33.984425Z","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.105:2380"],"listen-peer-urls":["https://162.253.55.105:2380"],"advertise-client-urls":["https://162.253.55.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.105: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-10T01:52:33.989874Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.889312ms"} {"level":"info","ts":"2026-09-10T01:52:34.003095Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"15a19459cc268924","cluster-id":"9aaad1c0fc15509e"} {"level":"info","ts":"2026-09-10T01:52:34.003214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 switched to configuration voters=()"} {"level":"info","ts":"2026-09-10T01:52:34.003237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became follower at term 0"} {"level":"info","ts":"2026-09-10T01:52:34.003247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 15a19459cc268924 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-10T01:52:34.003255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became follower at term 1"} {"level":"info","ts":"2026-09-10T01:52:34.003296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 switched to configuration voters=(1558690059444980004)"} {"level":"warn","ts":"2026-09-10T01:52:34.012909Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-10T01:52:34.014351Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-10T01:52:34.015543Z","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-10T01:52:34.017526Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"15a19459cc268924","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-10T01:52:34.017698Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"15a19459cc268924","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-10T01:52:34.017767Z","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-10T01:52:34.017844Z","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-10T01:52:34.017853Z","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-10T01:52:34.018619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 switched to configuration voters=(1558690059444980004)"} {"level":"info","ts":"2026-09-10T01:52:34.018724Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9aaad1c0fc15509e","local-member-id":"15a19459cc268924","added-peer-id":"15a19459cc268924","added-peer-peer-urls":["https://162.253.55.105:2380"]} {"level":"info","ts":"2026-09-10T01:52:34.022491Z","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-10T01:52:34.022668Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"15a19459cc268924","initial-advertise-peer-urls":["https://162.253.55.105:2380"],"listen-peer-urls":["https://162.253.55.105:2380"],"advertise-client-urls":["https://162.253.55.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-10T01:52:34.022697Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-10T01:52:34.022718Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.105:2380"} {"level":"info","ts":"2026-09-10T01:52:34.02278Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.105:2380"} {"level":"info","ts":"2026-09-10T01:52:34.103559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 is starting a new election at term 1"} {"level":"info","ts":"2026-09-10T01:52:34.103618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-10T01:52:34.103643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 received MsgPreVoteResp from 15a19459cc268924 at term 1"} {"level":"info","ts":"2026-09-10T01:52:34.103686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became candidate at term 2"} {"level":"info","ts":"2026-09-10T01:52:34.103697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 received MsgVoteResp from 15a19459cc268924 at term 2"} {"level":"info","ts":"2026-09-10T01:52:34.103706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"15a19459cc268924 became leader at term 2"} {"level":"info","ts":"2026-09-10T01:52:34.103752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 15a19459cc268924 elected leader 15a19459cc268924 at term 2"} {"level":"info","ts":"2026-09-10T01:52:34.104776Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-10T01:52:34.105665Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"15a19459cc268924","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.105:2379]}","request-path":"/0/members/15a19459cc268924/attributes","cluster-id":"9aaad1c0fc15509e","publish-timeout":"7s"} {"level":"info","ts":"2026-09-10T01:52:34.105934Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-10T01:52:34.1064Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-10T01:52:34.106623Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9aaad1c0fc15509e","local-member-id":"15a19459cc268924","cluster-version":"3.5"} {"level":"info","ts":"2026-09-10T01:52:34.106727Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-10T01:52:34.106807Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-10T01:52:34.107391Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-10T01:52:34.107425Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-10T01:52:34.11084Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-10T01:52:34.114811Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.105:2379"} {"level":"info","ts":"2026-09-10T01:53:21.161692Z","caller":"traceutil/trace.go:171","msg":"trace[727964300] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"202.901867ms","start":"2026-09-10T01:53:20.958749Z","end":"2026-09-10T01:53:21.161651Z","steps":["trace[727964300] 'process raft request' (duration: 202.635294ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:53:21.172931Z","caller":"traceutil/trace.go:171","msg":"trace[1791226107] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"197.20157ms","start":"2026-09-10T01:53:20.975666Z","end":"2026-09-10T01:53:21.172867Z","steps":["trace[1791226107] 'process raft request' (duration: 197.034092ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:53:21.172975Z","caller":"traceutil/trace.go:171","msg":"trace[1764976121] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"187.449175ms","start":"2026-09-10T01:53:20.985493Z","end":"2026-09-10T01:53:21.172942Z","steps":["trace[1764976121] 'process raft request' (duration: 187.239085ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:53:21.173239Z","caller":"traceutil/trace.go:171","msg":"trace[68806248] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"144.752335ms","start":"2026-09-10T01:53:21.028475Z","end":"2026-09-10T01:53:21.173227Z","steps":["trace[68806248] 'process raft request' (duration: 144.43629ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:53:21.173281Z","caller":"traceutil/trace.go:171","msg":"trace[1993845070] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"102.757514ms","start":"2026-09-10T01:53:21.070501Z","end":"2026-09-10T01:53:21.173258Z","steps":["trace[1993845070] 'process raft request' (duration: 102.706172ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:53:21.173337Z","caller":"traceutil/trace.go:171","msg":"trace[1690218537] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"132.486236ms","start":"2026-09-10T01:53:21.040838Z","end":"2026-09-10T01:53:21.173325Z","steps":["trace[1690218537] 'process raft request' (duration: 132.178482ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:53:21.173342Z","caller":"traceutil/trace.go:171","msg":"trace[1744790273] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"155.796145ms","start":"2026-09-10T01:53:21.017503Z","end":"2026-09-10T01:53:21.173299Z","steps":["trace[1744790273] 'process raft request' (duration: 155.305612ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:53:21.173486Z","caller":"traceutil/trace.go:171","msg":"trace[1408591368] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"124.692248ms","start":"2026-09-10T01:53:21.048786Z","end":"2026-09-10T01:53:21.173478Z","steps":["trace[1408591368] 'process raft request' (duration: 124.315121ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:53:21.173546Z","caller":"traceutil/trace.go:171","msg":"trace[138945171] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"144.968704ms","start":"2026-09-10T01:53:21.028573Z","end":"2026-09-10T01:53:21.173541Z","steps":["trace[138945171] 'process raft request' (duration: 144.386127ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:53:21.172824Z","caller":"traceutil/trace.go:171","msg":"trace[234334719] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"203.275399ms","start":"2026-09-10T01:53:20.969497Z","end":"2026-09-10T01:53:21.172772Z","steps":["trace[234334719] 'process raft request' (duration: 203.162934ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:53:21.172753Z","caller":"traceutil/trace.go:171","msg":"trace[549509746] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"211.659219ms","start":"2026-09-10T01:53:20.961072Z","end":"2026-09-10T01:53:21.172731Z","steps":["trace[549509746] 'process raft request' (duration: 209.381482ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:53:22.735663Z","caller":"traceutil/trace.go:171","msg":"trace[159563057] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"112.226965ms","start":"2026-09-10T01:53:22.623404Z","end":"2026-09-10T01:53:22.735631Z","steps":["trace[159563057] 'read index received' (duration: 75.25988ms)","trace[159563057] 'applied index is now lower than readState.Index' (duration: 36.965345ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T01:53:22.735831Z","caller":"traceutil/trace.go:171","msg":"trace[248055640] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"131.669531ms","start":"2026-09-10T01:53:22.604146Z","end":"2026-09-10T01:53:22.735816Z","steps":["trace[248055640] 'process raft request' (duration: 94.671785ms)","trace[248055640] 'compare' (duration: 36.574967ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T01:53:22.736127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.688366ms","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-09-10T01:53:22.73622Z","caller":"traceutil/trace.go:171","msg":"trace[2010939334] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:630; }","duration":"112.826292ms","start":"2026-09-10T01:53:22.623379Z","end":"2026-09-10T01:53:22.736205Z","steps":["trace[2010939334] 'agreement among raft nodes before linearized reading' (duration: 112.601882ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:53:27.620845Z","caller":"traceutil/trace.go:171","msg":"trace[369194269] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"179.402811ms","start":"2026-09-10T01:53:27.441406Z","end":"2026-09-10T01:53:27.620808Z","steps":["trace[369194269] 'process raft request' (duration: 178.598115ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:53:28.339631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.352892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dqqpc\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-10T01:53:28.339725Z","caller":"traceutil/trace.go:171","msg":"trace[468407663] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dqqpc; range_end:; response_count:1; response_revision:661; }","duration":"420.511549ms","start":"2026-09-10T01:53:27.91919Z","end":"2026-09-10T01:53:28.339701Z","steps":["trace[468407663] 'range keys from in-memory index tree' (duration: 420.197385ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:53:28.339764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:53:27.919166Z","time spent":"420.590992ms","remote":"127.0.0.1:48342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-dqqpc\" "} {"level":"info","ts":"2026-09-10T01:53:28.340928Z","caller":"traceutil/trace.go:171","msg":"trace[387491941] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"151.911995ms","start":"2026-09-10T01:53:28.188985Z","end":"2026-09-10T01:53:28.340897Z","steps":["trace[387491941] 'process raft request' (duration: 149.947649ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:54:46.103883Z","caller":"traceutil/trace.go:171","msg":"trace[1657051249] transaction","detail":"{read_only:false; response_revision:1595; number_of_response:1; }","duration":"305.794131ms","start":"2026-09-10T01:54:45.798064Z","end":"2026-09-10T01:54:46.103858Z","steps":["trace[1657051249] 'process raft request' (duration: 245.693725ms)","trace[1657051249] 'compare' (duration: 59.803659ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T01:54:46.104291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:54:45.798041Z","time spent":"305.902014ms","remote":"127.0.0.1:48198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":111670,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T01:55:06.688482Z","caller":"traceutil/trace.go:171","msg":"trace[167440986] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"191.396735ms","start":"2026-09-10T01:55:06.497065Z","end":"2026-09-10T01:55:06.688462Z","steps":["trace[167440986] 'process raft request' (duration: 191.259473ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:55:19.099639Z","caller":"traceutil/trace.go:171","msg":"trace[1233607072] transaction","detail":"{read_only:false; response_revision:2016; number_of_response:1; }","duration":"109.200713ms","start":"2026-09-10T01:55:18.990401Z","end":"2026-09-10T01:55:19.099601Z","steps":["trace[1233607072] 'process raft request' (duration: 108.954788ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:55:19.297318Z","caller":"traceutil/trace.go:171","msg":"trace[959868084] transaction","detail":"{read_only:false; response_revision:2017; number_of_response:1; }","duration":"193.350209ms","start":"2026-09-10T01:55:19.103929Z","end":"2026-09-10T01:55:19.297279Z","steps":["trace[959868084] 'process raft request' (duration: 144.538805ms)","trace[959868084] 'compare' (duration: 48.63959ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T01:55:19.36824Z","caller":"traceutil/trace.go:171","msg":"trace[19700553] transaction","detail":"{read_only:false; response_revision:2018; number_of_response:1; }","duration":"117.933247ms","start":"2026-09-10T01:55:19.250279Z","end":"2026-09-10T01:55:19.368212Z","steps":["trace[19700553] 'process raft request' (duration: 117.721303ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:55:23.26924Z","caller":"traceutil/trace.go:171","msg":"trace[1871267296] transaction","detail":"{read_only:false; response_revision:2048; number_of_response:1; }","duration":"151.641422ms","start":"2026-09-10T01:55:23.117574Z","end":"2026-09-10T01:55:23.269216Z","steps":["trace[1871267296] 'process raft request' (duration: 151.419828ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:55:40.261667Z","caller":"traceutil/trace.go:171","msg":"trace[1229465984] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"113.00429ms","start":"2026-09-10T01:55:40.148634Z","end":"2026-09-10T01:55:40.261638Z","steps":["trace[1229465984] 'process raft request' (duration: 112.836547ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:55:45.630097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.918074ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-10T01:55:45.630428Z","caller":"traceutil/trace.go:171","msg":"trace[1793977991] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"157.411021ms","start":"2026-09-10T01:55:45.472979Z","end":"2026-09-10T01:55:45.63039Z","steps":["trace[1793977991] 'process raft request' (duration: 21.971947ms)","trace[1793977991] 'compare' (duration: 134.822642ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T01:55:46.661474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.953822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T01:55:46.661603Z","caller":"traceutil/trace.go:171","msg":"trace[987991760] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:2179; }","duration":"190.163686ms","start":"2026-09-10T01:55:46.471409Z","end":"2026-09-10T01:55:46.661573Z","steps":["trace[987991760] 'count revisions from in-memory index tree' (duration: 189.85622ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:55:46.787162Z","caller":"traceutil/trace.go:171","msg":"trace[2035661960] linearizableReadLoop","detail":"{readStateIndex:2266; appliedIndex:2265; }","duration":"104.930713ms","start":"2026-09-10T01:55:46.682207Z","end":"2026-09-10T01:55:46.787137Z","steps":["trace[2035661960] 'read index received' (duration: 104.76524ms)","trace[2035661960] 'applied index is now lower than readState.Index' (duration: 164.283µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T01:55:46.787223Z","caller":"traceutil/trace.go:171","msg":"trace[1223088042] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"121.680892ms","start":"2026-09-10T01:55:46.665516Z","end":"2026-09-10T01:55:46.787197Z","steps":["trace[1223088042] 'process raft request' (duration: 121.459708ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:55:46.787467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.23998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-10T01:55:46.787651Z","caller":"traceutil/trace.go:171","msg":"trace[1025565637] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:2180; }","duration":"105.469043ms","start":"2026-09-10T01:55:46.682157Z","end":"2026-09-10T01:55:46.787626Z","steps":["trace[1025565637] 'agreement among raft nodes before linearized reading' (duration: 105.152457ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:56:37.985624Z","caller":"traceutil/trace.go:171","msg":"trace[254806871] linearizableReadLoop","detail":"{readStateIndex:2659; appliedIndex:2658; }","duration":"202.54266ms","start":"2026-09-10T01:56:37.78306Z","end":"2026-09-10T01:56:37.985603Z","steps":["trace[254806871] 'read index received' (duration: 202.478798ms)","trace[254806871] 'applied index is now lower than readState.Index' (duration: 62.752µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T01:56:37.985668Z","caller":"traceutil/trace.go:171","msg":"trace[748291175] transaction","detail":"{read_only:false; response_revision:2561; number_of_response:1; }","duration":"203.613648ms","start":"2026-09-10T01:56:37.782025Z","end":"2026-09-10T01:56:37.985639Z","steps":["trace[748291175] 'process raft request' (duration: 203.444375ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:56:37.985777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.697562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T01:56:37.985838Z","caller":"traceutil/trace.go:171","msg":"trace[569987278] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2561; }","duration":"202.795414ms","start":"2026-09-10T01:56:37.783031Z","end":"2026-09-10T01:56:37.985826Z","steps":["trace[569987278] 'agreement among raft nodes before linearized reading' (duration: 202.680802ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:56:37.986484Z","caller":"traceutil/trace.go:171","msg":"trace[2060577878] transaction","detail":"{read_only:false; response_revision:2562; number_of_response:1; }","duration":"169.642603ms","start":"2026-09-10T01:56:37.816826Z","end":"2026-09-10T01:56:37.986468Z","steps":["trace[2060577878] 'process raft request' (duration: 169.43534ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:01:38.265896Z","caller":"traceutil/trace.go:171","msg":"trace[2079650352] transaction","detail":"{read_only:false; response_revision:4763; number_of_response:1; }","duration":"146.830608ms","start":"2026-09-10T02:01:38.119043Z","end":"2026-09-10T02:01:38.265874Z","steps":["trace[2079650352] 'process raft request' (duration: 128.789339ms)","trace[2079650352] 'compare' (duration: 17.878976ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:01:39.83424Z","caller":"traceutil/trace.go:171","msg":"trace[80599088] linearizableReadLoop","detail":"{readStateIndex:4962; appliedIndex:4961; }","duration":"260.389929ms","start":"2026-09-10T02:01:39.573822Z","end":"2026-09-10T02:01:39.834212Z","steps":["trace[80599088] 'read index received' (duration: 200.649876ms)","trace[80599088] 'applied index is now lower than readState.Index' (duration: 59.738893ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:01:39.834742Z","caller":"traceutil/trace.go:171","msg":"trace[867176198] transaction","detail":"{read_only:false; response_revision:4778; number_of_response:1; }","duration":"264.022083ms","start":"2026-09-10T02:01:39.570702Z","end":"2026-09-10T02:01:39.834724Z","steps":["trace[867176198] 'process raft request' (duration: 203.784851ms)","trace[867176198] 'compare' (duration: 59.464747ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:01:39.834883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.050703ms","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-09-10T02:01:39.835505Z","caller":"traceutil/trace.go:171","msg":"trace[1044996753] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4778; }","duration":"261.699656ms","start":"2026-09-10T02:01:39.57379Z","end":"2026-09-10T02:01:39.83549Z","steps":["trace[1044996753] 'agreement among raft nodes before linearized reading' (duration: 260.989172ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:01:39.874258Z","caller":"traceutil/trace.go:171","msg":"trace[825538971] transaction","detail":"{read_only:false; response_revision:4779; number_of_response:1; }","duration":"258.763426ms","start":"2026-09-10T02:01:39.615473Z","end":"2026-09-10T02:01:39.874237Z","steps":["trace[825538971] 'process raft request' (duration: 258.430579ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:39.874535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.250536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d6130586-f3a7-4e42-8cd9-e4049f1a5200\" ","response":"range_response_count:1 size:4067"} {"level":"info","ts":"2026-09-10T02:01:39.874636Z","caller":"traceutil/trace.go:171","msg":"trace[8454690] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d6130586-f3a7-4e42-8cd9-e4049f1a5200; range_end:; response_count:1; response_revision:4779; }","duration":"110.40477ms","start":"2026-09-10T02:01:39.764209Z","end":"2026-09-10T02:01:39.874613Z","steps":["trace[8454690] 'agreement among raft nodes before linearized reading' (duration: 110.062823ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:39.874714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.553754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-09-10T02:01:39.874716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.722724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-31494bce-752f-4ebd-976e-94afe0acc019\" ","response":"range_response_count:1 size:4053"} {"level":"info","ts":"2026-09-10T02:01:39.874769Z","caller":"traceutil/trace.go:171","msg":"trace[966933947] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4779; }","duration":"199.645077ms","start":"2026-09-10T02:01:39.675109Z","end":"2026-09-10T02:01:39.874754Z","steps":["trace[966933947] 'agreement among raft nodes before linearized reading' (duration: 199.481813ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:01:39.874797Z","caller":"traceutil/trace.go:171","msg":"trace[2041401436] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-31494bce-752f-4ebd-976e-94afe0acc019; range_end:; response_count:1; response_revision:4779; }","duration":"149.845667ms","start":"2026-09-10T02:01:39.72493Z","end":"2026-09-10T02:01:39.874775Z","steps":["trace[2041401436] 'agreement among raft nodes before linearized reading' (duration: 149.593972ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:39.875174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.978046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T02:01:39.875287Z","caller":"traceutil/trace.go:171","msg":"trace[226628269] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4779; }","duration":"207.126719ms","start":"2026-09-10T02:01:39.668145Z","end":"2026-09-10T02:01:39.875272Z","steps":["trace[226628269] 'agreement among raft nodes before linearized reading' (duration: 206.081688ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:01:42.926479Z","caller":"traceutil/trace.go:171","msg":"trace[763299295] linearizableReadLoop","detail":"{readStateIndex:5043; appliedIndex:5041; }","duration":"248.95899ms","start":"2026-09-10T02:01:42.677494Z","end":"2026-09-10T02:01:42.926453Z","steps":["trace[763299295] 'read index received' (duration: 47.172803ms)","trace[763299295] 'applied index is now lower than readState.Index' (duration: 201.785117ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:01:42.926595Z","caller":"traceutil/trace.go:171","msg":"trace[2029961489] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"252.839519ms","start":"2026-09-10T02:01:42.673729Z","end":"2026-09-10T02:01:42.926568Z","steps":["trace[2029961489] 'process raft request' (duration: 252.512502ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:42.927833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.313167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-09-10T02:01:42.927911Z","caller":"traceutil/trace.go:171","msg":"trace[872455484] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4857; }","duration":"250.402709ms","start":"2026-09-10T02:01:42.677489Z","end":"2026-09-10T02:01:42.927892Z","steps":["trace[872455484] 'agreement among raft nodes before linearized reading' (duration: 249.210885ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:42.958651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.543211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T02:01:42.958743Z","caller":"traceutil/trace.go:171","msg":"trace[1551158716] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4858; }","duration":"175.664984ms","start":"2026-09-10T02:01:42.783039Z","end":"2026-09-10T02:01:42.958704Z","steps":["trace[1551158716] 'agreement among raft nodes before linearized reading' (duration: 175.46439ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:01:43.103779Z","caller":"traceutil/trace.go:171","msg":"trace[636651604] linearizableReadLoop","detail":"{readStateIndex:5046; appliedIndex:5045; }","duration":"115.348061ms","start":"2026-09-10T02:01:42.988413Z","end":"2026-09-10T02:01:43.103762Z","steps":["trace[636651604] 'read index received' (duration: 115.326311ms)","trace[636651604] 'applied index is now lower than readState.Index' (duration: 21.26µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:01:43.103817Z","caller":"traceutil/trace.go:171","msg":"trace[423521794] transaction","detail":"{read_only:false; response_revision:4860; number_of_response:1; }","duration":"132.818048ms","start":"2026-09-10T02:01:42.970983Z","end":"2026-09-10T02:01:43.103801Z","steps":["trace[423521794] 'process raft request' (duration: 132.686215ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:43.104003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.019486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T02:01:43.104031Z","caller":"traceutil/trace.go:171","msg":"trace[778741720] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4860; }","duration":"144.102847ms","start":"2026-09-10T02:01:42.95992Z","end":"2026-09-10T02:01:43.104023Z","steps":["trace[778741720] 'agreement among raft nodes before linearized reading' (duration: 144.046856ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:43.105058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.202065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-09-10T02:01:43.105225Z","caller":"traceutil/trace.go:171","msg":"trace[1845500989] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4860; }","duration":"135.452891ms","start":"2026-09-10T02:01:42.96972Z","end":"2026-09-10T02:01:43.105173Z","steps":["trace[1845500989] 'agreement among raft nodes before linearized reading' (duration: 134.128024ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:01:43.417632Z","caller":"traceutil/trace.go:171","msg":"trace[2075861793] linearizableReadLoop","detail":"{readStateIndex:5047; appliedIndex:5046; }","duration":"313.771226ms","start":"2026-09-10T02:01:43.103834Z","end":"2026-09-10T02:01:43.417605Z","steps":["trace[2075861793] 'read index received' (duration: 308.715652ms)","trace[2075861793] 'applied index is now lower than readState.Index' (duration: 5.054194ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:01:43.417704Z","caller":"traceutil/trace.go:171","msg":"trace[386702445] transaction","detail":"{read_only:false; response_revision:4861; number_of_response:1; }","duration":"415.03367ms","start":"2026-09-10T02:01:43.002637Z","end":"2026-09-10T02:01:43.417671Z","steps":["trace[386702445] 'process raft request' (duration: 409.901395ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:43.417865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:01:43.002621Z","time spent":"415.155692ms","remote":"127.0.0.1:48342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16218,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T02:01:43.418069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-31494bce-752f-4ebd-976e-94afe0acc019\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-09-10T02:01:43.418835Z","caller":"traceutil/trace.go:171","msg":"trace[784284620] range","detail":"{range_begin:/registry/persistentvolumes/pvc-31494bce-752f-4ebd-976e-94afe0acc019; range_end:; response_count:1; response_revision:4861; }","duration":"426.613066ms","start":"2026-09-10T02:01:42.992196Z","end":"2026-09-10T02:01:43.418809Z","steps":["trace[784284620] 'agreement among raft nodes before linearized reading' (duration: 425.693917ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:43.41897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:01:42.992179Z","time spent":"426.758739ms","remote":"127.0.0.1:48304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1458,"request content":"key:\"/registry/persistentvolumes/pvc-31494bce-752f-4ebd-976e-94afe0acc019\" "} {"level":"info","ts":"2026-09-10T02:01:43.488072Z","caller":"traceutil/trace.go:171","msg":"trace[533082207] transaction","detail":"{read_only:false; response_revision:4862; number_of_response:1; }","duration":"306.192271ms","start":"2026-09-10T02:01:43.181846Z","end":"2026-09-10T02:01:43.488039Z","steps":["trace[533082207] 'process raft request' (duration: 306.020177ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:43.488231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:01:43.181824Z","time spent":"306.320684ms","remote":"127.0.0.1:48424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T02:01:43.488589Z","caller":"traceutil/trace.go:171","msg":"trace[302898277] transaction","detail":"{read_only:false; response_revision:4863; number_of_response:1; }","duration":"299.516145ms","start":"2026-09-10T02:01:43.188965Z","end":"2026-09-10T02:01:43.488481Z","steps":["trace[302898277] 'process raft request' (duration: 299.032285ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:43.488647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.050796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1986"} {"level":"warn","ts":"2026-09-10T02:01:43.488669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.323068ms","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-09-10T02:01:43.488739Z","caller":"traceutil/trace.go:171","msg":"trace[327098752] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4863; }","duration":"134.467331ms","start":"2026-09-10T02:01:43.354252Z","end":"2026-09-10T02:01:43.488719Z","steps":["trace[327098752] 'agreement among raft nodes before linearized reading' (duration: 134.265967ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:43.488772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.779784ms","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-10T02:01:43.488797Z","caller":"traceutil/trace.go:171","msg":"trace[179817096] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4863; }","duration":"126.826375ms","start":"2026-09-10T02:01:43.361963Z","end":"2026-09-10T02:01:43.48879Z","steps":["trace[179817096] 'agreement among raft nodes before linearized reading' (duration: 126.751184ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:01:43.488684Z","caller":"traceutil/trace.go:171","msg":"trace[434127178] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:4863; }","duration":"117.106317ms","start":"2026-09-10T02:01:43.371566Z","end":"2026-09-10T02:01:43.488672Z","steps":["trace[434127178] 'agreement among raft nodes before linearized reading' (duration: 116.981284ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:43.489095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.712264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-09-10T02:01:43.48951Z","caller":"traceutil/trace.go:171","msg":"trace[553454777] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4863; }","duration":"364.03558ms","start":"2026-09-10T02:01:43.125339Z","end":"2026-09-10T02:01:43.489375Z","steps":["trace[553454777] 'agreement among raft nodes before linearized reading' (duration: 363.286515ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:43.489702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:01:43.125322Z","time spent":"364.363756ms","remote":"127.0.0.1:48242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":3529,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" "} {"level":"info","ts":"2026-09-10T02:01:43.650456Z","caller":"traceutil/trace.go:171","msg":"trace[49709485] linearizableReadLoop","detail":"{readStateIndex:5059; appliedIndex:5057; }","duration":"106.843658ms","start":"2026-09-10T02:01:43.543586Z","end":"2026-09-10T02:01:43.65043Z","steps":["trace[49709485] 'read index received' (duration: 51.447029ms)","trace[49709485] 'applied index is now lower than readState.Index' (duration: 55.394959ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:01:43.650492Z","caller":"traceutil/trace.go:171","msg":"trace[1557711475] transaction","detail":"{read_only:false; response_revision:4872; number_of_response:1; }","duration":"109.907391ms","start":"2026-09-10T02:01:43.540553Z","end":"2026-09-10T02:01:43.650461Z","steps":["trace[1557711475] 'process raft request' (duration: 97.093269ms)","trace[1557711475] 'compare' (duration: 12.610318ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:01:43.650652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.038962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T02:01:43.650716Z","caller":"traceutil/trace.go:171","msg":"trace[1792468085] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:4872; }","duration":"107.147595ms","start":"2026-09-10T02:01:43.543553Z","end":"2026-09-10T02:01:43.650701Z","steps":["trace[1792468085] 'agreement among raft nodes before linearized reading' (duration: 106.990801ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:49.684691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.258604ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-10T02:01:49.684898Z","caller":"traceutil/trace.go:171","msg":"trace[1953596684] transaction","detail":"{read_only:false; response_revision:4968; number_of_response:1; }","duration":"176.114259ms","start":"2026-09-10T02:01:49.508753Z","end":"2026-09-10T02:01:49.684867Z","steps":["trace[1953596684] 'process raft request' (duration: 28.575279ms)","trace[1953596684] 'compare' (duration: 147.098881ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:01:49.68497Z","caller":"traceutil/trace.go:171","msg":"trace[635362832] linearizableReadLoop","detail":"{readStateIndex:5158; appliedIndex:5156; }","duration":"156.790958ms","start":"2026-09-10T02:01:49.528167Z","end":"2026-09-10T02:01:49.684958Z","steps":["trace[635362832] 'read index received' (duration: 9.173926ms)","trace[635362832] 'applied index is now lower than readState.Index' (duration: 147.616292ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:01:49.685067Z","caller":"traceutil/trace.go:171","msg":"trace[1092946513] transaction","detail":"{read_only:false; response_revision:4969; number_of_response:1; }","duration":"175.454135ms","start":"2026-09-10T02:01:49.50959Z","end":"2026-09-10T02:01:49.685045Z","steps":["trace[1092946513] 'process raft request' (duration: 175.221951ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:49.685311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.148264ms","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-09-10T02:01:49.68539Z","caller":"traceutil/trace.go:171","msg":"trace[1298605975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4969; }","duration":"157.264577ms","start":"2026-09-10T02:01:49.528112Z","end":"2026-09-10T02:01:49.685377Z","steps":["trace[1298605975] 'agreement among raft nodes before linearized reading' (duration: 156.969671ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:01:49.687083Z","caller":"traceutil/trace.go:171","msg":"trace[1119254928] transaction","detail":"{read_only:false; response_revision:4970; number_of_response:1; }","duration":"141.498417ms","start":"2026-09-10T02:01:49.545568Z","end":"2026-09-10T02:01:49.687067Z","steps":["trace[1119254928] 'process raft request' (duration: 141.401495ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:49.68713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.614168ms","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-10T02:01:49.687158Z","caller":"traceutil/trace.go:171","msg":"trace[1212459671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4970; }","duration":"134.683279ms","start":"2026-09-10T02:01:49.552467Z","end":"2026-09-10T02:01:49.687151Z","steps":["trace[1212459671] 'agreement among raft nodes before linearized reading' (duration: 134.572257ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:49.687422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.058627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-77d99cf858-42n59\" ","response":"range_response_count:1 size:11257"} {"level":"info","ts":"2026-09-10T02:01:49.687462Z","caller":"traceutil/trace.go:171","msg":"trace[1991456454] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-77d99cf858-42n59; range_end:; response_count:1; response_revision:4970; }","duration":"134.135848ms","start":"2026-09-10T02:01:49.553315Z","end":"2026-09-10T02:01:49.687451Z","steps":["trace[1991456454] 'agreement among raft nodes before linearized reading' (duration: 133.965035ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:01:49.845684Z","caller":"traceutil/trace.go:171","msg":"trace[282985294] transaction","detail":"{read_only:false; response_revision:4971; number_of_response:1; }","duration":"155.135743ms","start":"2026-09-10T02:01:49.690509Z","end":"2026-09-10T02:01:49.845645Z","steps":["trace[282985294] 'process raft request' (duration: 132.392963ms)","trace[282985294] 'compare' (duration: 22.525976ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:01:49.867605Z","caller":"traceutil/trace.go:171","msg":"trace[1714037671] linearizableReadLoop","detail":"{readStateIndex:5162; appliedIndex:5159; }","duration":"139.119059ms","start":"2026-09-10T02:01:49.728458Z","end":"2026-09-10T02:01:49.867577Z","steps":["trace[1714037671] 'read index received' (duration: 94.437784ms)","trace[1714037671] 'applied index is now lower than readState.Index' (duration: 44.680125ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:01:49.867847Z","caller":"traceutil/trace.go:171","msg":"trace[1792336742] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"165.028874ms","start":"2026-09-10T02:01:49.702719Z","end":"2026-09-10T02:01:49.867748Z","steps":["trace[1792336742] 'process raft request' (duration: 164.788129ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:01:49.868012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.524867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T02:01:49.868191Z","caller":"traceutil/trace.go:171","msg":"trace[2049293309] transaction","detail":"{read_only:false; response_revision:4972; number_of_response:1; }","duration":"177.17906ms","start":"2026-09-10T02:01:49.690902Z","end":"2026-09-10T02:01:49.868081Z","steps":["trace[2049293309] 'process raft request' (duration: 176.424875ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:01:49.868949Z","caller":"traceutil/trace.go:171","msg":"trace[1373946256] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:4973; }","duration":"140.457226ms","start":"2026-09-10T02:01:49.728414Z","end":"2026-09-10T02:01:49.868871Z","steps":["trace[1373946256] 'agreement among raft nodes before linearized reading' (duration: 139.535357ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:02:04.286644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.61002ms","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-09-10T02:02:04.28667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.264812ms","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-09-10T02:02:04.286734Z","caller":"traceutil/trace.go:171","msg":"trace[1186518574] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5157; }","duration":"208.736783ms","start":"2026-09-10T02:02:04.077976Z","end":"2026-09-10T02:02:04.286712Z","steps":["trace[1186518574] 'range keys from in-memory index tree' (duration: 208.415276ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:02:04.287114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.866644ms","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-10T02:02:04.287201Z","caller":"traceutil/trace.go:171","msg":"trace[422579648] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5157; }","duration":"205.984827ms","start":"2026-09-10T02:02:04.081199Z","end":"2026-09-10T02:02:04.287184Z","steps":["trace[422579648] 'range keys from in-memory index tree' (duration: 205.512018ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:02:04.287372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.850515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-10T02:02:04.28742Z","caller":"traceutil/trace.go:171","msg":"trace[1518555746] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:5157; }","duration":"191.950266ms","start":"2026-09-10T02:02:04.095453Z","end":"2026-09-10T02:02:04.287403Z","steps":["trace[1518555746] 'count revisions from in-memory index tree' (duration: 191.686001ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:02:04.287637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.980747ms","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-10T02:02:04.287688Z","caller":"traceutil/trace.go:171","msg":"trace[1001127457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5157; }","duration":"311.053348ms","start":"2026-09-10T02:02:03.97662Z","end":"2026-09-10T02:02:04.287673Z","steps":["trace[1001127457] 'range keys from in-memory index tree' (duration: 310.846924ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:02:04.287727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:02:03.976609Z","time spent":"311.106479ms","remote":"127.0.0.1:48424","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-09-10T02:02:04.28825Z","caller":"traceutil/trace.go:171","msg":"trace[729847407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5157; }","duration":"311.364974ms","start":"2026-09-10T02:02:03.975373Z","end":"2026-09-10T02:02:04.286738Z","steps":["trace[729847407] 'range keys from in-memory index tree' (duration: 311.072778ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:02:04.288322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:02:03.975276Z","time spent":"313.027007ms","remote":"127.0.0.1:48424","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-09-10T02:02:34.533948Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2869} {"level":"info","ts":"2026-09-10T02:02:34.616213Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2869,"took":"80.160395ms","hash":406610897,"current-db-size-bytes":51089408,"current-db-size":"51 MB","current-db-size-in-use-bytes":27717632,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-10T02:02:34.616307Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":406610897,"revision":2869,"compact-revision":-1} {"level":"info","ts":"2026-09-10T02:07:34.53866Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5354} {"level":"info","ts":"2026-09-10T02:07:34.646889Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5354,"took":"107.273817ms","hash":310011862,"current-db-size-bytes":51089408,"current-db-size":"51 MB","current-db-size-in-use-bytes":18558976,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-10T02:07:34.646961Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":310011862,"revision":5354,"compact-revision":2869}