{"level":"warn","ts":"2026-09-18T02:23:17.803771Z","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-18T02:23:17.803911Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.6: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.6:2380","--initial-cluster=instance=https://162.253.55.6:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.6:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.6: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-18T02:23:17.804789Z","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-18T02:23:17.804809Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.6:2380"]} {"level":"info","ts":"2026-09-18T02:23:17.80489Z","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-18T02:23:17.805615Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.6:2379"]} {"level":"info","ts":"2026-09-18T02:23:17.80573Z","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.6:2380"],"listen-peer-urls":["https://162.253.55.6:2380"],"advertise-client-urls":["https://162.253.55.6:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.6:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.6: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-18T02:23:17.811518Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.261977ms"} {"level":"info","ts":"2026-09-18T02:23:17.824373Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e4145bf1b1a19cd","cluster-id":"e02e9056d18cef61"} {"level":"info","ts":"2026-09-18T02:23:17.824627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e4145bf1b1a19cd switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T02:23:17.824662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e4145bf1b1a19cd became follower at term 0"} {"level":"info","ts":"2026-09-18T02:23:17.824719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e4145bf1b1a19cd [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T02:23:17.82478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e4145bf1b1a19cd became follower at term 1"} {"level":"info","ts":"2026-09-18T02:23:17.824837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e4145bf1b1a19cd switched to configuration voters=(5638864895540337101)"} {"level":"warn","ts":"2026-09-18T02:23:17.833711Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T02:23:17.835186Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T02:23:17.836574Z","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-18T02:23:17.838617Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e4145bf1b1a19cd","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T02:23:17.838737Z","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-18T02:23:17.838784Z","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-18T02:23:17.838882Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e4145bf1b1a19cd","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T02:23:17.83879Z","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-18T02:23:17.840762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e4145bf1b1a19cd switched to configuration voters=(5638864895540337101)"} {"level":"info","ts":"2026-09-18T02:23:17.840934Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e02e9056d18cef61","local-member-id":"4e4145bf1b1a19cd","added-peer-id":"4e4145bf1b1a19cd","added-peer-peer-urls":["https://162.253.55.6:2380"]} {"level":"info","ts":"2026-09-18T02:23:17.843554Z","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-18T02:23:17.843878Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e4145bf1b1a19cd","initial-advertise-peer-urls":["https://162.253.55.6:2380"],"listen-peer-urls":["https://162.253.55.6:2380"],"advertise-client-urls":["https://162.253.55.6:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.6:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T02:23:17.843883Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.6:2380"} {"level":"info","ts":"2026-09-18T02:23:17.843927Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.6:2380"} {"level":"info","ts":"2026-09-18T02:23:17.843915Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T02:23:17.925329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e4145bf1b1a19cd is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T02:23:17.925447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e4145bf1b1a19cd became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T02:23:17.925472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e4145bf1b1a19cd received MsgPreVoteResp from 4e4145bf1b1a19cd at term 1"} {"level":"info","ts":"2026-09-18T02:23:17.925488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e4145bf1b1a19cd became candidate at term 2"} {"level":"info","ts":"2026-09-18T02:23:17.925494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e4145bf1b1a19cd received MsgVoteResp from 4e4145bf1b1a19cd at term 2"} {"level":"info","ts":"2026-09-18T02:23:17.925505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e4145bf1b1a19cd became leader at term 2"} {"level":"info","ts":"2026-09-18T02:23:17.925514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e4145bf1b1a19cd elected leader 4e4145bf1b1a19cd at term 2"} {"level":"info","ts":"2026-09-18T02:23:17.92787Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e4145bf1b1a19cd","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.6:2379]}","request-path":"/0/members/4e4145bf1b1a19cd/attributes","cluster-id":"e02e9056d18cef61","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T02:23:17.927968Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:23:17.928142Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T02:23:17.928158Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T02:23:17.929519Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e02e9056d18cef61","local-member-id":"4e4145bf1b1a19cd","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:23:17.929793Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T02:23:17.929924Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T02:23:17.930092Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-18T02:23:17.932519Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:23:17.932654Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:23:17.936222Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.6:2379"} {"level":"info","ts":"2026-09-18T02:23:19.675775Z","caller":"traceutil/trace.go:171","msg":"trace[949379823] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"192.664178ms","start":"2026-09-18T02:23:19.483081Z","end":"2026-09-18T02:23:19.675746Z","steps":["trace[949379823] 'process raft request' (duration: 192.296305ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:23:19.966396Z","caller":"traceutil/trace.go:171","msg":"trace[2059025738] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"483.022258ms","start":"2026-09-18T02:23:19.483316Z","end":"2026-09-18T02:23:19.966338Z","steps":["trace[2059025738] 'process raft request' (duration: 399.692415ms)","trace[2059025738] 'compare' (duration: 83.029491ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:23:19.966649Z","caller":"traceutil/trace.go:171","msg":"trace[1794064231] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"482.204012ms","start":"2026-09-18T02:23:19.484416Z","end":"2026-09-18T02:23:19.96662Z","steps":["trace[1794064231] 'read index received' (duration: 191.061206ms)","trace[1794064231] 'applied index is now lower than readState.Index' (duration: 291.141616ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:23:19.966698Z","caller":"traceutil/trace.go:171","msg":"trace[753022162] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"389.627604ms","start":"2026-09-18T02:23:19.57703Z","end":"2026-09-18T02:23:19.966657Z","steps":["trace[753022162] 'process raft request' (duration: 389.445183ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:23:19.966837Z","caller":"traceutil/trace.go:171","msg":"trace[306170851] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"389.732885ms","start":"2026-09-18T02:23:19.577093Z","end":"2026-09-18T02:23:19.966826Z","steps":["trace[306170851] 'process raft request' (duration: 389.409873ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:23:19.966808Z","caller":"traceutil/trace.go:171","msg":"trace[269567492] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"389.797456ms","start":"2026-09-18T02:23:19.576942Z","end":"2026-09-18T02:23:19.966739Z","steps":["trace[269567492] 'process raft request' (duration: 389.489163ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:23:19.966965Z","caller":"traceutil/trace.go:171","msg":"trace[1024034954] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"389.764685ms","start":"2026-09-18T02:23:19.57719Z","end":"2026-09-18T02:23:19.966955Z","steps":["trace[1024034954] 'process raft request' (duration: 389.343312ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:23:19.966983Z","caller":"traceutil/trace.go:171","msg":"trace[1707651011] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"415.440055ms","start":"2026-09-18T02:23:19.551531Z","end":"2026-09-18T02:23:19.966971Z","steps":["trace[1707651011] 'process raft request' (duration: 414.75919ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:23:19.967056Z","caller":"traceutil/trace.go:171","msg":"trace[1202379130] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"389.341413ms","start":"2026-09-18T02:23:19.577704Z","end":"2026-09-18T02:23:19.967045Z","steps":["trace[1202379130] 'process raft request' (duration: 388.87976ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:19.967168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:19.483297Z","time spent":"483.220689ms","remote":"127.0.0.1:34996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:23:19.967134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:19.577697Z","time spent":"389.395763ms","remote":"127.0.0.1:35490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T02:23:19.967224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.22438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T02:23:19.967338Z","caller":"traceutil/trace.go:171","msg":"trace[547453913] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"433.402431ms","start":"2026-09-18T02:23:19.533924Z","end":"2026-09-18T02:23:19.967327Z","steps":["trace[547453913] 'agreement among raft nodes before linearized reading' (duration: 433.168169ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:19.967366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:19.533836Z","time spent":"433.521181ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-18T02:23:19.967437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:19.577Z","time spent":"389.788646ms","remote":"127.0.0.1:35490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T02:23:19.967489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:19.577059Z","time spent":"389.815506ms","remote":"127.0.0.1:35490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T02:23:19.967535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:19.577183Z","time spent":"389.833066ms","remote":"127.0.0.1:35490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T02:23:19.967615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.198359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3169"} {"level":"warn","ts":"2026-09-18T02:23:19.967617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:19.576928Z","time spent":"390.019847ms","remote":"127.0.0.1:35490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T02:23:19.967712Z","caller":"traceutil/trace.go:171","msg":"trace[776187662] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"483.275609ms","start":"2026-09-18T02:23:19.484375Z","end":"2026-09-18T02:23:19.967651Z","steps":["trace[776187662] 'agreement among raft nodes before linearized reading' (duration: 483.195258ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:19.967752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:19.484357Z","time spent":"483.386601ms","remote":"127.0.0.1:35106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3192,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-09-18T02:23:19.967889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:19.551515Z","time spent":"415.505436ms","remote":"127.0.0.1:35398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T02:23:19.967933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.773461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.6\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T02:23:19.967975Z","caller":"traceutil/trace.go:171","msg":"trace[755417637] range","detail":"{range_begin:/registry/masterleases/162.253.55.6; range_end:; response_count:0; response_revision:11; }","duration":"417.853181ms","start":"2026-09-18T02:23:19.550115Z","end":"2026-09-18T02:23:19.967968Z","steps":["trace[755417637] 'agreement among raft nodes before linearized reading' (duration: 417.757921ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:19.967983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.226462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T02:23:19.968033Z","caller":"traceutil/trace.go:171","msg":"trace[2117564573] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"432.290113ms","start":"2026-09-18T02:23:19.535731Z","end":"2026-09-18T02:23:19.968021Z","steps":["trace[2117564573] 'agreement among raft nodes before linearized reading' (duration: 432.198992ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:19.96807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:19.535724Z","time spent":"432.339463ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-18T02:23:19.968026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.030356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T02:23:19.968142Z","caller":"traceutil/trace.go:171","msg":"trace[605298438] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"344.182826ms","start":"2026-09-18T02:23:19.623953Z","end":"2026-09-18T02:23:19.968136Z","steps":["trace[605298438] 'agreement among raft nodes before linearized reading' (duration: 344.054446ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:19.968158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:19.623929Z","time spent":"344.224578ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-09-18T02:23:19.9681Z","caller":"traceutil/trace.go:171","msg":"trace[651845104] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"402.375464ms","start":"2026-09-18T02:23:19.5647Z","end":"2026-09-18T02:23:19.967076Z","steps":["trace[651845104] 'process raft request' (duration: 401.641819ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:19.968311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.166241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T02:23:19.96833Z","caller":"traceutil/trace.go:171","msg":"trace[1324734605] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"396.212221ms","start":"2026-09-18T02:23:19.572112Z","end":"2026-09-18T02:23:19.968324Z","steps":["trace[1324734605] 'agreement among raft nodes before linearized reading' (duration: 396.178461ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:19.96831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.225669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T02:23:19.968386Z","caller":"traceutil/trace.go:171","msg":"trace[1621231161] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"433.31169ms","start":"2026-09-18T02:23:19.535049Z","end":"2026-09-18T02:23:19.96836Z","steps":["trace[1621231161] 'agreement among raft nodes before linearized reading' (duration: 433.162379ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:19.968454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:19.535039Z","time spent":"433.399631ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-18T02:23:19.968487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.244315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T02:23:19.968504Z","caller":"traceutil/trace.go:171","msg":"trace[1140423382] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"418.273135ms","start":"2026-09-18T02:23:19.550226Z","end":"2026-09-18T02:23:19.968499Z","steps":["trace[1140423382] 'agreement among raft nodes before linearized reading' (duration: 418.250135ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:19.968524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:19.55022Z","time spent":"418.296645ms","remote":"127.0.0.1:35058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-18T02:23:19.968466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:19.572099Z","time spent":"396.360782ms","remote":"127.0.0.1:35026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-09-18T02:23:19.968554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:19.56468Z","time spent":"403.753774ms","remote":"127.0.0.1:35178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T02:23:19.967998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:19.550088Z","time spent":"417.906672ms","remote":"127.0.0.1:34978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/162.253.55.6\" "} {"level":"info","ts":"2026-09-18T02:23:19.966686Z","caller":"traceutil/trace.go:171","msg":"trace[1186463916] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"399.931617ms","start":"2026-09-18T02:23:19.56671Z","end":"2026-09-18T02:23:19.966642Z","steps":["trace[1186463916] 'process raft request' (duration: 399.673105ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:19.968941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:19.566696Z","time spent":"402.224163ms","remote":"127.0.0.1:35106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3157,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T02:23:58.961589Z","caller":"traceutil/trace.go:171","msg":"trace[1073216500] linearizableReadLoop","detail":"{readStateIndex:473; appliedIndex:472; }","duration":"173.865744ms","start":"2026-09-18T02:23:58.787689Z","end":"2026-09-18T02:23:58.961555Z","steps":["trace[1073216500] 'read index received' (duration: 173.682636ms)","trace[1073216500] 'applied index is now lower than readState.Index' (duration: 182.088µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:23:58.96171Z","caller":"traceutil/trace.go:171","msg":"trace[1365475224] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"185.362199ms","start":"2026-09-18T02:23:58.776308Z","end":"2026-09-18T02:23:58.961671Z","steps":["trace[1365475224] 'process raft request' (duration: 185.070867ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:58.961762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.053693ms","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-18T02:23:58.96187Z","caller":"traceutil/trace.go:171","msg":"trace[1242903165] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:456; }","duration":"174.161637ms","start":"2026-09-18T02:23:58.787652Z","end":"2026-09-18T02:23:58.961814Z","steps":["trace[1242903165] 'agreement among raft nodes before linearized reading' (duration: 174.027751ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:58.962073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.247228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:23:58.962157Z","caller":"traceutil/trace.go:171","msg":"trace[986468760] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:456; }","duration":"107.391584ms","start":"2026-09-18T02:23:58.85475Z","end":"2026-09-18T02:23:58.962142Z","steps":["trace[986468760] 'agreement among raft nodes before linearized reading' (duration: 107.215936ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:01.699216Z","caller":"traceutil/trace.go:171","msg":"trace[972516031] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"129.134903ms","start":"2026-09-18T02:24:01.570048Z","end":"2026-09-18T02:24:01.699183Z","steps":["trace[972516031] 'process raft request' (duration: 125.941963ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:01.702449Z","caller":"traceutil/trace.go:171","msg":"trace[875945968] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"130.923196ms","start":"2026-09-18T02:24:01.571502Z","end":"2026-09-18T02:24:01.702425Z","steps":["trace[875945968] 'process raft request' (duration: 130.434826ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:01.702582Z","caller":"traceutil/trace.go:171","msg":"trace[2047592348] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"125.1214ms","start":"2026-09-18T02:24:01.57744Z","end":"2026-09-18T02:24:01.702562Z","steps":["trace[2047592348] 'process raft request' (duration: 124.62287ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:08.401211Z","caller":"traceutil/trace.go:171","msg":"trace[1242812963] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:625; }","duration":"328.197609ms","start":"2026-09-18T02:24:08.072975Z","end":"2026-09-18T02:24:08.401173Z","steps":["trace[1242812963] 'read index received' (duration: 327.270134ms)","trace[1242812963] 'applied index is now lower than readState.Index' (duration: 926.355µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:24:08.401393Z","caller":"traceutil/trace.go:171","msg":"trace[165958105] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"360.199151ms","start":"2026-09-18T02:24:08.04116Z","end":"2026-09-18T02:24:08.401359Z","steps":["trace[165958105] 'process raft request' (duration: 359.297777ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:24:08.401545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.526211ms","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-18T02:24:08.401904Z","caller":"traceutil/trace.go:171","msg":"trace[2027788612] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:606; }","duration":"328.77932ms","start":"2026-09-18T02:24:08.072893Z","end":"2026-09-18T02:24:08.401672Z","steps":["trace[2027788612] 'agreement among raft nodes before linearized reading' (duration: 328.484959ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:24:08.401591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:24:08.041121Z","time spent":"360.371308ms","remote":"127.0.0.1:35036","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-18T02:24:08.401995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:24:08.072862Z","time spent":"329.085202ms","remote":"127.0.0.1:35188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-18T02:24:08.899143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.083694ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:24:08.899291Z","caller":"traceutil/trace.go:171","msg":"trace[1522974150] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"459.325035ms","start":"2026-09-18T02:24:08.439936Z","end":"2026-09-18T02:24:08.899261Z","steps":["trace[1522974150] 'process raft request' (duration: 31.839786ms)","trace[1522974150] 'compare' (duration: 426.942738ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:24:08.899369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:24:08.439892Z","time spent":"459.440399ms","remote":"127.0.0.1:35116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:24:09.018628Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1859318908935816723,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-18T02:24:09.096766Z","caller":"traceutil/trace.go:171","msg":"trace[146484827] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:628; }","duration":"578.449441ms","start":"2026-09-18T02:24:08.518278Z","end":"2026-09-18T02:24:09.096728Z","steps":["trace[146484827] 'read index received' (duration: 517.333021ms)","trace[146484827] 'applied index is now lower than readState.Index' (duration: 61.11216ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:24:09.097162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.490969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:24:09.097303Z","caller":"traceutil/trace.go:171","msg":"trace[1104833378] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"243.675835ms","start":"2026-09-18T02:24:08.853595Z","end":"2026-09-18T02:24:09.097271Z","steps":["trace[1104833378] 'agreement among raft nodes before linearized reading' (duration: 243.452817ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:09.096979Z","caller":"traceutil/trace.go:171","msg":"trace[1076292933] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"614.115361ms","start":"2026-09-18T02:24:08.482785Z","end":"2026-09-18T02:24:09.096901Z","steps":["trace[1076292933] 'process raft request' (duration: 552.778742ms)","trace[1076292933] 'compare' (duration: 60.968605ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:24:09.097142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.838866ms","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-18T02:24:09.097555Z","caller":"traceutil/trace.go:171","msg":"trace[1609150658] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:609; }","duration":"579.345095ms","start":"2026-09-18T02:24:08.518199Z","end":"2026-09-18T02:24:09.097544Z","steps":["trace[1609150658] 'agreement among raft nodes before linearized reading' (duration: 578.737902ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:24:09.09761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:24:08.518167Z","time spent":"579.429998ms","remote":"127.0.0.1:35188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-18T02:24:09.097653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:24:08.482752Z","time spent":"614.731654ms","remote":"127.0.0.1:35160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T02:24:25.320081Z","caller":"traceutil/trace.go:171","msg":"trace[76009571] linearizableReadLoop","detail":"{readStateIndex:796; appliedIndex:795; }","duration":"122.033768ms","start":"2026-09-18T02:24:25.198017Z","end":"2026-09-18T02:24:25.32005Z","steps":["trace[76009571] 'read index received' (duration: 121.791721ms)","trace[76009571] 'applied index is now lower than readState.Index' (duration: 240.987µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:24:25.320172Z","caller":"traceutil/trace.go:171","msg":"trace[662569026] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"333.303624ms","start":"2026-09-18T02:24:24.98683Z","end":"2026-09-18T02:24:25.320134Z","steps":["trace[662569026] 'process raft request' (duration: 333.060446ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:24:25.320349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:24:24.986802Z","time spent":"333.458389ms","remote":"127.0.0.1:35188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:24:25.32036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.316047ms","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-18T02:24:25.320399Z","caller":"traceutil/trace.go:171","msg":"trace[1877252792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:770; }","duration":"122.41044ms","start":"2026-09-18T02:24:25.197979Z","end":"2026-09-18T02:24:25.320389Z","steps":["trace[1877252792] 'agreement among raft nodes before linearized reading' (duration: 122.224494ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:55.609318Z","caller":"traceutil/trace.go:171","msg":"trace[437705399] linearizableReadLoop","detail":"{readStateIndex:1210; appliedIndex:1209; }","duration":"112.461942ms","start":"2026-09-18T02:24:55.496825Z","end":"2026-09-18T02:24:55.609287Z","steps":["trace[437705399] 'read index received' (duration: 112.244567ms)","trace[437705399] 'applied index is now lower than readState.Index' (duration: 216.105µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:24:55.609615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.770299ms","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-18T02:24:55.609515Z","caller":"traceutil/trace.go:171","msg":"trace[1788100760] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"120.273926ms","start":"2026-09-18T02:24:55.489191Z","end":"2026-09-18T02:24:55.609465Z","steps":["trace[1788100760] 'process raft request' (duration: 119.892277ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:55.609659Z","caller":"traceutil/trace.go:171","msg":"trace[353018839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1178; }","duration":"112.871082ms","start":"2026-09-18T02:24:55.496776Z","end":"2026-09-18T02:24:55.609647Z","steps":["trace[353018839] 'agreement among raft nodes before linearized reading' (duration: 112.679767ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:24:55.609757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.627338ms","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-18T02:24:55.609849Z","caller":"traceutil/trace.go:171","msg":"trace[1903559431] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1178; }","duration":"107.759142ms","start":"2026-09-18T02:24:55.502048Z","end":"2026-09-18T02:24:55.609807Z","steps":["trace[1903559431] 'agreement among raft nodes before linearized reading' (duration: 107.484905ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:03.804627Z","caller":"traceutil/trace.go:171","msg":"trace[1424871525] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1296; }","duration":"100.882137ms","start":"2026-09-18T02:25:03.703712Z","end":"2026-09-18T02:25:03.804595Z","steps":["trace[1424871525] 'read index received' (duration: 100.634712ms)","trace[1424871525] 'applied index is now lower than readState.Index' (duration: 246.425µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:03.80475Z","caller":"traceutil/trace.go:171","msg":"trace[755749686] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"143.508758ms","start":"2026-09-18T02:25:03.66121Z","end":"2026-09-18T02:25:03.804719Z","steps":["trace[755749686] 'process raft request' (duration: 143.215291ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:03.804881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.139483ms","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-18T02:25:03.804922Z","caller":"traceutil/trace.go:171","msg":"trace[313548461] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1258; }","duration":"101.241105ms","start":"2026-09-18T02:25:03.703669Z","end":"2026-09-18T02:25:03.80491Z","steps":["trace[313548461] 'agreement among raft nodes before linearized reading' (duration: 101.085712ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:09.780321Z","caller":"traceutil/trace.go:171","msg":"trace[423270959] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"122.334646ms","start":"2026-09-18T02:25:09.657962Z","end":"2026-09-18T02:25:09.780296Z","steps":["trace[423270959] 'process raft request' (duration: 80.869313ms)","trace[423270959] 'compare' (duration: 41.33654ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:09.999659Z","caller":"traceutil/trace.go:171","msg":"trace[1628047154] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"123.495511ms","start":"2026-09-18T02:25:09.876118Z","end":"2026-09-18T02:25:09.999613Z","steps":["trace[1628047154] 'process raft request' (duration: 95.982881ms)","trace[1628047154] 'compare' (duration: 27.145272ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:25:10.248432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.828278ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:25:10.248705Z","caller":"traceutil/trace.go:171","msg":"trace[1249195379] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"243.10827ms","start":"2026-09-18T02:25:10.005566Z","end":"2026-09-18T02:25:10.248674Z","steps":["trace[1249195379] 'process raft request' (duration: 128.941044ms)","trace[1249195379] 'compare' (duration: 113.638505ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:10.248765Z","caller":"traceutil/trace.go:171","msg":"trace[270214787] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"236.107474ms","start":"2026-09-18T02:25:10.012632Z","end":"2026-09-18T02:25:10.248739Z","steps":["trace[270214787] 'process raft request' (duration: 236.039963ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:10.248855Z","caller":"traceutil/trace.go:171","msg":"trace[2054705891] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"241.355223ms","start":"2026-09-18T02:25:10.007443Z","end":"2026-09-18T02:25:10.248798Z","steps":["trace[2054705891] 'process raft request' (duration: 241.151089ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:10.635605Z","caller":"traceutil/trace.go:171","msg":"trace[685461097] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"135.858ms","start":"2026-09-18T02:25:10.499714Z","end":"2026-09-18T02:25:10.635572Z","steps":["trace[685461097] 'process raft request' (duration: 44.630513ms)","trace[685461097] 'compare' (duration: 91.051523ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:10.872046Z","caller":"traceutil/trace.go:171","msg":"trace[535152358] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"205.448693ms","start":"2026-09-18T02:25:10.666562Z","end":"2026-09-18T02:25:10.87201Z","steps":["trace[535152358] 'process raft request' (duration: 180.155315ms)","trace[535152358] 'compare' (duration: 24.89263ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:10.872346Z","caller":"traceutil/trace.go:171","msg":"trace[1176607676] linearizableReadLoop","detail":"{readStateIndex:1342; appliedIndex:1340; }","duration":"141.289643ms","start":"2026-09-18T02:25:10.731028Z","end":"2026-09-18T02:25:10.872317Z","steps":["trace[1176607676] 'read index received' (duration: 115.748809ms)","trace[1176607676] 'applied index is now lower than readState.Index' (duration: 25.539254ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:10.872403Z","caller":"traceutil/trace.go:171","msg":"trace[1629911885] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"205.638888ms","start":"2026-09-18T02:25:10.666729Z","end":"2026-09-18T02:25:10.872368Z","steps":["trace[1629911885] 'process raft request' (duration: 205.204549ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:10.872686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.63651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-2dk5z\" ","response":"range_response_count:1 size:3276"} {"level":"info","ts":"2026-09-18T02:25:10.87275Z","caller":"traceutil/trace.go:171","msg":"trace[1221083806] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-create-2dk5z; range_end:; response_count:1; response_revision:1302; }","duration":"141.759773ms","start":"2026-09-18T02:25:10.730978Z","end":"2026-09-18T02:25:10.872738Z","steps":["trace[1221083806] 'agreement among raft nodes before linearized reading' (duration: 141.534568ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:10.875925Z","caller":"traceutil/trace.go:171","msg":"trace[1738649445] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"143.837676ms","start":"2026-09-18T02:25:10.73207Z","end":"2026-09-18T02:25:10.875907Z","steps":["trace[1738649445] 'process raft request' (duration: 143.485499ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:20.150945Z","caller":"traceutil/trace.go:171","msg":"trace[1609764169] linearizableReadLoop","detail":"{readStateIndex:1404; appliedIndex:1400; }","duration":"127.958447ms","start":"2026-09-18T02:25:20.022923Z","end":"2026-09-18T02:25:20.150881Z","steps":["trace[1609764169] 'read index received' (duration: 26.355632ms)","trace[1609764169] 'applied index is now lower than readState.Index' (duration: 101.601035ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:20.151011Z","caller":"traceutil/trace.go:171","msg":"trace[1313985139] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"154.952472ms","start":"2026-09-18T02:25:19.99604Z","end":"2026-09-18T02:25:20.150992Z","steps":["trace[1313985139] 'process raft request' (duration: 154.787099ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:20.151002Z","caller":"traceutil/trace.go:171","msg":"trace[1804593087] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"155.31471ms","start":"2026-09-18T02:25:19.995655Z","end":"2026-09-18T02:25:20.15097Z","steps":["trace[1804593087] 'process raft request' (duration: 154.853081ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:20.150938Z","caller":"traceutil/trace.go:171","msg":"trace[241311496] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"155.080454ms","start":"2026-09-18T02:25:19.99583Z","end":"2026-09-18T02:25:20.150911Z","steps":["trace[241311496] 'process raft request' (duration: 154.933251ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:20.151289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.295823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T02:25:20.151346Z","caller":"traceutil/trace.go:171","msg":"trace[2096026657] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1362; }","duration":"128.488007ms","start":"2026-09-18T02:25:20.02284Z","end":"2026-09-18T02:25:20.151328Z","steps":["trace[2096026657] 'agreement among raft nodes before linearized reading' (duration: 128.190992ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:20.512718Z","caller":"traceutil/trace.go:171","msg":"trace[516308484] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"137.548742ms","start":"2026-09-18T02:25:20.375131Z","end":"2026-09-18T02:25:20.51268Z","steps":["trace[516308484] 'process raft request' (duration: 62.431743ms)","trace[516308484] 'compare' (duration: 74.958106ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:20.513285Z","caller":"traceutil/trace.go:171","msg":"trace[343030379] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"134.102926ms","start":"2026-09-18T02:25:20.379168Z","end":"2026-09-18T02:25:20.513271Z","steps":["trace[343030379] 'process raft request' (duration: 133.599276ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:20.513299Z","caller":"traceutil/trace.go:171","msg":"trace[56557328] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"134.027944ms","start":"2026-09-18T02:25:20.379208Z","end":"2026-09-18T02:25:20.513236Z","steps":["trace[56557328] 'process raft request' (duration: 133.908682ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:20.810606Z","caller":"traceutil/trace.go:171","msg":"trace[209707717] linearizableReadLoop","detail":"{readStateIndex:1442; appliedIndex:1438; }","duration":"104.374179ms","start":"2026-09-18T02:25:20.706206Z","end":"2026-09-18T02:25:20.81058Z","steps":["trace[209707717] 'read index received' (duration: 53.674463ms)","trace[209707717] 'applied index is now lower than readState.Index' (duration: 50.698536ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:20.810755Z","caller":"traceutil/trace.go:171","msg":"trace[1999433470] transaction","detail":"{read_only:false; response_revision:1397; number_of_response:1; }","duration":"156.386329ms","start":"2026-09-18T02:25:20.654357Z","end":"2026-09-18T02:25:20.810744Z","steps":["trace[1999433470] 'process raft request' (duration: 105.52567ms)","trace[1999433470] 'compare' (duration: 50.296838ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:20.811094Z","caller":"traceutil/trace.go:171","msg":"trace[1529491126] transaction","detail":"{read_only:false; response_revision:1399; number_of_response:1; }","duration":"154.442071ms","start":"2026-09-18T02:25:20.656565Z","end":"2026-09-18T02:25:20.811007Z","steps":["trace[1529491126] 'process raft request' (duration: 153.911721ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:20.811113Z","caller":"traceutil/trace.go:171","msg":"trace[534723797] transaction","detail":"{read_only:false; response_revision:1400; number_of_response:1; }","duration":"111.054429ms","start":"2026-09-18T02:25:20.700037Z","end":"2026-09-18T02:25:20.811091Z","steps":["trace[534723797] 'process raft request' (duration: 110.510058ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:20.811113Z","caller":"traceutil/trace.go:171","msg":"trace[1395884306] transaction","detail":"{read_only:false; response_revision:1398; number_of_response:1; }","duration":"155.088404ms","start":"2026-09-18T02:25:20.655967Z","end":"2026-09-18T02:25:20.811055Z","steps":["trace[1395884306] 'process raft request' (duration: 154.432041ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:20.811229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.998861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-controller-9xkx5\" ","response":"range_response_count:1 size:6053"} {"level":"info","ts":"2026-09-18T02:25:20.811296Z","caller":"traceutil/trace.go:171","msg":"trace[1993602258] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-controller-9xkx5; range_end:; response_count:1; response_revision:1400; }","duration":"105.127943ms","start":"2026-09-18T02:25:20.706148Z","end":"2026-09-18T02:25:20.811276Z","steps":["trace[1993602258] 'agreement among raft nodes before linearized reading' (duration: 104.869628ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:20.811593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.607485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/ingress-nginx/ingress-nginx-admission\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:25:20.811767Z","caller":"traceutil/trace.go:171","msg":"trace[1358263894] range","detail":"{range_begin:/registry/serviceaccounts/ingress-nginx/ingress-nginx-admission; range_end:; response_count:0; response_revision:1400; }","duration":"100.828649ms","start":"2026-09-18T02:25:20.710873Z","end":"2026-09-18T02:25:20.811702Z","steps":["trace[1358263894] 'agreement among raft nodes before linearized reading' (duration: 100.596585ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:21.028063Z","caller":"traceutil/trace.go:171","msg":"trace[2102407597] transaction","detail":"{read_only:false; response_revision:1408; number_of_response:1; }","duration":"156.024777ms","start":"2026-09-18T02:25:20.872011Z","end":"2026-09-18T02:25:21.028036Z","steps":["trace[2102407597] 'process raft request' (duration: 155.937216ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:21.028125Z","caller":"traceutil/trace.go:171","msg":"trace[289407982] transaction","detail":"{read_only:false; response_revision:1407; number_of_response:1; }","duration":"157.981495ms","start":"2026-09-18T02:25:20.870087Z","end":"2026-09-18T02:25:21.028069Z","steps":["trace[289407982] 'process raft request' (duration: 157.660619ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:21.028767Z","caller":"traceutil/trace.go:171","msg":"trace[596880883] transaction","detail":"{read_only:false; response_revision:1409; number_of_response:1; }","duration":"156.659099ms","start":"2026-09-18T02:25:20.872079Z","end":"2026-09-18T02:25:21.028738Z","steps":["trace[596880883] 'process raft request' (duration: 155.921115ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:21.029192Z","caller":"traceutil/trace.go:171","msg":"trace[1657439071] transaction","detail":"{read_only:false; response_revision:1410; number_of_response:1; }","duration":"156.968675ms","start":"2026-09-18T02:25:20.872201Z","end":"2026-09-18T02:25:21.02917Z","steps":["trace[1657439071] 'process raft request' (duration: 156.525477ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:21.029253Z","caller":"traceutil/trace.go:171","msg":"trace[134701978] transaction","detail":"{read_only:false; response_revision:1411; number_of_response:1; }","duration":"156.925515ms","start":"2026-09-18T02:25:20.872317Z","end":"2026-09-18T02:25:21.029243Z","steps":["trace[134701978] 'process raft request' (duration: 156.539777ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:21.029507Z","caller":"traceutil/trace.go:171","msg":"trace[1036405362] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"156.908204ms","start":"2026-09-18T02:25:20.87259Z","end":"2026-09-18T02:25:21.029499Z","steps":["trace[1036405362] 'process raft request' (duration: 156.549287ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:21.029987Z","caller":"traceutil/trace.go:171","msg":"trace[96608567] transaction","detail":"{read_only:false; response_revision:1413; number_of_response:1; }","duration":"157.119228ms","start":"2026-09-18T02:25:20.87286Z","end":"2026-09-18T02:25:21.029979Z","steps":["trace[96608567] 'process raft request' (duration: 156.351213ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:21.030302Z","caller":"traceutil/trace.go:171","msg":"trace[1369369838] linearizableReadLoop","detail":"{readStateIndex:1456; appliedIndex:1448; }","duration":"129.796027ms","start":"2026-09-18T02:25:20.900482Z","end":"2026-09-18T02:25:21.030278Z","steps":["trace[1369369838] 'read index received' (duration: 127.337849ms)","trace[1369369838] 'applied index is now lower than readState.Index' (duration: 2.456948ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:21.030576Z","caller":"traceutil/trace.go:171","msg":"trace[1581152282] transaction","detail":"{read_only:false; response_revision:1414; number_of_response:1; }","duration":"156.72172ms","start":"2026-09-18T02:25:20.873838Z","end":"2026-09-18T02:25:21.03056Z","steps":["trace[1581152282] 'process raft request' (duration: 155.408795ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:21.030861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.990656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/ingress-nginx/ingress-nginx-defaultbackend\" ","response":"range_response_count:1 size:4431"} {"level":"info","ts":"2026-09-18T02:25:21.030935Z","caller":"traceutil/trace.go:171","msg":"trace[2077385026] range","detail":"{range_begin:/registry/deployments/ingress-nginx/ingress-nginx-defaultbackend; range_end:; response_count:1; response_revision:1414; }","duration":"156.072798ms","start":"2026-09-18T02:25:20.874834Z","end":"2026-09-18T02:25:21.030906Z","steps":["trace[2077385026] 'agreement among raft nodes before linearized reading' (duration: 155.855254ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:21.089257Z","caller":"traceutil/trace.go:171","msg":"trace[1117220542] transaction","detail":"{read_only:false; response_revision:1415; number_of_response:1; }","duration":"181.747668ms","start":"2026-09-18T02:25:20.907485Z","end":"2026-09-18T02:25:21.089232Z","steps":["trace[1117220542] 'process raft request' (duration: 181.450982ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:21.089603Z","caller":"traceutil/trace.go:171","msg":"trace[399811216] transaction","detail":"{read_only:false; response_revision:1416; number_of_response:1; }","duration":"158.961516ms","start":"2026-09-18T02:25:20.930578Z","end":"2026-09-18T02:25:21.089539Z","steps":["trace[399811216] 'process raft request' (duration: 158.555508ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:21.484944Z","caller":"traceutil/trace.go:171","msg":"trace[1854833954] transaction","detail":"{read_only:false; response_revision:1423; number_of_response:1; }","duration":"114.588952ms","start":"2026-09-18T02:25:21.370312Z","end":"2026-09-18T02:25:21.484901Z","steps":["trace[1854833954] 'process raft request' (duration: 47.866684ms)","trace[1854833954] 'compare' (duration: 66.505364ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:21.674202Z","caller":"traceutil/trace.go:171","msg":"trace[1011738369] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"118.11866ms","start":"2026-09-18T02:25:21.556045Z","end":"2026-09-18T02:25:21.674164Z","steps":["trace[1011738369] 'process raft request' (duration: 86.626312ms)","trace[1011738369] 'compare' (duration: 31.333374ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:21.907174Z","caller":"traceutil/trace.go:171","msg":"trace[1412752715] transaction","detail":"{read_only:false; response_revision:1428; number_of_response:1; }","duration":"148.773961ms","start":"2026-09-18T02:25:21.758356Z","end":"2026-09-18T02:25:21.90713Z","steps":["trace[1412752715] 'process raft request' (duration: 133.006377ms)","trace[1412752715] 'compare' (duration: 15.54975ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:25:22.158013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.69016ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:25:22.15815Z","caller":"traceutil/trace.go:171","msg":"trace[356471828] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"173.699052ms","start":"2026-09-18T02:25:21.984435Z","end":"2026-09-18T02:25:22.158134Z","steps":["trace[356471828] 'process raft request' (duration: 72.819718ms)","trace[356471828] 'compare' (duration: 100.483196ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:22.167959Z","caller":"traceutil/trace.go:171","msg":"trace[1541239829] transaction","detail":"{read_only:false; response_revision:1431; number_of_response:1; }","duration":"175.816262ms","start":"2026-09-18T02:25:21.992115Z","end":"2026-09-18T02:25:22.167931Z","steps":["trace[1541239829] 'process raft request' (duration: 175.654228ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:22.411848Z","caller":"traceutil/trace.go:171","msg":"trace[863893808] transaction","detail":"{read_only:false; response_revision:1434; number_of_response:1; }","duration":"126.380612ms","start":"2026-09-18T02:25:22.284883Z","end":"2026-09-18T02:25:22.411263Z","steps":["trace[863893808] 'process raft request' (duration: 126.133137ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:22.692915Z","caller":"traceutil/trace.go:171","msg":"trace[112528149] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"125.556207ms","start":"2026-09-18T02:25:22.567325Z","end":"2026-09-18T02:25:22.692881Z","steps":["trace[112528149] 'process raft request' (duration: 102.421283ms)","trace[112528149] 'compare' (duration: 22.836368ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:22.692965Z","caller":"traceutil/trace.go:171","msg":"trace[296161839] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"124.467256ms","start":"2026-09-18T02:25:22.568476Z","end":"2026-09-18T02:25:22.692943Z","steps":["trace[296161839] 'process raft request' (duration: 124.229021ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:23.37778Z","caller":"traceutil/trace.go:171","msg":"trace[868162476] linearizableReadLoop","detail":"{readStateIndex:1493; appliedIndex:1491; }","duration":"117.371044ms","start":"2026-09-18T02:25:23.26038Z","end":"2026-09-18T02:25:23.377751Z","steps":["trace[868162476] 'read index received' (duration: 16.902091ms)","trace[868162476] 'applied index is now lower than readState.Index' (duration: 100.467903ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:23.377947Z","caller":"traceutil/trace.go:171","msg":"trace[1694511983] transaction","detail":"{read_only:false; response_revision:1449; number_of_response:1; }","duration":"169.785542ms","start":"2026-09-18T02:25:23.20815Z","end":"2026-09-18T02:25:23.377935Z","steps":["trace[1694511983] 'process raft request' (duration: 169.361304ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:23.378083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.68225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T02:25:23.378153Z","caller":"traceutil/trace.go:171","msg":"trace[1638235997] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1450; }","duration":"117.770011ms","start":"2026-09-18T02:25:23.260373Z","end":"2026-09-18T02:25:23.378143Z","steps":["trace[1638235997] 'agreement among raft nodes before linearized reading' (duration: 117.624989ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:23.378434Z","caller":"traceutil/trace.go:171","msg":"trace[250013509] transaction","detail":"{read_only:false; response_revision:1450; number_of_response:1; }","duration":"165.147264ms","start":"2026-09-18T02:25:23.213277Z","end":"2026-09-18T02:25:23.378425Z","steps":["trace[250013509] 'process raft request' (duration: 164.400069ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:25.476301Z","caller":"traceutil/trace.go:171","msg":"trace[135078392] linearizableReadLoop","detail":"{readStateIndex:1498; appliedIndex:1497; }","duration":"195.107154ms","start":"2026-09-18T02:25:25.281158Z","end":"2026-09-18T02:25:25.476265Z","steps":["trace[135078392] 'read index received' (duration: 195.043473ms)","trace[135078392] 'applied index is now lower than readState.Index' (duration: 62.571µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:25.476484Z","caller":"traceutil/trace.go:171","msg":"trace[1656890176] transaction","detail":"{read_only:false; response_revision:1455; number_of_response:1; }","duration":"285.200736ms","start":"2026-09-18T02:25:25.191238Z","end":"2026-09-18T02:25:25.476438Z","steps":["trace[1656890176] 'process raft request' (duration: 284.89437ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:25.476578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.38788ms","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-18T02:25:25.476632Z","caller":"traceutil/trace.go:171","msg":"trace[745250239] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1455; }","duration":"195.515252ms","start":"2026-09-18T02:25:25.281103Z","end":"2026-09-18T02:25:25.476619Z","steps":["trace[745250239] 'agreement among raft nodes before linearized reading' (duration: 195.333378ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:25.512291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.947241ms","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-18T02:25:25.512396Z","caller":"traceutil/trace.go:171","msg":"trace[1179367513] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1456; }","duration":"130.076353ms","start":"2026-09-18T02:25:25.382282Z","end":"2026-09-18T02:25:25.512359Z","steps":["trace[1179367513] 'agreement among raft nodes before linearized reading' (duration: 129.860629ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:55.315382Z","caller":"traceutil/trace.go:171","msg":"trace[601027476] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"315.060884ms","start":"2026-09-18T02:25:55.000292Z","end":"2026-09-18T02:25:55.315353Z","steps":["trace[601027476] 'process raft request' (duration: 314.930822ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:55.315549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:55.000267Z","time spent":"315.205206ms","remote":"127.0.0.1:35188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:25:55.560868Z","caller":"traceutil/trace.go:171","msg":"trace[362915915] linearizableReadLoop","detail":"{readStateIndex:1968; appliedIndex:1966; }","duration":"163.712205ms","start":"2026-09-18T02:25:55.397123Z","end":"2026-09-18T02:25:55.560835Z","steps":["trace[362915915] 'read index received' (duration: 151.326839ms)","trace[362915915] 'applied index is now lower than readState.Index' (duration: 12.383726ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:55.560908Z","caller":"traceutil/trace.go:171","msg":"trace[1647423120] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"354.952383ms","start":"2026-09-18T02:25:55.205927Z","end":"2026-09-18T02:25:55.560879Z","steps":["trace[1647423120] 'process raft request' (duration: 354.828341ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:55.56095Z","caller":"traceutil/trace.go:171","msg":"trace[969947569] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"555.293986ms","start":"2026-09-18T02:25:55.00561Z","end":"2026-09-18T02:25:55.560904Z","steps":["trace[969947569] 'process raft request' (duration: 542.9042ms)","trace[969947569] 'compare' (duration: 12.063261ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:25:55.561075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:55.205892Z","time spent":"355.095516ms","remote":"127.0.0.1:35188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:25:55.56107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.926058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-466f4dfc-3795-4c39-9dd1-8d80cf359140\" ","response":"range_response_count:1 size:3745"} {"level":"info","ts":"2026-09-18T02:25:55.561165Z","caller":"traceutil/trace.go:171","msg":"trace[989785603] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-466f4dfc-3795-4c39-9dd1-8d80cf359140; range_end:; response_count:1; response_revision:1898; }","duration":"164.095931ms","start":"2026-09-18T02:25:55.397055Z","end":"2026-09-18T02:25:55.561151Z","steps":["trace[989785603] 'agreement among raft nodes before linearized reading' (duration: 163.956079ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:55.561177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:55.005582Z","time spent":"555.458249ms","remote":"127.0.0.1:35116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3730,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:25:55.943954Z","caller":"traceutil/trace.go:171","msg":"trace[837901325] linearizableReadLoop","detail":"{readStateIndex:1970; appliedIndex:1969; }","duration":"170.44038ms","start":"2026-09-18T02:25:55.773466Z","end":"2026-09-18T02:25:55.943907Z","steps":["trace[837901325] 'read index received' (duration: 108.3385ms)","trace[837901325] 'applied index is now lower than readState.Index' (duration: 62.10069ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:25:55.944318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.346101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-18T02:25:55.944395Z","caller":"traceutil/trace.go:171","msg":"trace[1126255805] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1900; }","duration":"141.475664ms","start":"2026-09-18T02:25:55.802906Z","end":"2026-09-18T02:25:55.944382Z","steps":["trace[1126255805] 'agreement among raft nodes before linearized reading' (duration: 141.20855ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:55.944457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.97338ms","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-18T02:25:55.94455Z","caller":"traceutil/trace.go:171","msg":"trace[1913841389] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1900; }","duration":"171.116891ms","start":"2026-09-18T02:25:55.773414Z","end":"2026-09-18T02:25:55.944531Z","steps":["trace[1913841389] 'agreement among raft nodes before linearized reading' (duration: 170.638664ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:55.944846Z","caller":"traceutil/trace.go:171","msg":"trace[951839790] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"240.06631ms","start":"2026-09-18T02:25:55.703937Z","end":"2026-09-18T02:25:55.944004Z","steps":["trace[951839790] 'process raft request' (duration: 177.99057ms)","trace[951839790] 'compare' (duration: 61.603972ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:26:08.872118Z","caller":"traceutil/trace.go:171","msg":"trace[1323830708] linearizableReadLoop","detail":"{readStateIndex:2081; appliedIndex:2080; }","duration":"108.956991ms","start":"2026-09-18T02:26:08.763134Z","end":"2026-09-18T02:26:08.872091Z","steps":["trace[1323830708] 'read index received' (duration: 108.694917ms)","trace[1323830708] 'applied index is now lower than readState.Index' (duration: 261.124µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:26:08.872232Z","caller":"traceutil/trace.go:171","msg":"trace[172502304] transaction","detail":"{read_only:false; response_revision:2007; number_of_response:1; }","duration":"172.84622ms","start":"2026-09-18T02:26:08.69936Z","end":"2026-09-18T02:26:08.872206Z","steps":["trace[172502304] 'process raft request' (duration: 172.529646ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:26:08.872445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.288725ms","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-18T02:26:08.872525Z","caller":"traceutil/trace.go:171","msg":"trace[20612797] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2007; }","duration":"109.417297ms","start":"2026-09-18T02:26:08.763093Z","end":"2026-09-18T02:26:08.87251Z","steps":["trace[20612797] 'agreement among raft nodes before linearized reading' (duration: 109.201954ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:26:12.527447Z","caller":"traceutil/trace.go:171","msg":"trace[249921052] linearizableReadLoop","detail":"{readStateIndex:2111; appliedIndex:2110; }","duration":"448.202004ms","start":"2026-09-18T02:26:12.079219Z","end":"2026-09-18T02:26:12.527421Z","steps":["trace[249921052] 'read index received' (duration: 447.975871ms)","trace[249921052] 'applied index is now lower than readState.Index' (duration: 225.143µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:26:12.527622Z","caller":"traceutil/trace.go:171","msg":"trace[2077883935] transaction","detail":"{read_only:false; response_revision:2036; number_of_response:1; }","duration":"449.36205ms","start":"2026-09-18T02:26:12.078209Z","end":"2026-09-18T02:26:12.527571Z","steps":["trace[2077883935] 'process raft request' (duration: 449.045806ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:26:12.527839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:26:12.078196Z","time spent":"449.537444ms","remote":"127.0.0.1:35188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:26:12.527967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.813616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-18T02:26:12.528089Z","caller":"traceutil/trace.go:171","msg":"trace[820959828] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2036; }","duration":"399.979369ms","start":"2026-09-18T02:26:12.128082Z","end":"2026-09-18T02:26:12.528061Z","steps":["trace[820959828] 'agreement among raft nodes before linearized reading' (duration: 399.605683ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:26:12.52805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.423837ms","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":"warn","ts":"2026-09-18T02:26:12.528145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:26:12.128068Z","time spent":"400.06701ms","remote":"127.0.0.1:58790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-09-18T02:26:12.528148Z","caller":"traceutil/trace.go:171","msg":"trace[1745218412] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2036; }","duration":"448.930545ms","start":"2026-09-18T02:26:12.079202Z","end":"2026-09-18T02:26:12.528132Z","steps":["trace[1745218412] 'agreement among raft nodes before linearized reading' (duration: 448.352276ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:26:12.52822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:26:12.079195Z","time spent":"448.985585ms","remote":"127.0.0.1:35188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-18T02:26:35.207961Z","caller":"traceutil/trace.go:171","msg":"trace[1576638805] linearizableReadLoop","detail":"{readStateIndex:2245; appliedIndex:2244; }","duration":"101.73597ms","start":"2026-09-18T02:26:35.106193Z","end":"2026-09-18T02:26:35.207929Z","steps":["trace[1576638805] 'read index received' (duration: 101.476667ms)","trace[1576638805] 'applied index is now lower than readState.Index' (duration: 258.233µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:26:35.208127Z","caller":"traceutil/trace.go:171","msg":"trace[2068249255] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"143.365871ms","start":"2026-09-18T02:26:35.064703Z","end":"2026-09-18T02:26:35.208069Z","steps":["trace[2068249255] 'process raft request' (duration: 142.988866ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:26:35.208457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.214207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-18T02:26:35.208651Z","caller":"traceutil/trace.go:171","msg":"trace[1157297853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2165; }","duration":"102.39457ms","start":"2026-09-18T02:26:35.106155Z","end":"2026-09-18T02:26:35.20855Z","steps":["trace[1157297853] 'agreement among raft nodes before linearized reading' (duration: 101.948034ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:26:35.406889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.381164ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:26:35.407082Z","caller":"traceutil/trace.go:171","msg":"trace[798687775] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"193.174382ms","start":"2026-09-18T02:26:35.213886Z","end":"2026-09-18T02:26:35.407061Z","steps":["trace[798687775] 'process raft request' (duration: 77.278651ms)","trace[798687775] 'compare' (duration: 115.293593ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:26:35.691935Z","caller":"traceutil/trace.go:171","msg":"trace[211515993] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"213.380554ms","start":"2026-09-18T02:26:35.478525Z","end":"2026-09-18T02:26:35.691906Z","steps":["trace[211515993] 'process raft request' (duration: 168.050684ms)","trace[211515993] 'compare' (duration: 45.100167ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:26:36.115278Z","caller":"traceutil/trace.go:171","msg":"trace[207914204] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"266.925251ms","start":"2026-09-18T02:26:35.848325Z","end":"2026-09-18T02:26:36.11525Z","steps":["trace[207914204] 'process raft request' (duration: 266.770809ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:26:36.307165Z","caller":"traceutil/trace.go:171","msg":"trace[1042143960] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"373.66734ms","start":"2026-09-18T02:26:35.933469Z","end":"2026-09-18T02:26:36.307136Z","steps":["trace[1042143960] 'process raft request' (duration: 278.804616ms)","trace[1042143960] 'compare' (duration: 94.626641ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:26:36.30738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:26:35.933444Z","time spent":"373.796232ms","remote":"127.0.0.1:35188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:26:36.3078Z","caller":"traceutil/trace.go:171","msg":"trace[490830939] linearizableReadLoop","detail":"{readStateIndex:2250; appliedIndex:2248; }","duration":"131.953713ms","start":"2026-09-18T02:26:36.175819Z","end":"2026-09-18T02:26:36.307772Z","steps":["trace[490830939] 'read index received' (duration: 36.508691ms)","trace[490830939] 'applied index is now lower than readState.Index' (duration: 95.357651ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:26:36.307836Z","caller":"traceutil/trace.go:171","msg":"trace[880501022] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"191.917266ms","start":"2026-09-18T02:26:36.115895Z","end":"2026-09-18T02:26:36.307813Z","steps":["trace[880501022] 'process raft request' (duration: 191.163746ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:26:36.307916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.079004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:26:36.307941Z","caller":"traceutil/trace.go:171","msg":"trace[999250024] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:2170; }","duration":"132.159705ms","start":"2026-09-18T02:26:36.175771Z","end":"2026-09-18T02:26:36.307931Z","steps":["trace[999250024] 'agreement among raft nodes before linearized reading' (duration: 132.087924ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:26:36.727033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.662764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T02:26:36.727238Z","caller":"traceutil/trace.go:171","msg":"trace[7724503] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:2170; }","duration":"296.929438ms","start":"2026-09-18T02:26:36.430285Z","end":"2026-09-18T02:26:36.727214Z","steps":["trace[7724503] 'count revisions from in-memory index tree' (duration: 296.557343ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:26:37.009317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.967338ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-18T02:26:37.009436Z","caller":"traceutil/trace.go:171","msg":"trace[1770581928] linearizableReadLoop","detail":"{readStateIndex:2251; appliedIndex:2250; }","duration":"299.690734ms","start":"2026-09-18T02:26:36.709722Z","end":"2026-09-18T02:26:37.009413Z","steps":["trace[1770581928] 'read index received' (duration: 69.607775ms)","trace[1770581928] 'applied index is now lower than readState.Index' (duration: 230.080849ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:26:37.009672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.492194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:26:37.009708Z","caller":"traceutil/trace.go:171","msg":"trace[58106444] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2170; }","duration":"157.565216ms","start":"2026-09-18T02:26:36.852133Z","end":"2026-09-18T02:26:37.009698Z","steps":["trace[58106444] 'agreement among raft nodes before linearized reading' (duration: 157.433734ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:26:37.009736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.780051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-18T02:26:37.009787Z","caller":"traceutil/trace.go:171","msg":"trace[1917393534] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2170; }","duration":"289.844142ms","start":"2026-09-18T02:26:36.719912Z","end":"2026-09-18T02:26:37.009756Z","steps":["trace[1917393534] 'agreement among raft nodes before linearized reading' (duration: 289.628789ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:26:37.009672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.950357ms","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-18T02:26:37.009932Z","caller":"traceutil/trace.go:171","msg":"trace[1479623940] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2170; }","duration":"300.239452ms","start":"2026-09-18T02:26:36.70967Z","end":"2026-09-18T02:26:37.00991Z","steps":["trace[1479623940] 'agreement among raft nodes before linearized reading' (duration: 299.856407ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:26:37.009999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:26:36.709651Z","time spent":"300.329053ms","remote":"127.0.0.1:35188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-18T02:26:37.010503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.939178ms","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-18T02:26:37.010551Z","caller":"traceutil/trace.go:171","msg":"trace[1023626274] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2170; }","duration":"230.034119ms","start":"2026-09-18T02:26:36.780505Z","end":"2026-09-18T02:26:37.010539Z","steps":["trace[1023626274] 'agreement among raft nodes before linearized reading' (duration: 229.895747ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:26:37.010699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.996325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-18T02:26:37.010776Z","caller":"traceutil/trace.go:171","msg":"trace[2091951036] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2170; }","duration":"226.197947ms","start":"2026-09-18T02:26:36.784561Z","end":"2026-09-18T02:26:37.010759Z","steps":["trace[2091951036] 'agreement among raft nodes before linearized reading' (duration: 225.269455ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:26:37.310229Z","caller":"traceutil/trace.go:171","msg":"trace[2013950992] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"294.896808ms","start":"2026-09-18T02:26:37.015308Z","end":"2026-09-18T02:26:37.310204Z","steps":["trace[2013950992] 'process raft request' (duration: 294.658735ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:26:37.491321Z","caller":"traceutil/trace.go:171","msg":"trace[1250019383] linearizableReadLoop","detail":"{readStateIndex:2254; appliedIndex:2252; }","duration":"278.121474ms","start":"2026-09-18T02:26:37.213183Z","end":"2026-09-18T02:26:37.491305Z","steps":["trace[1250019383] 'read index received' (duration: 97.453805ms)","trace[1250019383] 'applied index is now lower than readState.Index' (duration: 180.667019ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:26:37.491407Z","caller":"traceutil/trace.go:171","msg":"trace[1823136028] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"475.942442ms","start":"2026-09-18T02:26:37.01542Z","end":"2026-09-18T02:26:37.491362Z","steps":["trace[1823136028] 'process raft request' (duration: 475.727969ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:26:37.491429Z","caller":"traceutil/trace.go:171","msg":"trace[939696394] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"475.025049ms","start":"2026-09-18T02:26:37.016368Z","end":"2026-09-18T02:26:37.491393Z","steps":["trace[939696394] 'process raft request' (duration: 474.910018ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:26:37.491644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:26:37.015384Z","time spent":"476.130595ms","remote":"127.0.0.1:35188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:26:37.491748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:26:37.016336Z","time spent":"475.317084ms","remote":"127.0.0.1:35188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:26:37.491472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.283266ms","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-18T02:26:37.491883Z","caller":"traceutil/trace.go:171","msg":"trace[62329072] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2173; }","duration":"278.748832ms","start":"2026-09-18T02:26:37.213127Z","end":"2026-09-18T02:26:37.491876Z","steps":["trace[62329072] 'agreement among raft nodes before linearized reading' (duration: 278.258005ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:26:37.732286Z","caller":"traceutil/trace.go:171","msg":"trace[382083517] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"237.213746ms","start":"2026-09-18T02:26:37.495025Z","end":"2026-09-18T02:26:37.732239Z","steps":["trace[382083517] 'process raft request' (duration: 226.31471ms)","trace[382083517] 'compare' (duration: 10.806734ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:26:37.815984Z","caller":"traceutil/trace.go:171","msg":"trace[1167356622] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"320.747465ms","start":"2026-09-18T02:26:37.495209Z","end":"2026-09-18T02:26:37.815956Z","steps":["trace[1167356622] 'process raft request' (duration: 320.548142ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:26:37.816039Z","caller":"traceutil/trace.go:171","msg":"trace[1946975389] linearizableReadLoop","detail":"{readStateIndex:2256; appliedIndex:2254; }","duration":"232.822288ms","start":"2026-09-18T02:26:37.583203Z","end":"2026-09-18T02:26:37.816025Z","steps":["trace[1946975389] 'read index received' (duration: 138.115889ms)","trace[1946975389] 'applied index is now lower than readState.Index' (duration: 94.705309ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:26:37.816092Z","caller":"traceutil/trace.go:171","msg":"trace[769507553] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"118.976994ms","start":"2026-09-18T02:26:37.697109Z","end":"2026-09-18T02:26:37.816086Z","steps":["trace[769507553] 'process raft request' (duration: 118.802291ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:26:37.816146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:26:37.495183Z","time spent":"320.880416ms","remote":"127.0.0.1:35188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:26:37.816194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.127353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T02:26:37.816244Z","caller":"traceutil/trace.go:171","msg":"trace[1938070750] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:2176; }","duration":"142.217045ms","start":"2026-09-18T02:26:37.674015Z","end":"2026-09-18T02:26:37.816232Z","steps":["trace[1938070750] 'agreement among raft nodes before linearized reading' (duration: 142.136593ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:26:37.816279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.082581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18d649325cf16310\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-09-18T02:26:37.816297Z","caller":"traceutil/trace.go:171","msg":"trace[1380303407] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18d649325cf16310; range_end:; response_count:1; response_revision:2176; }","duration":"233.144192ms","start":"2026-09-18T02:26:37.583146Z","end":"2026-09-18T02:26:37.816291Z","steps":["trace[1380303407] 'agreement among raft nodes before linearized reading' (duration: 233.067841ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:28:42.219068Z","caller":"traceutil/trace.go:171","msg":"trace[1351790356] transaction","detail":"{read_only:false; response_revision:2944; number_of_response:1; }","duration":"101.281993ms","start":"2026-09-18T02:28:42.117737Z","end":"2026-09-18T02:28:42.219019Z","steps":["trace[1351790356] 'process raft request' (duration: 101.047243ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:28:42.50894Z","caller":"traceutil/trace.go:171","msg":"trace[1384548358] transaction","detail":"{read_only:false; response_revision:2945; number_of_response:1; }","duration":"283.494209ms","start":"2026-09-18T02:28:42.225406Z","end":"2026-09-18T02:28:42.5089Z","steps":["trace[1384548358] 'process raft request' (duration: 283.233688ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:28:42.509623Z","caller":"traceutil/trace.go:171","msg":"trace[1109289438] linearizableReadLoop","detail":"{readStateIndex:3054; appliedIndex:3052; }","duration":"157.843555ms","start":"2026-09-18T02:28:42.351754Z","end":"2026-09-18T02:28:42.509598Z","steps":["trace[1109289438] 'read index received' (duration: 156.907195ms)","trace[1109289438] 'applied index is now lower than readState.Index' (duration: 935.49µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:28:42.509724Z","caller":"traceutil/trace.go:171","msg":"trace[1364841694] transaction","detail":"{read_only:false; response_revision:2946; number_of_response:1; }","duration":"196.957903ms","start":"2026-09-18T02:28:42.312718Z","end":"2026-09-18T02:28:42.509676Z","steps":["trace[1364841694] 'process raft request' (duration: 196.771955ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:28:42.510052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.329159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-09-18T02:28:42.510165Z","caller":"traceutil/trace.go:171","msg":"trace[732302619] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2946; }","duration":"156.56265ms","start":"2026-09-18T02:28:42.353587Z","end":"2026-09-18T02:28:42.510149Z","steps":["trace[732302619] 'agreement among raft nodes before linearized reading' (duration: 156.147192ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:28:42.510064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.279694ms","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-18T02:28:42.510318Z","caller":"traceutil/trace.go:171","msg":"trace[1662568474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2946; }","duration":"158.575926ms","start":"2026-09-18T02:28:42.351722Z","end":"2026-09-18T02:28:42.510298Z","steps":["trace[1662568474] 'agreement among raft nodes before linearized reading' (duration: 157.988081ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:32:53.059261Z","caller":"traceutil/trace.go:171","msg":"trace[154651911] transaction","detail":"{read_only:false; response_revision:4795; number_of_response:1; }","duration":"172.841797ms","start":"2026-09-18T02:32:52.886389Z","end":"2026-09-18T02:32:53.059231Z","steps":["trace[154651911] 'process raft request' (duration: 80.425014ms)","trace[154651911] 'compare' (duration: 92.28479ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:32:57.581558Z","caller":"traceutil/trace.go:171","msg":"trace[525237688] transaction","detail":"{read_only:false; response_revision:4919; number_of_response:1; }","duration":"133.921771ms","start":"2026-09-18T02:32:57.447613Z","end":"2026-09-18T02:32:57.581535Z","steps":["trace[525237688] 'process raft request' (duration: 133.355451ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:32:59.747974Z","caller":"traceutil/trace.go:171","msg":"trace[1921758111] transaction","detail":"{read_only:false; response_revision:4977; number_of_response:1; }","duration":"160.448257ms","start":"2026-09-18T02:32:59.587496Z","end":"2026-09-18T02:32:59.747945Z","steps":["trace[1921758111] 'process raft request' (duration: 74.76559ms)","trace[1921758111] 'compare' (duration: 85.545035ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:33:05.123816Z","caller":"traceutil/trace.go:171","msg":"trace[807501060] transaction","detail":"{read_only:false; response_revision:5041; number_of_response:1; }","duration":"163.990508ms","start":"2026-09-18T02:33:04.959797Z","end":"2026-09-18T02:33:05.123788Z","steps":["trace[807501060] 'process raft request' (duration: 163.738763ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:33:05.353205Z","caller":"traceutil/trace.go:171","msg":"trace[651078096] linearizableReadLoop","detail":"{readStateIndex:5237; appliedIndex:5235; }","duration":"335.730839ms","start":"2026-09-18T02:33:05.017442Z","end":"2026-09-18T02:33:05.353173Z","steps":["trace[651078096] 'read index received' (duration: 106.108107ms)","trace[651078096] 'applied index is now lower than readState.Index' (duration: 229.621792ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:33:05.353554Z","caller":"traceutil/trace.go:171","msg":"trace[254569485] transaction","detail":"{read_only:false; response_revision:5042; number_of_response:1; }","duration":"384.034569ms","start":"2026-09-18T02:33:04.969499Z","end":"2026-09-18T02:33:05.353534Z","steps":["trace[254569485] 'process raft request' (duration: 383.511969ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:33:05.353586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.132907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-18T02:33:05.353649Z","caller":"traceutil/trace.go:171","msg":"trace[1987934702] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5042; }","duration":"336.245448ms","start":"2026-09-18T02:33:05.017385Z","end":"2026-09-18T02:33:05.35363Z","steps":["trace[1987934702] 'agreement among raft nodes before linearized reading' (duration: 336.019374ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:33:05.353671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:33:04.969477Z","time spent":"384.122701ms","remote":"127.0.0.1:35116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16538,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:33:05.353707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:33:05.017368Z","time spent":"336.322231ms","remote":"127.0.0.1:35090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-09-18T02:33:05.92666Z","caller":"traceutil/trace.go:171","msg":"trace[2099976619] linearizableReadLoop","detail":"{readStateIndex:5245; appliedIndex:5243; }","duration":"145.02973ms","start":"2026-09-18T02:33:05.781603Z","end":"2026-09-18T02:33:05.926633Z","steps":["trace[2099976619] 'read index received' (duration: 144.917028ms)","trace[2099976619] 'applied index is now lower than readState.Index' (duration: 111.712µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:33:05.926741Z","caller":"traceutil/trace.go:171","msg":"trace[1419417775] transaction","detail":"{read_only:false; response_revision:5049; number_of_response:1; }","duration":"161.805956ms","start":"2026-09-18T02:33:05.764884Z","end":"2026-09-18T02:33:05.92669Z","steps":["trace[1419417775] 'process raft request' (duration: 161.564931ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:33:05.926764Z","caller":"traceutil/trace.go:171","msg":"trace[2019417315] transaction","detail":"{read_only:false; response_revision:5050; number_of_response:1; }","duration":"161.415299ms","start":"2026-09-18T02:33:05.765324Z","end":"2026-09-18T02:33:05.926739Z","steps":["trace[2019417315] 'process raft request' (duration: 161.260506ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:33:05.926911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.294624ms","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-18T02:33:05.92699Z","caller":"traceutil/trace.go:171","msg":"trace[1204198490] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5050; }","duration":"145.57155ms","start":"2026-09-18T02:33:05.781403Z","end":"2026-09-18T02:33:05.926975Z","steps":["trace[1204198490] 'agreement among raft nodes before linearized reading' (duration: 145.357706ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:33:18.27002Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2820} {"level":"info","ts":"2026-09-18T02:33:18.396925Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2820,"took":"125.929697ms","hash":1033102103,"current-db-size-bytes":50941952,"current-db-size":"51 MB","current-db-size-in-use-bytes":26976256,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-18T02:33:18.39699Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1033102103,"revision":2820,"compact-revision":-1} {"level":"info","ts":"2026-09-18T02:33:29.456238Z","caller":"traceutil/trace.go:171","msg":"trace[633371935] transaction","detail":"{read_only:false; response_revision:5320; number_of_response:1; }","duration":"213.922816ms","start":"2026-09-18T02:33:29.242278Z","end":"2026-09-18T02:33:29.4562Z","steps":["trace[633371935] 'process raft request' (duration: 213.523879ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:33:29.456483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.077443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8d6587fb-45e5-4417-812c-4c83683879b6\" ","response":"range_response_count:1 size:3764"} {"level":"info","ts":"2026-09-18T02:33:29.456618Z","caller":"traceutil/trace.go:171","msg":"trace[269555964] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8d6587fb-45e5-4417-812c-4c83683879b6; range_end:; response_count:1; response_revision:5320; }","duration":"195.279737ms","start":"2026-09-18T02:33:29.261307Z","end":"2026-09-18T02:33:29.456587Z","steps":["trace[269555964] 'agreement among raft nodes before linearized reading' (duration: 195.046973ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:33:29.456633Z","caller":"traceutil/trace.go:171","msg":"trace[1146511483] linearizableReadLoop","detail":"{readStateIndex:5524; appliedIndex:5523; }","duration":"194.728877ms","start":"2026-09-18T02:33:29.261356Z","end":"2026-09-18T02:33:29.456085Z","steps":["trace[1146511483] 'read index received' (duration: 194.153316ms)","trace[1146511483] 'applied index is now lower than readState.Index' (duration: 573.911µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:37:27.473724Z","caller":"traceutil/trace.go:171","msg":"trace[437577906] transaction","detail":"{read_only:false; response_revision:7030; number_of_response:1; }","duration":"107.842855ms","start":"2026-09-18T02:37:27.365851Z","end":"2026-09-18T02:37:27.473693Z","steps":["trace[437577906] 'process raft request' (duration: 107.708ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:37:59.182969Z","caller":"traceutil/trace.go:171","msg":"trace[405416196] transaction","detail":"{read_only:false; response_revision:7242; number_of_response:1; }","duration":"114.19615ms","start":"2026-09-18T02:37:59.068738Z","end":"2026-09-18T02:37:59.182934Z","steps":["trace[405416196] 'process raft request' (duration: 73.672595ms)","trace[405416196] 'compare' (duration: 40.222904ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:38:18.276592Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5207} {"level":"info","ts":"2026-09-18T02:38:18.355414Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5207,"took":"77.436133ms","hash":4259493384,"current-db-size-bytes":50941952,"current-db-size":"51 MB","current-db-size-in-use-bytes":18694144,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-18T02:38:18.355467Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4259493384,"revision":5207,"compact-revision":2820}