{"level":"warn","ts":"2026-07-25T19:11:30.214767Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T19:11:30.214843Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.144:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.144:2380","--initial-cluster=instance=https://199.204.45.144:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.144:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.144: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-07-25T19:11:30.214902Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T19:11:30.21491Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-07-25T19:11:30.214929Z","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-07-25T19:11:30.215623Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"]} {"level":"info","ts":"2026-07-25T19:11:30.21575Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.144: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-07-25T19:11:30.223921Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.108706ms"} {"level":"info","ts":"2026-07-25T19:11:30.234385Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4594e5f716bad646","cluster-id":"ff2e51b364668606"} {"level":"info","ts":"2026-07-25T19:11:30.234493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=()"} {"level":"info","ts":"2026-07-25T19:11:30.234527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 0"} {"level":"info","ts":"2026-07-25T19:11:30.234545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4594e5f716bad646 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-25T19:11:30.234568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 1"} {"level":"info","ts":"2026-07-25T19:11:30.234617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"warn","ts":"2026-07-25T19:11:30.239591Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-25T19:11:30.240888Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-25T19:11:30.241825Z","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-07-25T19:11:30.243897Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4594e5f716bad646","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-25T19:11:30.24467Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4594e5f716bad646","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-25T19:11:30.245197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"info","ts":"2026-07-25T19:11:30.251874Z","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-07-25T19:11:30.251965Z","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-07-25T19:11:30.251977Z","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-07-25T19:11:30.256484Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","added-peer-id":"4594e5f716bad646","added-peer-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-07-25T19:11:30.258057Z","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-07-25T19:11:30.25826Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-07-25T19:11:30.258324Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-07-25T19:11:30.258969Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4594e5f716bad646","initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-25T19:11:30.259011Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-25T19:11:30.935313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 is starting a new election at term 1"} {"level":"info","ts":"2026-07-25T19:11:30.935444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-25T19:11:30.935514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgPreVoteResp from 4594e5f716bad646 at term 1"} {"level":"info","ts":"2026-07-25T19:11:30.935569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became candidate at term 2"} {"level":"info","ts":"2026-07-25T19:11:30.935604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgVoteResp from 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-07-25T19:11:30.935653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became leader at term 2"} {"level":"info","ts":"2026-07-25T19:11:30.935715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4594e5f716bad646 elected leader 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-07-25T19:11:30.936793Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4594e5f716bad646","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.144:2379]}","request-path":"/0/members/4594e5f716bad646/attributes","cluster-id":"ff2e51b364668606","publish-timeout":"7s"} {"level":"info","ts":"2026-07-25T19:11:30.936889Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T19:11:30.93689Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T19:11:30.937107Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T19:11:30.937163Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-25T19:11:30.937249Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-25T19:11:30.940308Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T19:11:30.940539Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T19:11:30.940599Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T19:11:30.94199Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.144:2379"} {"level":"info","ts":"2026-07-25T19:11:30.942142Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-25T19:11:36.775403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.430099ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-25T19:11:36.775497Z","caller":"traceutil/trace.go:171","msg":"trace[2047436410] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"301.629923ms","start":"2026-07-25T19:11:36.473854Z","end":"2026-07-25T19:11:36.775484Z","steps":["trace[2047436410] 'process raft request' (duration: 131.751336ms)","trace[2047436410] 'compare' (duration: 169.282725ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T19:11:36.775544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:11:36.47384Z","time spent":"301.689814ms","remote":"127.0.0.1:41244","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-07-25T19:11:37.053135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.19766ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T19:11:37.053349Z","caller":"traceutil/trace.go:171","msg":"trace[580799673] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"273.795314ms","start":"2026-07-25T19:11:36.779525Z","end":"2026-07-25T19:11:37.05332Z","steps":["trace[580799673] 'process raft request' (duration: 273.739573ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:11:37.053505Z","caller":"traceutil/trace.go:171","msg":"trace[1800192314] linearizableReadLoop","detail":"{readStateIndex:281; appliedIndex:279; }","duration":"536.707302ms","start":"2026-07-25T19:11:36.516767Z","end":"2026-07-25T19:11:37.053474Z","steps":["trace[1800192314] 'read index received' (duration: 88.961611ms)","trace[1800192314] 'applied index is now lower than readState.Index' (duration: 447.742821ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:11:37.053563Z","caller":"traceutil/trace.go:171","msg":"trace[82403952] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"570.134734ms","start":"2026-07-25T19:11:36.483406Z","end":"2026-07-25T19:11:37.053541Z","steps":["trace[82403952] 'process raft request' (duration: 421.32188ms)","trace[82403952] 'compare' (duration: 148.059027ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T19:11:37.053691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:11:36.483397Z","time spent":"570.224816ms","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4649,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T19:11:37.053733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.915837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T19:11:37.053775Z","caller":"traceutil/trace.go:171","msg":"trace[589987482] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:0; response_revision:271; }","duration":"537.04391ms","start":"2026-07-25T19:11:36.516716Z","end":"2026-07-25T19:11:37.05376Z","steps":["trace[589987482] 'agreement among raft nodes before linearized reading' (duration: 536.908497ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:11:37.05377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.360779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-25T19:11:37.053809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:11:36.516697Z","time spent":"537.102871ms","remote":"127.0.0.1:41178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" "} {"level":"info","ts":"2026-07-25T19:11:37.053848Z","caller":"traceutil/trace.go:171","msg":"trace[2041813999] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:271; }","duration":"275.474412ms","start":"2026-07-25T19:11:36.778354Z","end":"2026-07-25T19:11:37.053828Z","steps":["trace[2041813999] 'agreement among raft nodes before linearized reading' (duration: 275.305528ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:11:37.053877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.270678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-25T19:11:37.053923Z","caller":"traceutil/trace.go:171","msg":"trace[829163624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:271; }","duration":"201.317189ms","start":"2026-07-25T19:11:36.852592Z","end":"2026-07-25T19:11:37.05391Z","steps":["trace[829163624] 'agreement among raft nodes before linearized reading' (duration: 201.240268ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:11:38.987951Z","caller":"traceutil/trace.go:171","msg":"trace[179873937] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"470.909743ms","start":"2026-07-25T19:11:38.517015Z","end":"2026-07-25T19:11:38.987925Z","steps":["trace[179873937] 'process raft request' (duration: 470.749409ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:11:38.988117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:11:38.516986Z","time spent":"471.056837ms","remote":"127.0.0.1:41178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":176,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T19:11:45.818928Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203859222314325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T19:11:46.319832Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203859222314325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T19:11:46.820779Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203859222314325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T19:11:47.321202Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203859222314325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T19:11:47.639709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000413113s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-25T19:11:47.639783Z","caller":"traceutil/trace.go:171","msg":"trace[1534967779] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000526967s","start":"2026-07-25T19:11:45.63924Z","end":"2026-07-25T19:11:47.639767Z","steps":["trace[1534967779] 'agreement among raft nodes before linearized reading' (duration: 2.000435914s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:11:47.639819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:11:45.639223Z","time spent":"2.000588739s","remote":"127.0.0.1:47860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/25 19:11:47 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-25T19:11:47.821797Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203859222314325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T19:11:48.323011Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203859222314325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T19:11:48.823806Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203859222314325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T19:11:49.324119Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203859222314325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T19:11:49.640546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000279559s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-25T19:11:49.640651Z","caller":"traceutil/trace.go:171","msg":"trace[877000770] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000430074s","start":"2026-07-25T19:11:47.640198Z","end":"2026-07-25T19:11:49.640628Z","steps":["trace[877000770] 'agreement among raft nodes before linearized reading' (duration: 2.00030711s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:11:49.640728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:11:47.640181Z","time spent":"2.000534276s","remote":"127.0.0.1:47868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/25 19:11:49 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-25T19:11:49.82473Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203859222314325,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T19:11:49.981622Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.82062777s","expected-duration":"1s"} {"level":"info","ts":"2026-07-25T19:11:49.982057Z","caller":"traceutil/trace.go:171","msg":"trace[268219106] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"4.821143056s","start":"2026-07-25T19:11:45.160882Z","end":"2026-07-25T19:11:49.982025Z","steps":["trace[268219106] 'process raft request' (duration: 4.820992791s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:11:49.982248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:11:45.160858Z","time spent":"4.821292501s","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T19:11:49.992686Z","caller":"traceutil/trace.go:171","msg":"trace[636897832] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"4.827314489s","start":"2026-07-25T19:11:45.165349Z","end":"2026-07-25T19:11:49.992663Z","steps":["trace[636897832] 'process raft request' (duration: 4.827167053s)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:11:49.992867Z","caller":"traceutil/trace.go:171","msg":"trace[1336395641] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"4.572077626s","start":"2026-07-25T19:11:45.420764Z","end":"2026-07-25T19:11:49.992842Z","steps":["trace[1336395641] 'process raft request' (duration: 4.571852709s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:11:49.992893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:11:45.165335Z","time spent":"4.827461873s","remote":"127.0.0.1:41244","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-07-25T19:11:49.992984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:11:45.420745Z","time spent":"4.57218004s","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T19:11:49.994323Z","caller":"traceutil/trace.go:171","msg":"trace[2103142989] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"350.355008ms","start":"2026-07-25T19:11:49.643956Z","end":"2026-07-25T19:11:49.994311Z","steps":["trace[2103142989] 'process raft request' (duration: 350.257165ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:11:49.994415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:11:49.643933Z","time spent":"350.458291ms","remote":"127.0.0.1:41036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T19:11:49.994315Z","caller":"traceutil/trace.go:171","msg":"trace[569362084] linearizableReadLoop","detail":"{readStateIndex:384; appliedIndex:379; }","duration":"4.675801768s","start":"2026-07-25T19:11:45.318492Z","end":"2026-07-25T19:11:49.994294Z","steps":["trace[569362084] 'read index received' (duration: 4.66350306s)","trace[569362084] 'applied index is now lower than readState.Index' (duration: 12.297668ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T19:11:49.994428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.675927652s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4796"} {"level":"info","ts":"2026-07-25T19:11:49.994529Z","caller":"traceutil/trace.go:171","msg":"trace[1901946758] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:370; }","duration":"4.676080026s","start":"2026-07-25T19:11:45.318441Z","end":"2026-07-25T19:11:49.994521Z","steps":["trace[1901946758] 'agreement among raft nodes before linearized reading' (duration: 4.675917291s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:11:49.994562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:11:45.31842Z","time spent":"4.676134968s","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":4819,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"warn","ts":"2026-07-25T19:11:49.994683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.28174202s","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-07-25T19:11:49.994788Z","caller":"traceutil/trace.go:171","msg":"trace[1435344465] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:370; }","duration":"4.281893054s","start":"2026-07-25T19:11:45.712871Z","end":"2026-07-25T19:11:49.994764Z","steps":["trace[1435344465] 'agreement among raft nodes before linearized reading' (duration: 4.281718099s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:11:49.994838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:11:45.712851Z","time spent":"4.281978317s","remote":"127.0.0.1:41244","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-07-25T19:11:49.994948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.566143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T19:11:49.995011Z","caller":"traceutil/trace.go:171","msg":"trace[1161021725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:370; }","duration":"349.657466ms","start":"2026-07-25T19:11:49.645344Z","end":"2026-07-25T19:11:49.995002Z","steps":["trace[1161021725] 'agreement among raft nodes before linearized reading' (duration: 349.500251ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:11:49.995058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:11:49.645338Z","time spent":"349.709327ms","remote":"127.0.0.1:47860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-25T19:11:49.99508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.973360019s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T19:11:49.995158Z","caller":"traceutil/trace.go:171","msg":"trace[773028629] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:370; }","duration":"1.973458102s","start":"2026-07-25T19:11:48.021689Z","end":"2026-07-25T19:11:49.995147Z","steps":["trace[773028629] 'agreement among raft nodes before linearized reading' (duration: 1.973347769s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:11:49.995281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.880180635s","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-07-25T19:11:49.995363Z","caller":"traceutil/trace.go:171","msg":"trace[246314759] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:370; }","duration":"3.880299899s","start":"2026-07-25T19:11:46.115045Z","end":"2026-07-25T19:11:49.995345Z","steps":["trace[246314759] 'agreement among raft nodes before linearized reading' (duration: 3.880147795s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:11:49.995421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:11:46.115024Z","time spent":"3.880388843s","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-25T19:12:15.074752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.290898ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-25T19:12:15.075022Z","caller":"traceutil/trace.go:171","msg":"trace[117577128] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"197.75246ms","start":"2026-07-25T19:12:14.877252Z","end":"2026-07-25T19:12:15.075004Z","steps":["trace[117577128] 'process raft request' (duration: 197.715138ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:12:15.075122Z","caller":"traceutil/trace.go:171","msg":"trace[1282026360] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"210.204476ms","start":"2026-07-25T19:12:14.864893Z","end":"2026-07-25T19:12:15.075097Z","steps":["trace[1282026360] 'process raft request' (duration: 209.970496ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:12:15.075301Z","caller":"traceutil/trace.go:171","msg":"trace[617731516] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"202.819422ms","start":"2026-07-25T19:12:14.872434Z","end":"2026-07-25T19:12:15.075254Z","steps":["trace[617731516] 'process raft request' (duration: 202.484167ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:12:15.075387Z","caller":"traceutil/trace.go:171","msg":"trace[2106297413] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"210.532461ms","start":"2026-07-25T19:12:14.864832Z","end":"2026-07-25T19:12:15.075364Z","steps":["trace[2106297413] 'process raft request' (duration: 51.546252ms)","trace[2106297413] 'compare' (duration: 158.11175ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:12:15.078601Z","caller":"traceutil/trace.go:171","msg":"trace[1081631874] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"179.96723ms","start":"2026-07-25T19:12:14.898618Z","end":"2026-07-25T19:12:15.078586Z","steps":["trace[1081631874] 'process raft request' (duration: 179.806383ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:12:15.078711Z","caller":"traceutil/trace.go:171","msg":"trace[815466973] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"182.801834ms","start":"2026-07-25T19:12:14.895898Z","end":"2026-07-25T19:12:15.0787Z","steps":["trace[815466973] 'process raft request' (duration: 182.341274ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:12:15.078871Z","caller":"traceutil/trace.go:171","msg":"trace[40435733] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"178.843001ms","start":"2026-07-25T19:12:14.900021Z","end":"2026-07-25T19:12:15.078864Z","steps":["trace[40435733] 'process raft request' (duration: 178.523597ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:12:15.079019Z","caller":"traceutil/trace.go:171","msg":"trace[795078873] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"182.897078ms","start":"2026-07-25T19:12:14.895983Z","end":"2026-07-25T19:12:15.07888Z","steps":["trace[795078873] 'process raft request' (duration: 182.343974ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:12:15.079171Z","caller":"traceutil/trace.go:171","msg":"trace[2006837606] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"178.738246ms","start":"2026-07-25T19:12:14.900427Z","end":"2026-07-25T19:12:15.079165Z","steps":["trace[2006837606] 'process raft request' (duration: 178.400981ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:12:15.079611Z","caller":"traceutil/trace.go:171","msg":"trace[1710874505] transaction","detail":"{read_only:false; number_of_response:0; response_revision:510; }","duration":"183.604891ms","start":"2026-07-25T19:12:14.895973Z","end":"2026-07-25T19:12:15.079578Z","steps":["trace[1710874505] 'process raft request' (duration: 182.420378ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:12:15.0791Z","caller":"traceutil/trace.go:171","msg":"trace[160762538] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"175.228792ms","start":"2026-07-25T19:12:14.903865Z","end":"2026-07-25T19:12:15.079094Z","steps":["trace[160762538] 'process raft request' (duration: 175.18709ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:12:15.118766Z","caller":"traceutil/trace.go:171","msg":"trace[310432224] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"196.930582ms","start":"2026-07-25T19:12:14.921545Z","end":"2026-07-25T19:12:15.118475Z","steps":["trace[310432224] 'process raft request' (duration: 196.051023ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:12:15.121551Z","caller":"traceutil/trace.go:171","msg":"trace[226748675] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"113.875957ms","start":"2026-07-25T19:12:15.007663Z","end":"2026-07-25T19:12:15.121539Z","steps":["trace[226748675] 'process raft request' (duration: 113.73079ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:15.796076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.663894ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T19:12:15.796198Z","caller":"traceutil/trace.go:171","msg":"trace[384157847] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"231.310141ms","start":"2026-07-25T19:12:15.564878Z","end":"2026-07-25T19:12:15.796188Z","steps":["trace[384157847] 'process raft request' (duration: 231.276889ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:12:15.796243Z","caller":"traceutil/trace.go:171","msg":"trace[134421784] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"232.41186ms","start":"2026-07-25T19:12:15.563804Z","end":"2026-07-25T19:12:15.796216Z","steps":["trace[134421784] 'process raft request' (duration: 77.554257ms)","trace[134421784] 'compare' (duration: 154.56642ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:12:15.809607Z","caller":"traceutil/trace.go:171","msg":"trace[878680605] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"194.316742ms","start":"2026-07-25T19:12:15.615267Z","end":"2026-07-25T19:12:15.809584Z","steps":["trace[878680605] 'process raft request' (duration: 194.101152ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:16.100659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.912969ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T19:12:16.100793Z","caller":"traceutil/trace.go:171","msg":"trace[105602683] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"279.759079ms","start":"2026-07-25T19:12:15.82101Z","end":"2026-07-25T19:12:16.100769Z","steps":["trace[105602683] 'process raft request' (duration: 144.63451ms)","trace[105602683] 'compare' (duration: 134.725691ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T19:12:16.490633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.437937ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T19:12:16.490744Z","caller":"traceutil/trace.go:171","msg":"trace[724983379] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"601.73367ms","start":"2026-07-25T19:12:15.888993Z","end":"2026-07-25T19:12:16.490726Z","steps":["trace[724983379] 'process raft request' (duration: 422.110895ms)","trace[724983379] 'compare' (duration: 179.193926ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T19:12:16.490814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:15.888962Z","time spent":"601.813124ms","remote":"127.0.0.1:41008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151212,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T19:12:16.492576Z","caller":"traceutil/trace.go:171","msg":"trace[2022099827] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"438.783309ms","start":"2026-07-25T19:12:16.05378Z","end":"2026-07-25T19:12:16.492564Z","steps":["trace[2022099827] 'process raft request' (duration: 438.449835ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:12:16.492596Z","caller":"traceutil/trace.go:171","msg":"trace[102471064] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:569; }","duration":"373.659586ms","start":"2026-07-25T19:12:16.118914Z","end":"2026-07-25T19:12:16.492574Z","steps":["trace[102471064] 'read index received' (duration: 190.737243ms)","trace[102471064] 'applied index is now lower than readState.Index' (duration: 182.921503ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T19:12:16.492627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:16.053755Z","time spent":"438.850292ms","remote":"127.0.0.1:41008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T19:12:16.492705Z","caller":"traceutil/trace.go:171","msg":"trace[1001409949] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"350.001707ms","start":"2026-07-25T19:12:16.142695Z","end":"2026-07-25T19:12:16.492696Z","steps":["trace[1001409949] 'process raft request' (duration: 349.792878ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:16.492811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:16.142673Z","time spent":"350.05863ms","remote":"127.0.0.1:41008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T19:12:16.492857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.416308ms","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-07-25T19:12:16.492881Z","caller":"traceutil/trace.go:171","msg":"trace[1734973355] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:549; }","duration":"361.473061ms","start":"2026-07-25T19:12:16.131399Z","end":"2026-07-25T19:12:16.492872Z","steps":["trace[1734973355] 'agreement among raft nodes before linearized reading' (duration: 361.388017ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:16.492906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:16.131381Z","time spent":"361.520282ms","remote":"127.0.0.1:41244","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-07-25T19:12:16.493014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.877474ms","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-07-25T19:12:16.493048Z","caller":"traceutil/trace.go:171","msg":"trace[427340153] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:549; }","duration":"358.939618ms","start":"2026-07-25T19:12:16.134098Z","end":"2026-07-25T19:12:16.493038Z","steps":["trace[427340153] 'agreement among raft nodes before linearized reading' (duration: 358.827673ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:16.493075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:16.134086Z","time spent":"358.983279ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-25T19:12:16.493126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.21196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-25T19:12:16.493152Z","caller":"traceutil/trace.go:171","msg":"trace[624874909] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:549; }","duration":"374.262152ms","start":"2026-07-25T19:12:16.118884Z","end":"2026-07-25T19:12:16.493146Z","steps":["trace[624874909] 'agreement among raft nodes before linearized reading' (duration: 374.20574ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:16.493168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:16.118868Z","time spent":"374.296634ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-25T19:12:16.493026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.525673ms","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-07-25T19:12:16.4932Z","caller":"traceutil/trace.go:171","msg":"trace[275151775] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:549; }","duration":"361.710121ms","start":"2026-07-25T19:12:16.131481Z","end":"2026-07-25T19:12:16.493191Z","steps":["trace[275151775] 'agreement among raft nodes before linearized reading' (duration: 361.501832ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:16.493233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:16.131474Z","time spent":"361.749863ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-25T19:12:21.013858Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203859222314739,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T19:12:21.428212Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.628818594s","expected-duration":"1s"} {"level":"info","ts":"2026-07-25T19:12:21.43107Z","caller":"traceutil/trace.go:171","msg":"trace[280004292] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"1.633191716s","start":"2026-07-25T19:12:19.797851Z","end":"2026-07-25T19:12:21.431043Z","steps":["trace[280004292] 'process raft request' (duration: 1.631375631s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:21.43124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:19.797822Z","time spent":"1.633333533s","remote":"127.0.0.1:41058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036161,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T19:12:21.451835Z","caller":"traceutil/trace.go:171","msg":"trace[347094827] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:608; }","duration":"938.357883ms","start":"2026-07-25T19:12:20.513409Z","end":"2026-07-25T19:12:21.451767Z","steps":["trace[347094827] 'read index received' (duration: 915.095696ms)","trace[347094827] 'applied index is now lower than readState.Index' (duration: 23.261207ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:12:21.452029Z","caller":"traceutil/trace.go:171","msg":"trace[1999102945] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"751.835478ms","start":"2026-07-25T19:12:20.700167Z","end":"2026-07-25T19:12:21.452003Z","steps":["trace[1999102945] 'process raft request' (duration: 751.44582ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:21.45224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.593087ms","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-07-25T19:12:21.452267Z","caller":"traceutil/trace.go:171","msg":"trace[1415721188] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:586; }","duration":"937.625008ms","start":"2026-07-25T19:12:20.514635Z","end":"2026-07-25T19:12:21.45226Z","steps":["trace[1415721188] 'agreement among raft nodes before linearized reading' (duration: 937.576796ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:21.452293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:20.514632Z","time spent":"937.656389ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-25T19:12:21.452412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:20.700145Z","time spent":"752.10337ms","remote":"127.0.0.1:41244","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-07-25T19:12:21.452187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.766022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-25T19:12:21.452544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"929.755424ms","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-07-25T19:12:21.452536Z","caller":"traceutil/trace.go:171","msg":"trace[1867516598] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:586; }","duration":"939.132119ms","start":"2026-07-25T19:12:20.513382Z","end":"2026-07-25T19:12:21.452514Z","steps":["trace[1867516598] 'agreement among raft nodes before linearized reading' (duration: 938.689888ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:12:21.452565Z","caller":"traceutil/trace.go:171","msg":"trace[266414391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:586; }","duration":"929.785116ms","start":"2026-07-25T19:12:20.522775Z","end":"2026-07-25T19:12:21.45256Z","steps":["trace[266414391] 'agreement among raft nodes before linearized reading' (duration: 929.733872ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:21.452433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"812.93571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-25T19:12:21.452594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:20.513372Z","time spent":"939.204143ms","remote":"127.0.0.1:41244","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-07-25T19:12:21.452614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"930.71751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-25T19:12:21.452582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:20.52277Z","time spent":"929.808748ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-25T19:12:21.452683Z","caller":"traceutil/trace.go:171","msg":"trace[252506791] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:586; }","duration":"930.838696ms","start":"2026-07-25T19:12:20.521831Z","end":"2026-07-25T19:12:21.45267Z","steps":["trace[252506791] 'agreement among raft nodes before linearized reading' (duration: 930.611484ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:12:21.452647Z","caller":"traceutil/trace.go:171","msg":"trace[288734836] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"813.162432ms","start":"2026-07-25T19:12:20.639465Z","end":"2026-07-25T19:12:21.452627Z","steps":["trace[288734836] 'agreement among raft nodes before linearized reading' (duration: 812.955491ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:21.452714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:20.52181Z","time spent":"930.895359ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-25T19:12:21.452742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:20.639448Z","time spent":"813.284128ms","remote":"127.0.0.1:47860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-25T19:12:23.126425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.559706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nhh55\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-25T19:12:23.126506Z","caller":"traceutil/trace.go:171","msg":"trace[18085869] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nhh55; range_end:; response_count:1; response_revision:596; }","duration":"678.692021ms","start":"2026-07-25T19:12:22.447798Z","end":"2026-07-25T19:12:23.12649Z","steps":["trace[18085869] 'range keys from in-memory index tree' (duration: 678.388007ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:23.126564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:22.44778Z","time spent":"678.777765ms","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-nhh55\" "} {"level":"warn","ts":"2026-07-25T19:12:23.139551Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203859222314760,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T19:12:23.63997Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203859222314760,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T19:12:23.870708Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.301915583s","expected-duration":"1s"} {"level":"info","ts":"2026-07-25T19:12:23.871698Z","caller":"traceutil/trace.go:171","msg":"trace[1037280456] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"1.303699937s","start":"2026-07-25T19:12:22.567976Z","end":"2026-07-25T19:12:23.871676Z","steps":["trace[1037280456] 'process raft request' (duration: 1.30312903s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:23.871838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:22.567953Z","time spent":"1.303806982s","remote":"127.0.0.1:41058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036233,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T19:12:24.294494Z","caller":"traceutil/trace.go:171","msg":"trace[572324106] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:620; }","duration":"1.655428345s","start":"2026-07-25T19:12:22.639048Z","end":"2026-07-25T19:12:24.294476Z","steps":["trace[572324106] 'read index received' (duration: 1.231979809s)","trace[572324106] 'applied index is now lower than readState.Index' (duration: 423.447846ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:12:24.294569Z","caller":"traceutil/trace.go:171","msg":"trace[1602810784] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"1.153329338s","start":"2026-07-25T19:12:23.141232Z","end":"2026-07-25T19:12:24.294562Z","steps":["trace[1602810784] 'process raft request' (duration: 1.153104407s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:24.294642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:23.141206Z","time spent":"1.15338027s","remote":"127.0.0.1:41156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T19:12:24.295008Z","caller":"traceutil/trace.go:171","msg":"trace[263445478] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"1.332563004s","start":"2026-07-25T19:12:22.962408Z","end":"2026-07-25T19:12:24.294971Z","steps":["trace[263445478] 'process raft request' (duration: 1.323130943s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:24.295056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.655766181s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T19:12:24.295124Z","caller":"traceutil/trace.go:171","msg":"trace[605451769] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"1.656269684s","start":"2026-07-25T19:12:22.638836Z","end":"2026-07-25T19:12:24.295106Z","steps":["trace[605451769] 'agreement among raft nodes before linearized reading' (duration: 1.655849604s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:24.295177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:22.638806Z","time spent":"1.656358958s","remote":"127.0.0.1:47868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-25T19:12:24.295176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:22.962374Z","time spent":"1.332713111s","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T19:12:24.330808Z","caller":"traceutil/trace.go:171","msg":"trace[1159217715] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"400.973502ms","start":"2026-07-25T19:12:23.92981Z","end":"2026-07-25T19:12:24.330784Z","steps":["trace[1159217715] 'process raft request' (duration: 400.818205ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:24.330964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.760517ms","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-07-25T19:12:24.331036Z","caller":"traceutil/trace.go:171","msg":"trace[1590457725] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:600; }","duration":"792.838301ms","start":"2026-07-25T19:12:23.538178Z","end":"2026-07-25T19:12:24.331017Z","steps":["trace[1590457725] 'agreement among raft nodes before linearized reading' (duration: 792.641622ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:24.331072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:23.538093Z","time spent":"792.971747ms","remote":"127.0.0.1:41244","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-07-25T19:12:24.331056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.850822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-25T19:12:24.331121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.796387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.144\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-25T19:12:24.331135Z","caller":"traceutil/trace.go:171","msg":"trace[603971106] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:600; }","duration":"792.963987ms","start":"2026-07-25T19:12:23.538152Z","end":"2026-07-25T19:12:24.331116Z","steps":["trace[603971106] 'agreement among raft nodes before linearized reading' (duration: 792.708695ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:12:24.331188Z","caller":"traceutil/trace.go:171","msg":"trace[1051307852] range","detail":"{range_begin:/registry/masterleases/199.204.45.144; range_end:; response_count:1; response_revision:600; }","duration":"490.894322ms","start":"2026-07-25T19:12:23.840272Z","end":"2026-07-25T19:12:24.331167Z","steps":["trace[1051307852] 'agreement among raft nodes before linearized reading' (duration: 490.726974ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:24.331155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:23.929791Z","time spent":"401.097638ms","remote":"127.0.0.1:41322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T19:12:24.331192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:23.538142Z","time spent":"793.038781ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-25T19:12:24.331237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:23.840253Z","time spent":"490.974536ms","remote":"127.0.0.1:40988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.144\" "} {"level":"warn","ts":"2026-07-25T19:12:24.331305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.988308ms","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-07-25T19:12:24.33141Z","caller":"traceutil/trace.go:171","msg":"trace[1548050447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:600; }","duration":"797.129585ms","start":"2026-07-25T19:12:23.534263Z","end":"2026-07-25T19:12:24.331392Z","steps":["trace[1548050447] 'agreement among raft nodes before linearized reading' (duration: 796.712895ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:24.331359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.841041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-25T19:12:24.331485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:23.534242Z","time spent":"797.23003ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-25T19:12:24.331523Z","caller":"traceutil/trace.go:171","msg":"trace[1694182709] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:600; }","duration":"793.419658ms","start":"2026-07-25T19:12:23.538089Z","end":"2026-07-25T19:12:24.331509Z","steps":["trace[1694182709] 'agreement among raft nodes before linearized reading' (duration: 792.702954ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:24.331711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:23.538069Z","time spent":"793.564675ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-25T19:12:24.807017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.007069ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T19:12:24.807228Z","caller":"traceutil/trace.go:171","msg":"trace[167723923] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"471.151328ms","start":"2026-07-25T19:12:24.336064Z","end":"2026-07-25T19:12:24.807215Z","steps":["trace[167723923] 'process raft request' (duration: 471.088675ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:24.807281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:24.336057Z","time spent":"471.19954ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T19:12:24.807306Z","caller":"traceutil/trace.go:171","msg":"trace[578042244] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"472.616949ms","start":"2026-07-25T19:12:24.334661Z","end":"2026-07-25T19:12:24.807278Z","steps":["trace[578042244] 'process raft request' (duration: 112.289014ms)","trace[578042244] 'compare' (duration: 359.858953ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T19:12:24.807436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:24.334644Z","time spent":"472.719244ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T19:12:24.807541Z","caller":"traceutil/trace.go:171","msg":"trace[1223675592] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"471.634001ms","start":"2026-07-25T19:12:24.335899Z","end":"2026-07-25T19:12:24.807533Z","steps":["trace[1223675592] 'process raft request' (duration: 471.202521ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:24.807603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:24.335891Z","time spent":"471.687743ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T19:12:24.807743Z","caller":"traceutil/trace.go:171","msg":"trace[269894522] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"471.239673ms","start":"2026-07-25T19:12:24.336492Z","end":"2026-07-25T19:12:24.807732Z","steps":["trace[269894522] 'process raft request' (duration: 470.691457ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:24.8078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:24.33645Z","time spent":"471.320176ms","remote":"127.0.0.1:41244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T19:12:24.807877Z","caller":"traceutil/trace.go:171","msg":"trace[1801874354] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"466.792689ms","start":"2026-07-25T19:12:24.341074Z","end":"2026-07-25T19:12:24.807866Z","steps":["trace[1801874354] 'process raft request' (duration: 466.594329ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:12:24.807886Z","caller":"traceutil/trace.go:171","msg":"trace[2052186312] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:625; }","duration":"465.809632ms","start":"2026-07-25T19:12:24.342059Z","end":"2026-07-25T19:12:24.807868Z","steps":["trace[2052186312] 'read index received' (duration: 104.91501ms)","trace[2052186312] 'applied index is now lower than readState.Index' (duration: 360.893372ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T19:12:24.80792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:24.341059Z","time spent":"466.837011ms","remote":"127.0.0.1:40988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T19:12:24.807966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.913207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T19:12:24.808001Z","caller":"traceutil/trace.go:171","msg":"trace[1687601749] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:605; }","duration":"465.97271ms","start":"2026-07-25T19:12:24.342015Z","end":"2026-07-25T19:12:24.807988Z","steps":["trace[1687601749] 'agreement among raft nodes before linearized reading' (duration: 465.912787ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:12:24.808031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:12:24.342003Z","time spent":"466.020672ms","remote":"127.0.0.1:41330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" "} {"level":"info","ts":"2026-07-25T19:13:14.356697Z","caller":"traceutil/trace.go:171","msg":"trace[231760788] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"117.172332ms","start":"2026-07-25T19:13:14.239503Z","end":"2026-07-25T19:13:14.356675Z","steps":["trace[231760788] 'process raft request' (duration: 117.043745ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:14:02.740097Z","caller":"traceutil/trace.go:171","msg":"trace[151267672] linearizableReadLoop","detail":"{readStateIndex:1188; appliedIndex:1187; }","duration":"102.696513ms","start":"2026-07-25T19:14:02.637372Z","end":"2026-07-25T19:14:02.740069Z","steps":["trace[151267672] 'read index received' (duration: 102.51563ms)","trace[151267672] 'applied index is now lower than readState.Index' (duration: 179.623µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:14:02.740163Z","caller":"traceutil/trace.go:171","msg":"trace[311425763] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"121.143404ms","start":"2026-07-25T19:14:02.61899Z","end":"2026-07-25T19:14:02.740134Z","steps":["trace[311425763] 'process raft request' (duration: 120.905887ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:14:02.74029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.899287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T19:14:02.740375Z","caller":"traceutil/trace.go:171","msg":"trace[408357749] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1141; }","duration":"103.014355ms","start":"2026-07-25T19:14:02.637338Z","end":"2026-07-25T19:14:02.740352Z","steps":["trace[408357749] 'agreement among raft nodes before linearized reading' (duration: 102.844203ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:08.87382Z","caller":"traceutil/trace.go:171","msg":"trace[501071334] transaction","detail":"{read_only:false; response_revision:2543; number_of_response:1; }","duration":"147.435499ms","start":"2026-07-25T19:21:08.726335Z","end":"2026-07-25T19:21:08.87377Z","steps":["trace[501071334] 'process raft request' (duration: 147.254235ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:09.516551Z","caller":"traceutil/trace.go:171","msg":"trace[1244072187] linearizableReadLoop","detail":"{readStateIndex:2677; appliedIndex:2676; }","duration":"182.621236ms","start":"2026-07-25T19:21:09.333907Z","end":"2026-07-25T19:21:09.516528Z","steps":["trace[1244072187] 'read index received' (duration: 182.32079ms)","trace[1244072187] 'applied index is now lower than readState.Index' (duration: 299.436µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:21:09.516723Z","caller":"traceutil/trace.go:171","msg":"trace[1467433037] transaction","detail":"{read_only:false; response_revision:2544; number_of_response:1; }","duration":"268.05335ms","start":"2026-07-25T19:21:09.248652Z","end":"2026-07-25T19:21:09.516705Z","steps":["trace[1467433037] 'process raft request' (duration: 267.669942ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:21:09.516916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.535603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-25T19:21:09.516975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.326962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-25T19:21:09.517004Z","caller":"traceutil/trace.go:171","msg":"trace[1440355462] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2544; }","duration":"132.700136ms","start":"2026-07-25T19:21:09.384283Z","end":"2026-07-25T19:21:09.516983Z","steps":["trace[1440355462] 'agreement among raft nodes before linearized reading' (duration: 132.564153ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:09.517022Z","caller":"traceutil/trace.go:171","msg":"trace[1535476543] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2544; }","duration":"178.401654ms","start":"2026-07-25T19:21:09.338607Z","end":"2026-07-25T19:21:09.517009Z","steps":["trace[1535476543] 'agreement among raft nodes before linearized reading' (duration: 178.191759ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:21:09.517043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.488544ms","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-07-25T19:21:09.517077Z","caller":"traceutil/trace.go:171","msg":"trace[1354259678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2544; }","duration":"177.539795ms","start":"2026-07-25T19:21:09.339526Z","end":"2026-07-25T19:21:09.517066Z","steps":["trace[1354259678] 'agreement among raft nodes before linearized reading' (duration: 177.444363ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:21:09.5172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.2692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-25T19:21:09.517275Z","caller":"traceutil/trace.go:171","msg":"trace[404718428] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2544; }","duration":"183.393753ms","start":"2026-07-25T19:21:09.33386Z","end":"2026-07-25T19:21:09.517254Z","steps":["trace[404718428] 'agreement among raft nodes before linearized reading' (duration: 183.179158ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:25.781208Z","caller":"traceutil/trace.go:171","msg":"trace[1394109741] linearizableReadLoop","detail":"{readStateIndex:2786; appliedIndex:2785; }","duration":"188.031234ms","start":"2026-07-25T19:21:25.593151Z","end":"2026-07-25T19:21:25.781183Z","steps":["trace[1394109741] 'read index received' (duration: 187.84228ms)","trace[1394109741] 'applied index is now lower than readState.Index' (duration: 187.814µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:21:25.781374Z","caller":"traceutil/trace.go:171","msg":"trace[647991042] transaction","detail":"{read_only:false; response_revision:2648; number_of_response:1; }","duration":"199.172607ms","start":"2026-07-25T19:21:25.58219Z","end":"2026-07-25T19:21:25.781362Z","steps":["trace[647991042] 'process raft request' (duration: 198.775849ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:21:25.781526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.366899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T19:21:25.781599Z","caller":"traceutil/trace.go:171","msg":"trace[2023395030] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2648; }","duration":"143.453461ms","start":"2026-07-25T19:21:25.638126Z","end":"2026-07-25T19:21:25.78158Z","steps":["trace[2023395030] 'agreement among raft nodes before linearized reading' (duration: 143.348819ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:21:25.781841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.538207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-25T19:21:25.78184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.501347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-25T19:21:25.781875Z","caller":"traceutil/trace.go:171","msg":"trace[1446590955] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2648; }","duration":"129.608399ms","start":"2026-07-25T19:21:25.652258Z","end":"2026-07-25T19:21:25.781866Z","steps":["trace[1446590955] 'agreement among raft nodes before linearized reading' (duration: 129.496787ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:25.781884Z","caller":"traceutil/trace.go:171","msg":"trace[474069985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2648; }","duration":"129.598729ms","start":"2026-07-25T19:21:25.652274Z","end":"2026-07-25T19:21:25.781873Z","steps":["trace[474069985] 'agreement among raft nodes before linearized reading' (duration: 129.456596ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:21:25.782058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.877563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-25T19:21:25.782139Z","caller":"traceutil/trace.go:171","msg":"trace[1999297432] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2648; }","duration":"188.979745ms","start":"2026-07-25T19:21:25.59314Z","end":"2026-07-25T19:21:25.78212Z","steps":["trace[1999297432] 'agreement among raft nodes before linearized reading' (duration: 188.738969ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:30.966067Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1630} {"level":"info","ts":"2026-07-25T19:21:31.002444Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":1630,"took":"35.907374ms","hash":407090598,"current-db-size-bytes":23937024,"current-db-size":"24 MB","current-db-size-in-use-bytes":5726208,"current-db-size-in-use":"5.7 MB"} {"level":"info","ts":"2026-07-25T19:21:31.002494Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":407090598,"revision":1630,"compact-revision":-1} {"level":"info","ts":"2026-07-25T19:21:40.945019Z","caller":"traceutil/trace.go:171","msg":"trace[1310855232] transaction","detail":"{read_only:false; response_revision:2714; number_of_response:1; }","duration":"211.496086ms","start":"2026-07-25T19:21:40.733496Z","end":"2026-07-25T19:21:40.944992Z","steps":["trace[1310855232] 'process raft request' (duration: 211.336053ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:21:41.124018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.716888ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T19:21:41.124331Z","caller":"traceutil/trace.go:171","msg":"trace[1194211374] transaction","detail":"{read_only:false; response_revision:2715; number_of_response:1; }","duration":"173.027247ms","start":"2026-07-25T19:21:40.951253Z","end":"2026-07-25T19:21:41.12428Z","steps":["trace[1194211374] 'process raft request' (duration: 44.992702ms)","trace[1194211374] 'compare' (duration: 127.601876ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:21:42.016857Z","caller":"traceutil/trace.go:171","msg":"trace[1854930383] transaction","detail":"{read_only:false; response_revision:2722; number_of_response:1; }","duration":"154.603775ms","start":"2026-07-25T19:21:41.862229Z","end":"2026-07-25T19:21:42.016833Z","steps":["trace[1854930383] 'process raft request' (duration: 154.411261ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:42.051094Z","caller":"traceutil/trace.go:171","msg":"trace[291352065] linearizableReadLoop","detail":"{readStateIndex:2865; appliedIndex:2863; }","duration":"186.498502ms","start":"2026-07-25T19:21:41.86457Z","end":"2026-07-25T19:21:42.051069Z","steps":["trace[291352065] 'read index received' (duration: 152.108352ms)","trace[291352065] 'applied index is now lower than readState.Index' (duration: 34.38884ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:21:42.051132Z","caller":"traceutil/trace.go:171","msg":"trace[1031558899] transaction","detail":"{read_only:false; response_revision:2723; number_of_response:1; }","duration":"187.302949ms","start":"2026-07-25T19:21:41.8638Z","end":"2026-07-25T19:21:42.051103Z","steps":["trace[1031558899] 'process raft request' (duration: 187.128025ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:21:42.051355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.764867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-25T19:21:42.051403Z","caller":"traceutil/trace.go:171","msg":"trace[1571778137] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2723; }","duration":"186.87519ms","start":"2026-07-25T19:21:41.864512Z","end":"2026-07-25T19:21:42.051387Z","steps":["trace[1571778137] 'agreement among raft nodes before linearized reading' (duration: 186.689796ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:21:42.051437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.08907ms","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-07-25T19:21:42.051508Z","caller":"traceutil/trace.go:171","msg":"trace[80331290] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2723; }","duration":"185.193533ms","start":"2026-07-25T19:21:41.866296Z","end":"2026-07-25T19:21:42.05149Z","steps":["trace[80331290] 'agreement among raft nodes before linearized reading' (duration: 184.989179ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:42.540799Z","caller":"traceutil/trace.go:171","msg":"trace[2037152740] linearizableReadLoop","detail":"{readStateIndex:2868; appliedIndex:2867; }","duration":"118.330283ms","start":"2026-07-25T19:21:42.422448Z","end":"2026-07-25T19:21:42.540778Z","steps":["trace[2037152740] 'read index received' (duration: 118.17252ms)","trace[2037152740] 'applied index is now lower than readState.Index' (duration: 157.053µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:21:42.540843Z","caller":"traceutil/trace.go:171","msg":"trace[459457533] transaction","detail":"{read_only:false; response_revision:2726; number_of_response:1; }","duration":"205.257111ms","start":"2026-07-25T19:21:42.335553Z","end":"2026-07-25T19:21:42.54081Z","steps":["trace[459457533] 'process raft request' (duration: 205.111908ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:21:42.540927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.468537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T19:21:42.540946Z","caller":"traceutil/trace.go:171","msg":"trace[34495273] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:2726; }","duration":"118.541418ms","start":"2026-07-25T19:21:42.422399Z","end":"2026-07-25T19:21:42.54094Z","steps":["trace[34495273] 'agreement among raft nodes before linearized reading' (duration: 118.446016ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:42.677845Z","caller":"traceutil/trace.go:171","msg":"trace[375489556] transaction","detail":"{read_only:false; response_revision:2731; number_of_response:1; }","duration":"101.576678ms","start":"2026-07-25T19:21:42.576246Z","end":"2026-07-25T19:21:42.677823Z","steps":["trace[375489556] 'process raft request' (duration: 101.451806ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:22:13.584526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.485841ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T19:22:13.58463Z","caller":"traceutil/trace.go:171","msg":"trace[1169538393] transaction","detail":"{read_only:false; response_revision:2901; number_of_response:1; }","duration":"233.601238ms","start":"2026-07-25T19:22:13.35101Z","end":"2026-07-25T19:22:13.584611Z","steps":["trace[1169538393] 'compare' (duration: 224.361867ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:26:19.394073Z","caller":"traceutil/trace.go:171","msg":"trace[1415497165] transaction","detail":"{read_only:false; response_revision:4026; number_of_response:1; }","duration":"121.046445ms","start":"2026-07-25T19:26:19.272972Z","end":"2026-07-25T19:26:19.394018Z","steps":["trace[1415497165] 'process raft request' (duration: 113.838046ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:26:30.971648Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2666} {"level":"info","ts":"2026-07-25T19:26:30.991682Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2666,"took":"19.257473ms","hash":2563501017,"current-db-size-bytes":23937024,"current-db-size":"24 MB","current-db-size-in-use-bytes":6225920,"current-db-size-in-use":"6.2 MB"} {"level":"info","ts":"2026-07-25T19:26:30.991747Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2563501017,"revision":2666,"compact-revision":1630}