{"level":"warn","ts":"2026-09-18T15:19:25.3222Z","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-18T15:19:25.322354Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.118: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.118:2380","--initial-cluster=instance=https://162.253.55.118:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.118:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.118: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-18T15:19:25.322473Z","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-18T15:19:25.322487Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.118:2380"]} {"level":"info","ts":"2026-09-18T15:19:25.322508Z","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-18T15:19:25.323833Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.118:2379"]} {"level":"info","ts":"2026-09-18T15:19:25.324875Z","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.118:2380"],"listen-peer-urls":["https://162.253.55.118:2380"],"advertise-client-urls":["https://162.253.55.118:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.118:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.118: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-18T15:19:25.332259Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.935731ms"} {"level":"info","ts":"2026-09-18T15:19:25.346791Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39c975536cfc1086","cluster-id":"ac0a95643fc422f0"} {"level":"info","ts":"2026-09-18T15:19:25.346922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T15:19:25.346959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became follower at term 0"} {"level":"info","ts":"2026-09-18T15:19:25.346978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39c975536cfc1086 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T15:19:25.346997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became follower at term 1"} {"level":"info","ts":"2026-09-18T15:19:25.347067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 switched to configuration voters=(4163988331651928198)"} {"level":"warn","ts":"2026-09-18T15:19:25.356817Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T15:19:25.365742Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T15:19:25.37003Z","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-18T15:19:25.372557Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39c975536cfc1086","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T15:19:25.373938Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39c975536cfc1086","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T15:19:25.374116Z","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-18T15:19:25.374183Z","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-18T15:19:25.3742Z","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-18T15:19:25.375107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 switched to configuration voters=(4163988331651928198)"} {"level":"info","ts":"2026-09-18T15:19:25.375301Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ac0a95643fc422f0","local-member-id":"39c975536cfc1086","added-peer-id":"39c975536cfc1086","added-peer-peer-urls":["https://162.253.55.118:2380"]} {"level":"info","ts":"2026-09-18T15:19:25.379253Z","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-18T15:19:25.379523Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39c975536cfc1086","initial-advertise-peer-urls":["https://162.253.55.118:2380"],"listen-peer-urls":["https://162.253.55.118:2380"],"advertise-client-urls":["https://162.253.55.118:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.118:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T15:19:25.379556Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T15:19:25.379716Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.118:2380"} {"level":"info","ts":"2026-09-18T15:19:25.379731Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.118:2380"} {"level":"info","ts":"2026-09-18T15:19:25.84771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T15:19:25.84776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T15:19:25.847787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 received MsgPreVoteResp from 39c975536cfc1086 at term 1"} {"level":"info","ts":"2026-09-18T15:19:25.847802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became candidate at term 2"} {"level":"info","ts":"2026-09-18T15:19:25.847809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 received MsgVoteResp from 39c975536cfc1086 at term 2"} {"level":"info","ts":"2026-09-18T15:19:25.847818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became leader at term 2"} {"level":"info","ts":"2026-09-18T15:19:25.84783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39c975536cfc1086 elected leader 39c975536cfc1086 at term 2"} {"level":"info","ts":"2026-09-18T15:19:25.849758Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:19:25.851117Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39c975536cfc1086","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.118:2379]}","request-path":"/0/members/39c975536cfc1086/attributes","cluster-id":"ac0a95643fc422f0","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T15:19:25.851209Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T15:19:25.85111Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T15:19:25.851615Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ac0a95643fc422f0","local-member-id":"39c975536cfc1086","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:19:25.851733Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T15:19:25.851765Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T15:19:25.851798Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:19:25.851839Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:19:25.854562Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.118:2379"} {"level":"info","ts":"2026-09-18T15:19:25.854634Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-18T15:19:27.4644Z","caller":"traceutil/trace.go:171","msg":"trace[464358453] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"230.304518ms","start":"2026-09-18T15:19:27.234065Z","end":"2026-09-18T15:19:27.464369Z","steps":["trace[464358453] 'process raft request' (duration: 230.013076ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:19:27.46437Z","caller":"traceutil/trace.go:171","msg":"trace[1745816775] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"206.50358ms","start":"2026-09-18T15:19:27.257831Z","end":"2026-09-18T15:19:27.464334Z","steps":["trace[1745816775] 'read index received' (duration: 206.340398ms)","trace[1745816775] 'applied index is now lower than readState.Index' (duration: 161.332µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:19:27.464647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.750672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T15:19:27.464793Z","caller":"traceutil/trace.go:171","msg":"trace[1544652458] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:2; }","duration":"206.964784ms","start":"2026-09-18T15:19:27.257806Z","end":"2026-09-18T15:19:27.464771Z","steps":["trace[1544652458] 'agreement among raft nodes before linearized reading' (duration: 206.651692ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:19:27.704814Z","caller":"traceutil/trace.go:171","msg":"trace[1424644962] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"377.313558ms","start":"2026-09-18T15:19:27.32748Z","end":"2026-09-18T15:19:27.704794Z","steps":["trace[1424644962] 'process raft request' (duration: 377.185247ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:19:27.704963Z","caller":"traceutil/trace.go:171","msg":"trace[1467305896] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"240.212544ms","start":"2026-09-18T15:19:27.464713Z","end":"2026-09-18T15:19:27.704925Z","steps":["trace[1467305896] 'read index received' (duration: 239.80406ms)","trace[1467305896] 'applied index is now lower than readState.Index' (duration: 407.214µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:19:27.705078Z","caller":"traceutil/trace.go:171","msg":"trace[646742916] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"369.156528ms","start":"2026-09-18T15:19:27.335802Z","end":"2026-09-18T15:19:27.704958Z","steps":["trace[646742916] 'process raft request' (duration: 369.076698ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:27.705183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.979421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.118\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-18T15:19:27.705195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.350281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-18T15:19:27.705198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.435447ms","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-18T15:19:27.705234Z","caller":"traceutil/trace.go:171","msg":"trace[1857219637] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:10; }","duration":"445.398983ms","start":"2026-09-18T15:19:27.259824Z","end":"2026-09-18T15:19:27.705223Z","steps":["trace[1857219637] 'agreement among raft nodes before linearized reading' (duration: 445.259881ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:19:27.705227Z","caller":"traceutil/trace.go:171","msg":"trace[1836636954] range","detail":"{range_begin:/registry/masterleases/162.253.55.118; range_end:; response_count:0; response_revision:10; }","duration":"389.078731ms","start":"2026-09-18T15:19:27.316134Z","end":"2026-09-18T15:19:27.705213Z","steps":["trace[1836636954] 'agreement among raft nodes before linearized reading' (duration: 388.93304ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:19:27.705275Z","caller":"traceutil/trace.go:171","msg":"trace[1700077895] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"387.564488ms","start":"2026-09-18T15:19:27.317686Z","end":"2026-09-18T15:19:27.705251Z","steps":["trace[1700077895] 'agreement among raft nodes before linearized reading' (duration: 387.304156ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:27.705284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:27.316106Z","time spent":"389.158382ms","remote":"127.0.0.1:38452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/162.253.55.118\" "} {"level":"warn","ts":"2026-09-18T15:19:27.705314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:27.317656Z","time spent":"387.650759ms","remote":"127.0.0.1:38518","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-18T15:19:27.705322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.227703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T15:19:27.705347Z","caller":"traceutil/trace.go:171","msg":"trace[674530180] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:10; }","duration":"443.262814ms","start":"2026-09-18T15:19:27.262074Z","end":"2026-09-18T15:19:27.705336Z","steps":["trace[674530180] 'agreement among raft nodes before linearized reading' (duration: 443.227124ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:27.705332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:27.327445Z","time spent":"377.44804ms","remote":"127.0.0.1:38594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T15:19:27.705362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:27.262071Z","time spent":"443.287605ms","remote":"127.0.0.1:38694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-18T15:19:27.705388Z","caller":"traceutil/trace.go:171","msg":"trace[409315426] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"376.877835ms","start":"2026-09-18T15:19:27.328499Z","end":"2026-09-18T15:19:27.705377Z","steps":["trace[409315426] 'process raft request' (duration: 376.222079ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:27.705473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:27.328488Z","time spent":"376.925725ms","remote":"127.0.0.1:38680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T15:19:27.705242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.70498ms","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":"warn","ts":"2026-09-18T15:19:27.705689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:27.335787Z","time spent":"369.41254ms","remote":"127.0.0.1:34232","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-18T15:19:27.705741Z","caller":"traceutil/trace.go:171","msg":"trace[1877440975] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"387.243774ms","start":"2026-09-18T15:19:27.318456Z","end":"2026-09-18T15:19:27.7057Z","steps":["trace[1877440975] 'agreement among raft nodes before linearized reading' (duration: 386.608139ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:19:27.705788Z","caller":"traceutil/trace.go:171","msg":"trace[1538120276] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"370.998764ms","start":"2026-09-18T15:19:27.334773Z","end":"2026-09-18T15:19:27.705772Z","steps":["trace[1538120276] 'process raft request' (duration: 370.074037ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:27.705813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:27.318442Z","time spent":"387.352155ms","remote":"127.0.0.1:38492","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":"info","ts":"2026-09-18T15:19:27.70588Z","caller":"traceutil/trace.go:171","msg":"trace[1393325669] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"371.273886ms","start":"2026-09-18T15:19:27.334595Z","end":"2026-09-18T15:19:27.705869Z","steps":["trace[1393325669] 'process raft request' (duration: 370.208356ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:27.705876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:27.334736Z","time spent":"371.093464ms","remote":"127.0.0.1:34232","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-18T15:19:27.705886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.314092ms","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-18T15:19:27.705923Z","caller":"traceutil/trace.go:171","msg":"trace[743103520] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"371.444907ms","start":"2026-09-18T15:19:27.334463Z","end":"2026-09-18T15:19:27.705908Z","steps":["trace[743103520] 'process raft request' (duration: 370.294917ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:19:27.705932Z","caller":"traceutil/trace.go:171","msg":"trace[1866693477] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"336.381922ms","start":"2026-09-18T15:19:27.369537Z","end":"2026-09-18T15:19:27.705919Z","steps":["trace[1866693477] 'agreement among raft nodes before linearized reading' (duration: 336.313982ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:27.705942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:27.334575Z","time spent":"371.330867ms","remote":"127.0.0.1:34232","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-18T15:19:27.705967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:27.369528Z","time spent":"336.431822ms","remote":"127.0.0.1:38518","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-18T15:19:27.70597Z","caller":"traceutil/trace.go:171","msg":"trace[1481575358] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"371.201565ms","start":"2026-09-18T15:19:27.334756Z","end":"2026-09-18T15:19:27.705958Z","steps":["trace[1481575358] 'process raft request' (duration: 370.069036ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:27.705989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:27.334442Z","time spent":"371.511668ms","remote":"127.0.0.1:34232","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-18T15:19:27.706025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:27.334745Z","time spent":"371.250116ms","remote":"127.0.0.1:34232","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-18T15:19:27.705563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.522536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T15:19:27.706158Z","caller":"traceutil/trace.go:171","msg":"trace[368468286] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:10; }","duration":"444.120451ms","start":"2026-09-18T15:19:27.262022Z","end":"2026-09-18T15:19:27.706143Z","steps":["trace[368468286] 'agreement among raft nodes before linearized reading' (duration: 443.506306ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:27.706188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:27.262017Z","time spent":"444.162051ms","remote":"127.0.0.1:38694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-18T15:19:27.705579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.758949ms","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-18T15:19:27.706288Z","caller":"traceutil/trace.go:171","msg":"trace[994780969] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"388.502577ms","start":"2026-09-18T15:19:27.317773Z","end":"2026-09-18T15:19:27.706275Z","steps":["trace[994780969] 'agreement among raft nodes before linearized reading' (duration: 387.77821ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:19:27.706237Z","caller":"traceutil/trace.go:171","msg":"trace[2011023978] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"386.824582ms","start":"2026-09-18T15:19:27.317917Z","end":"2026-09-18T15:19:27.704742Z","steps":["trace[2011023978] 'process raft request' (duration: 386.441189ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:27.706363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:27.317746Z","time spent":"388.570807ms","remote":"127.0.0.1:38518","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-18T15:19:27.705258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:27.25982Z","time spent":"445.432053ms","remote":"127.0.0.1:38486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":27,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"warn","ts":"2026-09-18T15:19:27.706511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:27.317897Z","time spent":"388.447836ms","remote":"127.0.0.1:34182","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-18T15:19:27.705655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.269978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-09-18T15:19:27.706699Z","caller":"traceutil/trace.go:171","msg":"trace[1265251031] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"238.342717ms","start":"2026-09-18T15:19:27.468341Z","end":"2026-09-18T15:19:27.706683Z","steps":["trace[1265251031] 'agreement among raft nodes before linearized reading' (duration: 237.233687ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:23.33097Z","caller":"traceutil/trace.go:171","msg":"trace[34002951] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"148.017308ms","start":"2026-09-18T15:20:23.182926Z","end":"2026-09-18T15:20:23.330943Z","steps":["trace[34002951] 'process raft request' (duration: 124.371827ms)","trace[34002951] 'compare' (duration: 23.22342ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:20:23.33116Z","caller":"traceutil/trace.go:171","msg":"trace[2033985504] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"128.325302ms","start":"2026-09-18T15:20:23.202719Z","end":"2026-09-18T15:20:23.331045Z","steps":["trace[2033985504] 'process raft request' (duration: 127.984833ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:23.331383Z","caller":"traceutil/trace.go:171","msg":"trace[2093092753] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"127.552771ms","start":"2026-09-18T15:20:23.203777Z","end":"2026-09-18T15:20:23.33133Z","steps":["trace[2093092753] 'process raft request' (duration: 126.991217ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:23.331658Z","caller":"traceutil/trace.go:171","msg":"trace[386589130] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"126.044421ms","start":"2026-09-18T15:20:23.205604Z","end":"2026-09-18T15:20:23.331648Z","steps":["trace[386589130] 'process raft request' (duration: 125.905687ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:23.331705Z","caller":"traceutil/trace.go:171","msg":"trace[2047909045] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"121.170563ms","start":"2026-09-18T15:20:23.210471Z","end":"2026-09-18T15:20:23.331642Z","steps":["trace[2047909045] 'process raft request' (duration: 121.117072ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:23.517103Z","caller":"traceutil/trace.go:171","msg":"trace[1617399538] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"175.654294ms","start":"2026-09-18T15:20:23.341407Z","end":"2026-09-18T15:20:23.517061Z","steps":["trace[1617399538] 'process raft request' (duration: 168.207088ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:23.517811Z","caller":"traceutil/trace.go:171","msg":"trace[1616134345] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"170.88329ms","start":"2026-09-18T15:20:23.346912Z","end":"2026-09-18T15:20:23.517795Z","steps":["trace[1616134345] 'process raft request' (duration: 169.895214ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:23.520217Z","caller":"traceutil/trace.go:171","msg":"trace[1519431110] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"167.986943ms","start":"2026-09-18T15:20:23.352196Z","end":"2026-09-18T15:20:23.520182Z","steps":["trace[1519431110] 'process raft request' (duration: 165.390175ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:23.520242Z","caller":"traceutil/trace.go:171","msg":"trace[1816285753] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"156.247914ms","start":"2026-09-18T15:20:23.363948Z","end":"2026-09-18T15:20:23.520195Z","steps":["trace[1816285753] 'process raft request' (duration: 155.69839ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:29.806693Z","caller":"traceutil/trace.go:171","msg":"trace[1810081780] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"102.403047ms","start":"2026-09-18T15:20:29.704261Z","end":"2026-09-18T15:20:29.806664Z","steps":["trace[1810081780] 'process raft request' (duration: 102.244663ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:30.232332Z","caller":"traceutil/trace.go:171","msg":"trace[854900866] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"278.406397ms","start":"2026-09-18T15:20:29.953901Z","end":"2026-09-18T15:20:30.232307Z","steps":["trace[854900866] 'process raft request' (duration: 278.222582ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:20:30.695208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.044527ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:20:30.69539Z","caller":"traceutil/trace.go:171","msg":"trace[869741993] linearizableReadLoop","detail":"{readStateIndex:709; appliedIndex:707; }","duration":"521.468037ms","start":"2026-09-18T15:20:30.173868Z","end":"2026-09-18T15:20:30.695336Z","steps":["trace[869741993] 'read index received' (duration: 58.171701ms)","trace[869741993] 'applied index is now lower than readState.Index' (duration: 463.294896ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:20:30.695609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.706543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-09-18T15:20:30.695669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.527778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:20:30.695697Z","caller":"traceutil/trace.go:171","msg":"trace[207060662] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:684; }","duration":"521.811935ms","start":"2026-09-18T15:20:30.173862Z","end":"2026-09-18T15:20:30.695674Z","steps":["trace[207060662] 'agreement among raft nodes before linearized reading' (duration: 521.545699ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:30.695719Z","caller":"traceutil/trace.go:171","msg":"trace[774578928] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:684; }","duration":"219.62909ms","start":"2026-09-18T15:20:30.476071Z","end":"2026-09-18T15:20:30.6957Z","steps":["trace[774578928] 'agreement among raft nodes before linearized reading' (duration: 219.537398ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:20:30.695738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:20:30.173821Z","time spent":"521.908168ms","remote":"127.0.0.1:38694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-18T15:20:30.69605Z","caller":"traceutil/trace.go:171","msg":"trace[373778100] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"659.66678ms","start":"2026-09-18T15:20:30.035699Z","end":"2026-09-18T15:20:30.695366Z","steps":["trace[373778100] 'process raft request' (duration: 276.023177ms)","trace[373778100] 'compare' (duration: 382.637318ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:20:30.696353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.965776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-09-18T15:20:30.696396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:20:30.035653Z","time spent":"660.581522ms","remote":"127.0.0.1:38498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:20:30.696419Z","caller":"traceutil/trace.go:171","msg":"trace[1735249317] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:684; }","duration":"517.064018ms","start":"2026-09-18T15:20:30.179339Z","end":"2026-09-18T15:20:30.696403Z","steps":["trace[1735249317] 'agreement among raft nodes before linearized reading' (duration: 516.890013ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:20:30.696472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:20:30.179323Z","time spent":"517.13584ms","remote":"127.0.0.1:38694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-18T15:20:31.266134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.469996ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:20:31.266261Z","caller":"traceutil/trace.go:171","msg":"trace[1063081706] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"566.565702ms","start":"2026-09-18T15:20:30.699673Z","end":"2026-09-18T15:20:31.266239Z","steps":["trace[1063081706] 'process raft request' (duration: 380.860609ms)","trace[1063081706] 'compare' (duration: 185.298712ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:20:31.266329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:20:30.699652Z","time spent":"566.648154ms","remote":"127.0.0.1:38694","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-09-18T15:20:31.307963Z","caller":"traceutil/trace.go:171","msg":"trace[2145584281] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"554.149855ms","start":"2026-09-18T15:20:30.753778Z","end":"2026-09-18T15:20:31.307928Z","steps":["trace[2145584281] 'process raft request' (duration: 554.049493ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:31.308039Z","caller":"traceutil/trace.go:171","msg":"trace[808451401] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"607.817125ms","start":"2026-09-18T15:20:30.700157Z","end":"2026-09-18T15:20:31.307974Z","steps":["trace[808451401] 'process raft request' (duration: 607.501398ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:20:31.308302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:20:30.753748Z","time spent":"554.389421ms","remote":"127.0.0.1:38656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T15:20:31.308331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:20:30.700132Z","time spent":"608.057731ms","remote":"127.0.0.1:38694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:20:33.12593Z","caller":"traceutil/trace.go:171","msg":"trace[676372478] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"103.389239ms","start":"2026-09-18T15:20:33.022508Z","end":"2026-09-18T15:20:33.125897Z","steps":["trace[676372478] 'process raft request' (duration: 99.498425ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:41.158402Z","caller":"traceutil/trace.go:171","msg":"trace[1713934618] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"125.881881ms","start":"2026-09-18T15:20:41.032488Z","end":"2026-09-18T15:20:41.15837Z","steps":["trace[1713934618] 'process raft request' (duration: 125.728148ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:48.042116Z","caller":"traceutil/trace.go:171","msg":"trace[1349883507] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"129.830939ms","start":"2026-09-18T15:20:47.912254Z","end":"2026-09-18T15:20:48.042085Z","steps":["trace[1349883507] 'process raft request' (duration: 129.509892ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:48.204907Z","caller":"traceutil/trace.go:171","msg":"trace[1340369106] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"157.636093ms","start":"2026-09-18T15:20:48.047228Z","end":"2026-09-18T15:20:48.204864Z","steps":["trace[1340369106] 'process raft request' (duration: 155.996868ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:48.216562Z","caller":"traceutil/trace.go:171","msg":"trace[1034949190] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"165.291969ms","start":"2026-09-18T15:20:48.051242Z","end":"2026-09-18T15:20:48.216534Z","steps":["trace[1034949190] 'process raft request' (duration: 164.862049ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:21:19.326275Z","caller":"traceutil/trace.go:171","msg":"trace[1781064571] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"383.51866ms","start":"2026-09-18T15:21:18.942729Z","end":"2026-09-18T15:21:19.326248Z","steps":["trace[1781064571] 'process raft request' (duration: 383.379588ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:21:19.326426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:21:18.942706Z","time spent":"383.643573ms","remote":"127.0.0.1:38694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:21:19.334726Z","caller":"traceutil/trace.go:171","msg":"trace[844340109] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"364.786054ms","start":"2026-09-18T15:21:18.969888Z","end":"2026-09-18T15:21:19.334674Z","steps":["trace[844340109] 'process raft request' (duration: 364.446128ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:21:19.334771Z","caller":"traceutil/trace.go:171","msg":"trace[1973606607] linearizableReadLoop","detail":"{readStateIndex:1292; appliedIndex:1290; }","duration":"210.594879ms","start":"2026-09-18T15:21:19.124158Z","end":"2026-09-18T15:21:19.334753Z","steps":["trace[1973606607] 'read index received' (duration: 202.017706ms)","trace[1973606607] 'applied index is now lower than readState.Index' (duration: 8.575833ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:21:19.335087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:21:18.969869Z","time spent":"364.982467ms","remote":"127.0.0.1:38694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:21:19.335163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.978175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.118\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-18T15:21:19.335265Z","caller":"traceutil/trace.go:171","msg":"trace[1839889918] range","detail":"{range_begin:/registry/masterleases/162.253.55.118; range_end:; response_count:1; response_revision:1255; }","duration":"211.096657ms","start":"2026-09-18T15:21:19.124149Z","end":"2026-09-18T15:21:19.335246Z","steps":["trace[1839889918] 'agreement among raft nodes before linearized reading' (duration: 210.68202ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:21:36.595883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.784725ms","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-18T15:21:36.595998Z","caller":"traceutil/trace.go:171","msg":"trace[175937486] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1398; }","duration":"115.941197ms","start":"2026-09-18T15:21:36.480033Z","end":"2026-09-18T15:21:36.595974Z","steps":["trace[175937486] 'range keys from in-memory index tree' (duration: 115.590482ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:21:36.595896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.233932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T15:21:36.596126Z","caller":"traceutil/trace.go:171","msg":"trace[356645961] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1398; }","duration":"102.508106ms","start":"2026-09-18T15:21:36.493586Z","end":"2026-09-18T15:21:36.596094Z","steps":["trace[356645961] 'count revisions from in-memory index tree' (duration: 102.152341ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:21:41.610704Z","caller":"traceutil/trace.go:171","msg":"trace[1460681255] transaction","detail":"{read_only:false; response_revision:1507; number_of_response:1; }","duration":"179.575402ms","start":"2026-09-18T15:21:41.431069Z","end":"2026-09-18T15:21:41.610644Z","steps":["trace[1460681255] 'process raft request' (duration: 115.48815ms)","trace[1460681255] 'compare' (duration: 63.933359ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:21:41.668343Z","caller":"traceutil/trace.go:171","msg":"trace[1149203688] linearizableReadLoop","detail":"{readStateIndex:1556; appliedIndex:1554; }","duration":"212.730536ms","start":"2026-09-18T15:21:41.455581Z","end":"2026-09-18T15:21:41.668311Z","steps":["trace[1149203688] 'read index received' (duration: 90.986306ms)","trace[1149203688] 'applied index is now lower than readState.Index' (duration: 121.74291ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:21:41.668446Z","caller":"traceutil/trace.go:171","msg":"trace[103681050] transaction","detail":"{read_only:false; response_revision:1508; number_of_response:1; }","duration":"220.157886ms","start":"2026-09-18T15:21:41.448248Z","end":"2026-09-18T15:21:41.668406Z","steps":["trace[103681050] 'process raft request' (duration: 219.870091ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:21:41.66861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.005841ms","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-18T15:21:41.668686Z","caller":"traceutil/trace.go:171","msg":"trace[1191826650] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1508; }","duration":"213.126732ms","start":"2026-09-18T15:21:41.45554Z","end":"2026-09-18T15:21:41.668667Z","steps":["trace[1191826650] 'agreement among raft nodes before linearized reading' (duration: 212.915019ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:21:41.680971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.189145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:21:41.681043Z","caller":"traceutil/trace.go:171","msg":"trace[403861814] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1509; }","duration":"205.302647ms","start":"2026-09-18T15:21:41.475725Z","end":"2026-09-18T15:21:41.681028Z","steps":["trace[403861814] 'agreement among raft nodes before linearized reading' (duration: 205.172735ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:21:42.676096Z","caller":"traceutil/trace.go:171","msg":"trace[878748959] transaction","detail":"{read_only:false; response_revision:1519; number_of_response:1; }","duration":"232.442858ms","start":"2026-09-18T15:21:42.44362Z","end":"2026-09-18T15:21:42.676063Z","steps":["trace[878748959] 'process raft request' (duration: 174.156433ms)","trace[878748959] 'compare' (duration: 58.167693ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:21:42.67622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.068002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:21:42.676086Z","caller":"traceutil/trace.go:171","msg":"trace[1284655983] linearizableReadLoop","detail":"{readStateIndex:1567; appliedIndex:1566; }","duration":"198.947081ms","start":"2026-09-18T15:21:42.477111Z","end":"2026-09-18T15:21:42.676058Z","steps":["trace[1284655983] 'read index received' (duration: 140.674716ms)","trace[1284655983] 'applied index is now lower than readState.Index' (duration: 58.271305ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:21:42.676268Z","caller":"traceutil/trace.go:171","msg":"trace[1345366602] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1519; }","duration":"199.193805ms","start":"2026-09-18T15:21:42.477059Z","end":"2026-09-18T15:21:42.676253Z","steps":["trace[1345366602] 'agreement among raft nodes before linearized reading' (duration: 199.080793ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:21:44.585801Z","caller":"traceutil/trace.go:171","msg":"trace[2096922524] linearizableReadLoop","detail":"{readStateIndex:1575; appliedIndex:1574; }","duration":"112.041343ms","start":"2026-09-18T15:21:44.473739Z","end":"2026-09-18T15:21:44.58578Z","steps":["trace[2096922524] 'read index received' (duration: 112.006432ms)","trace[2096922524] 'applied index is now lower than readState.Index' (duration: 33.601µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:21:44.585986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.199605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:21:44.586009Z","caller":"traceutil/trace.go:171","msg":"trace[1149271429] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1527; }","duration":"112.315287ms","start":"2026-09-18T15:21:44.473686Z","end":"2026-09-18T15:21:44.586001Z","steps":["trace[1149271429] 'agreement among raft nodes before linearized reading' (duration: 112.174295ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:21:44.586268Z","caller":"traceutil/trace.go:171","msg":"trace[1492989316] transaction","detail":"{read_only:false; response_revision:1527; number_of_response:1; }","duration":"191.834723ms","start":"2026-09-18T15:21:44.394426Z","end":"2026-09-18T15:21:44.586261Z","steps":["trace[1492989316] 'process raft request' (duration: 191.224404ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:22:04.089741Z","caller":"traceutil/trace.go:171","msg":"trace[570063897] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"115.763668ms","start":"2026-09-18T15:22:03.973963Z","end":"2026-09-18T15:22:04.089727Z","steps":["trace[570063897] 'process raft request' (duration: 97.213463ms)","trace[570063897] 'compare' (duration: 18.17449ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:22:11.714263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.45914ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:22:11.714364Z","caller":"traceutil/trace.go:171","msg":"trace[916021414] linearizableReadLoop","detail":"{readStateIndex:2020; appliedIndex:2019; }","duration":"293.363579ms","start":"2026-09-18T15:22:11.420985Z","end":"2026-09-18T15:22:11.714349Z","steps":["trace[916021414] 'read index received' (duration: 141.663077ms)","trace[916021414] 'applied index is now lower than readState.Index' (duration: 151.699052ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:22:11.714937Z","caller":"traceutil/trace.go:171","msg":"trace[1101421947] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"424.8309ms","start":"2026-09-18T15:22:11.290091Z","end":"2026-09-18T15:22:11.714922Z","steps":["trace[1101421947] 'process raft request' (duration: 272.613789ms)","trace[1101421947] 'compare' (duration: 151.240247ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:22:11.714978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.888868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7d89c322-dfc3-46c1-a778-595085351ce5\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-18T15:22:11.715082Z","caller":"traceutil/trace.go:171","msg":"trace[749602737] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7d89c322-dfc3-46c1-a778-595085351ce5; range_end:; response_count:1; response_revision:1945; }","duration":"294.118711ms","start":"2026-09-18T15:22:11.420941Z","end":"2026-09-18T15:22:11.71506Z","steps":["trace[749602737] 'agreement among raft nodes before linearized reading' (duration: 293.736026ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:11.715005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.619688ms","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":"warn","ts":"2026-09-18T15:22:11.715305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:22:11.290023Z","time spent":"424.953102ms","remote":"127.0.0.1:38694","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-09-18T15:22:11.71534Z","caller":"traceutil/trace.go:171","msg":"trace[1955528932] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1945; }","duration":"255.000753ms","start":"2026-09-18T15:22:11.460306Z","end":"2026-09-18T15:22:11.715307Z","steps":["trace[1955528932] 'agreement among raft nodes before linearized reading' (duration: 254.420065ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:12.445616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.278346ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:22:12.445915Z","caller":"traceutil/trace.go:171","msg":"trace[1442930206] transaction","detail":"{read_only:false; response_revision:1948; number_of_response:1; }","duration":"440.361667ms","start":"2026-09-18T15:22:12.005537Z","end":"2026-09-18T15:22:12.445898Z","steps":["trace[1442930206] 'process raft request' (duration: 440.319906ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:12.44599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:22:12.005513Z","time spent":"440.444599ms","remote":"127.0.0.1:38694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:22:12.44602Z","caller":"traceutil/trace.go:171","msg":"trace[670509974] transaction","detail":"{read_only:false; response_revision:1946; number_of_response:1; }","duration":"723.121102ms","start":"2026-09-18T15:22:11.722876Z","end":"2026-09-18T15:22:12.445997Z","steps":["trace[670509974] 'process raft request' (duration: 116.3836ms)","trace[670509974] 'compare' (duration: 606.111964ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:22:12.446157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:22:11.722851Z","time spent":"723.242204ms","remote":"127.0.0.1:38606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:22:12.446246Z","caller":"traceutil/trace.go:171","msg":"trace[1956032478] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"619.64487ms","start":"2026-09-18T15:22:11.826591Z","end":"2026-09-18T15:22:12.446236Z","steps":["trace[1956032478] 'process raft request' (duration: 619.136143ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:12.446301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:22:11.82656Z","time spent":"619.7118ms","remote":"127.0.0.1:38694","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-18T15:22:12.446299Z","caller":"traceutil/trace.go:171","msg":"trace[786804731] linearizableReadLoop","detail":"{readStateIndex:2022; appliedIndex:2020; }","duration":"560.547211ms","start":"2026-09-18T15:22:11.885735Z","end":"2026-09-18T15:22:12.446282Z","steps":["trace[786804731] 'read index received' (duration: 17.152639ms)","trace[786804731] 'applied index is now lower than readState.Index' (duration: 543.393322ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:22:12.446381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.664144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7d89c322-dfc3-46c1-a778-595085351ce5\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-09-18T15:22:12.446405Z","caller":"traceutil/trace.go:171","msg":"trace[369174800] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7d89c322-dfc3-46c1-a778-595085351ce5; range_end:; response_count:1; response_revision:1948; }","duration":"560.767175ms","start":"2026-09-18T15:22:11.88563Z","end":"2026-09-18T15:22:12.446397Z","steps":["trace[369174800] 'agreement among raft nodes before linearized reading' (duration: 560.718304ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:12.44642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:22:11.885608Z","time spent":"560.807145ms","remote":"127.0.0.1:38606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3770,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7d89c322-dfc3-46c1-a778-595085351ce5\" "} {"level":"warn","ts":"2026-09-18T15:22:12.456652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.556723ms","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-18T15:22:12.456709Z","caller":"traceutil/trace.go:171","msg":"trace[777654896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1949; }","duration":"289.649705ms","start":"2026-09-18T15:22:12.167046Z","end":"2026-09-18T15:22:12.456695Z","steps":["trace[777654896] 'agreement among raft nodes before linearized reading' (duration: 289.536433ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:12.456688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.958347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-09-18T15:22:12.456652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.598788ms","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-18T15:22:12.456768Z","caller":"traceutil/trace.go:171","msg":"trace[1049719325] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1949; }","duration":"274.0955ms","start":"2026-09-18T15:22:12.182656Z","end":"2026-09-18T15:22:12.456752Z","steps":["trace[1049719325] 'agreement among raft nodes before linearized reading' (duration: 273.877037ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:22:12.456817Z","caller":"traceutil/trace.go:171","msg":"trace[2048492164] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1949; }","duration":"466.816561ms","start":"2026-09-18T15:22:11.989992Z","end":"2026-09-18T15:22:12.456809Z","steps":["trace[2048492164] 'agreement among raft nodes before linearized reading' (duration: 466.526347ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:12.456819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.804133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"warn","ts":"2026-09-18T15:22:12.456845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:22:11.989972Z","time spent":"466.864232ms","remote":"127.0.0.1:38694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-18T15:22:12.456877Z","caller":"traceutil/trace.go:171","msg":"trace[663696033] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1949; }","duration":"364.969545ms","start":"2026-09-18T15:22:12.091889Z","end":"2026-09-18T15:22:12.456859Z","steps":["trace[663696033] 'agreement among raft nodes before linearized reading' (duration: 364.731832ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:22:12.456908Z","caller":"traceutil/trace.go:171","msg":"trace[1062099274] transaction","detail":"{read_only:false; response_revision:1949; number_of_response:1; }","duration":"285.338433ms","start":"2026-09-18T15:22:12.171558Z","end":"2026-09-18T15:22:12.456896Z","steps":["trace[1062099274] 'process raft request' (duration: 284.868995ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:12.456912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:22:12.091869Z","time spent":"365.034497ms","remote":"127.0.0.1:38694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-09-18T15:22:28.166898Z","caller":"traceutil/trace.go:171","msg":"trace[662590075] linearizableReadLoop","detail":"{readStateIndex:2155; appliedIndex:2154; }","duration":"430.1186ms","start":"2026-09-18T15:22:27.736761Z","end":"2026-09-18T15:22:28.16688Z","steps":["trace[662590075] 'read index received' (duration: 429.973668ms)","trace[662590075] 'applied index is now lower than readState.Index' (duration: 144.312µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:22:28.166952Z","caller":"traceutil/trace.go:171","msg":"trace[944487659] transaction","detail":"{read_only:false; response_revision:2077; number_of_response:1; }","duration":"455.631875ms","start":"2026-09-18T15:22:27.711305Z","end":"2026-09-18T15:22:28.166937Z","steps":["trace[944487659] 'process raft request' (duration: 455.466923ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:28.167023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.279671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-09-18T15:22:28.167048Z","caller":"traceutil/trace.go:171","msg":"trace[2141722510] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2077; }","duration":"430.363383ms","start":"2026-09-18T15:22:27.736678Z","end":"2026-09-18T15:22:28.167041Z","steps":["trace[2141722510] 'agreement among raft nodes before linearized reading' (duration: 430.297872ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:28.167067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:22:27.736633Z","time spent":"430.428703ms","remote":"127.0.0.1:38486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":141,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"warn","ts":"2026-09-18T15:22:28.167076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:22:27.711284Z","time spent":"455.705786ms","remote":"127.0.0.1:38694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:22:28.16714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.041592ms","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-18T15:22:28.167176Z","caller":"traceutil/trace.go:171","msg":"trace[2072948584] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2077; }","duration":"347.107062ms","start":"2026-09-18T15:22:27.820058Z","end":"2026-09-18T15:22:28.167165Z","steps":["trace[2072948584] 'agreement among raft nodes before linearized reading' (duration: 346.988991ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:28.167198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:22:27.820042Z","time spent":"347.150004ms","remote":"127.0.0.1:34028","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-18T15:22:45.201687Z","caller":"traceutil/trace.go:171","msg":"trace[2075616498] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"107.240581ms","start":"2026-09-18T15:22:45.094413Z","end":"2026-09-18T15:22:45.201653Z","steps":["trace[2075616498] 'process raft request' (duration: 96.854621ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:22:50.824826Z","caller":"traceutil/trace.go:171","msg":"trace[704470973] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"141.498834ms","start":"2026-09-18T15:22:50.683307Z","end":"2026-09-18T15:22:50.824806Z","steps":["trace[704470973] 'process raft request' (duration: 134.945986ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:22:50.825355Z","caller":"traceutil/trace.go:171","msg":"trace[638909286] transaction","detail":"{read_only:false; response_revision:2204; number_of_response:1; }","duration":"138.570455ms","start":"2026-09-18T15:22:50.686748Z","end":"2026-09-18T15:22:50.825319Z","steps":["trace[638909286] 'process raft request' (duration: 138.016118ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:22:51.002363Z","caller":"traceutil/trace.go:171","msg":"trace[1217681502] linearizableReadLoop","detail":"{readStateIndex:2290; appliedIndex:2289; }","duration":"142.565928ms","start":"2026-09-18T15:22:50.859762Z","end":"2026-09-18T15:22:51.002328Z","steps":["trace[1217681502] 'read index received' (duration: 99.280042ms)","trace[1217681502] 'applied index is now lower than readState.Index' (duration: 43.283576ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:22:51.002503Z","caller":"traceutil/trace.go:171","msg":"trace[222105441] transaction","detail":"{read_only:false; response_revision:2206; number_of_response:1; }","duration":"147.304421ms","start":"2026-09-18T15:22:50.855184Z","end":"2026-09-18T15:22:51.002488Z","steps":["trace[222105441] 'process raft request' (duration: 103.938054ms)","trace[222105441] 'compare' (duration: 43.022283ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:22:51.002751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.962873ms","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-18T15:22:51.002854Z","caller":"traceutil/trace.go:171","msg":"trace[1002977932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2206; }","duration":"143.091736ms","start":"2026-09-18T15:22:50.859732Z","end":"2026-09-18T15:22:51.002824Z","steps":["trace[1002977932] 'agreement among raft nodes before linearized reading' (duration: 142.832502ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:51.003306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.479144ms","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-18T15:22:51.003381Z","caller":"traceutil/trace.go:171","msg":"trace[1739380807] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2206; }","duration":"129.603405ms","start":"2026-09-18T15:22:50.873761Z","end":"2026-09-18T15:22:51.003364Z","steps":["trace[1739380807] 'agreement among raft nodes before linearized reading' (duration: 129.358022ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:22:51.376011Z","caller":"traceutil/trace.go:171","msg":"trace[542513942] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"114.152468ms","start":"2026-09-18T15:22:51.26184Z","end":"2026-09-18T15:22:51.375992Z","steps":["trace[542513942] 'process raft request' (duration: 114.043886ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:22:51.398962Z","caller":"traceutil/trace.go:171","msg":"trace[658521743] transaction","detail":"{read_only:false; response_revision:2210; number_of_response:1; }","duration":"137.049822ms","start":"2026-09-18T15:22:51.261873Z","end":"2026-09-18T15:22:51.398923Z","steps":["trace[658521743] 'process raft request' (duration: 136.606047ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:51.981335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.510298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:22:51.98153Z","caller":"traceutil/trace.go:171","msg":"trace[550933095] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2210; }","duration":"507.742821ms","start":"2026-09-18T15:22:51.473762Z","end":"2026-09-18T15:22:51.981505Z","steps":["trace[550933095] 'range keys from in-memory index tree' (duration: 507.384515ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:51.981632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:22:51.473746Z","time spent":"507.868272ms","remote":"127.0.0.1:38420","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-09-18T15:24:14.272665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.174854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:24:14.272756Z","caller":"traceutil/trace.go:171","msg":"trace[1905476185] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2765; }","duration":"297.3147ms","start":"2026-09-18T15:24:13.975424Z","end":"2026-09-18T15:24:14.272738Z","steps":["trace[1905476185] 'range keys from in-memory index tree' (duration: 297.10957ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:24:19.64295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.719409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9282"} {"level":"info","ts":"2026-09-18T15:24:19.643333Z","caller":"traceutil/trace.go:171","msg":"trace[569636343] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:2792; }","duration":"163.135537ms","start":"2026-09-18T15:24:19.480171Z","end":"2026-09-18T15:24:19.643307Z","steps":["trace[569636343] 'range keys from in-memory index tree' (duration: 162.560692ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:28:33.901684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.28205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:28:33.901803Z","caller":"traceutil/trace.go:171","msg":"trace[1841817003] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:4712; }","duration":"134.465554ms","start":"2026-09-18T15:28:33.767311Z","end":"2026-09-18T15:28:33.901777Z","steps":["trace[1841817003] 'count revisions from in-memory index tree' (duration: 134.171668ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:28:33.901694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.75136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T15:28:33.902008Z","caller":"traceutil/trace.go:171","msg":"trace[1209940356] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4712; }","duration":"130.095798ms","start":"2026-09-18T15:28:33.771861Z","end":"2026-09-18T15:28:33.901957Z","steps":["trace[1209940356] 'count revisions from in-memory index tree' (duration: 129.654808ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:28:35.139714Z","caller":"traceutil/trace.go:171","msg":"trace[319796281] transaction","detail":"{read_only:false; response_revision:4780; number_of_response:1; }","duration":"156.453086ms","start":"2026-09-18T15:28:34.983228Z","end":"2026-09-18T15:28:35.139681Z","steps":["trace[319796281] 'process raft request' (duration: 155.629639ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:28:35.139751Z","caller":"traceutil/trace.go:171","msg":"trace[415199238] linearizableReadLoop","detail":"{readStateIndex:4962; appliedIndex:4961; }","duration":"155.278943ms","start":"2026-09-18T15:28:34.984447Z","end":"2026-09-18T15:28:35.139726Z","steps":["trace[415199238] 'read index received' (duration: 154.400375ms)","trace[415199238] 'applied index is now lower than readState.Index' (duration: 877.508µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:28:35.13997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.508817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-18T15:28:35.139993Z","caller":"traceutil/trace.go:171","msg":"trace[1603762005] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4780; }","duration":"155.580318ms","start":"2026-09-18T15:28:34.984406Z","end":"2026-09-18T15:28:35.139986Z","steps":["trace[1603762005] 'agreement among raft nodes before linearized reading' (duration: 155.442145ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:28:35.140171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.424785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4737"} {"level":"info","ts":"2026-09-18T15:28:35.14021Z","caller":"traceutil/trace.go:171","msg":"trace[1888478197] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4780; }","duration":"152.473497ms","start":"2026-09-18T15:28:34.987729Z","end":"2026-09-18T15:28:35.140203Z","steps":["trace[1888478197] 'agreement among raft nodes before linearized reading' (duration: 152.397376ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:28:35.140795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.878955ms","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-09-18T15:28:35.140845Z","caller":"traceutil/trace.go:171","msg":"trace[1720539290] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4780; }","duration":"145.951396ms","start":"2026-09-18T15:28:34.994881Z","end":"2026-09-18T15:28:35.140833Z","steps":["trace[1720539290] 'agreement among raft nodes before linearized reading' (duration: 145.854054ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:28:41.446727Z","caller":"traceutil/trace.go:171","msg":"trace[985364104] transaction","detail":"{read_only:false; response_revision:4933; number_of_response:1; }","duration":"129.993827ms","start":"2026-09-18T15:28:41.316684Z","end":"2026-09-18T15:28:41.446678Z","steps":["trace[985364104] 'process raft request' (duration: 125.185662ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:28:41.477902Z","caller":"traceutil/trace.go:171","msg":"trace[168803355] linearizableReadLoop","detail":"{readStateIndex:5118; appliedIndex:5116; }","duration":"109.704357ms","start":"2026-09-18T15:28:41.36818Z","end":"2026-09-18T15:28:41.477884Z","steps":["trace[168803355] 'read index received' (duration: 73.680855ms)","trace[168803355] 'applied index is now lower than readState.Index' (duration: 36.022922ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:28:41.477972Z","caller":"traceutil/trace.go:171","msg":"trace[938760018] transaction","detail":"{read_only:false; response_revision:4934; number_of_response:1; }","duration":"140.434943ms","start":"2026-09-18T15:28:41.337522Z","end":"2026-09-18T15:28:41.477956Z","steps":["trace[938760018] 'process raft request' (duration: 140.271299ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:28:41.478619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.43357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-09-18T15:28:41.478649Z","caller":"traceutil/trace.go:171","msg":"trace[112690288] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4934; }","duration":"110.498512ms","start":"2026-09-18T15:28:41.368142Z","end":"2026-09-18T15:28:41.47864Z","steps":["trace[112690288] 'agreement among raft nodes before linearized reading' (duration: 109.827999ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:28:41.677493Z","caller":"traceutil/trace.go:171","msg":"trace[36363463] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"193.51701ms","start":"2026-09-18T15:28:41.483954Z","end":"2026-09-18T15:28:41.677471Z","steps":["trace[36363463] 'process raft request' (duration: 151.431579ms)","trace[36363463] 'compare' (duration: 41.886327ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:28:41.678031Z","caller":"traceutil/trace.go:171","msg":"trace[424663197] linearizableReadLoop","detail":"{readStateIndex:5122; appliedIndex:5118; }","duration":"166.084558ms","start":"2026-09-18T15:28:41.511913Z","end":"2026-09-18T15:28:41.677997Z","steps":["trace[424663197] 'read index received' (duration: 8.485918ms)","trace[424663197] 'applied index is now lower than readState.Index' (duration: 157.59729ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:28:41.67833Z","caller":"traceutil/trace.go:171","msg":"trace[257340601] transaction","detail":"{read_only:false; response_revision:4937; number_of_response:1; }","duration":"193.097762ms","start":"2026-09-18T15:28:41.485218Z","end":"2026-09-18T15:28:41.678316Z","steps":["trace[257340601] 'process raft request' (duration: 192.197274ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:28:41.678253Z","caller":"traceutil/trace.go:171","msg":"trace[321317959] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"191.237506ms","start":"2026-09-18T15:28:41.486982Z","end":"2026-09-18T15:28:41.67822Z","steps":["trace[321317959] 'process raft request' (duration: 190.804596ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:28:41.678598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.63615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-09-18T15:28:41.678685Z","caller":"traceutil/trace.go:171","msg":"trace[2097930541] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4938; }","duration":"166.803613ms","start":"2026-09-18T15:28:41.511864Z","end":"2026-09-18T15:28:41.678667Z","steps":["trace[2097930541] 'agreement among raft nodes before linearized reading' (duration: 166.325984ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:28:54.80841Z","caller":"traceutil/trace.go:171","msg":"trace[959269637] transaction","detail":"{read_only:false; response_revision:5109; number_of_response:1; }","duration":"247.700678ms","start":"2026-09-18T15:28:54.560687Z","end":"2026-09-18T15:28:54.808387Z","steps":["trace[959269637] 'process raft request' (duration: 239.568491ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:28:54.808619Z","caller":"traceutil/trace.go:171","msg":"trace[151030978] transaction","detail":"{read_only:false; response_revision:5110; number_of_response:1; }","duration":"247.83926ms","start":"2026-09-18T15:28:54.56077Z","end":"2026-09-18T15:28:54.808609Z","steps":["trace[151030978] 'process raft request' (duration: 247.453442ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:28:54.809185Z","caller":"traceutil/trace.go:171","msg":"trace[330918072] transaction","detail":"{read_only:false; response_revision:5111; number_of_response:1; }","duration":"248.141875ms","start":"2026-09-18T15:28:54.561027Z","end":"2026-09-18T15:28:54.809169Z","steps":["trace[330918072] 'process raft request' (duration: 247.249018ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:28:54.809227Z","caller":"traceutil/trace.go:171","msg":"trace[280870548] transaction","detail":"{read_only:false; response_revision:5112; number_of_response:1; }","duration":"233.97071ms","start":"2026-09-18T15:28:54.575232Z","end":"2026-09-18T15:28:54.809202Z","steps":["trace[280870548] 'process raft request' (duration: 233.078092ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:29:25.879677Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2828} {"level":"info","ts":"2026-09-18T15:29:25.983248Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2828,"took":"102.185444ms","hash":4137773677,"current-db-size-bytes":53288960,"current-db-size":"53 MB","current-db-size-in-use-bytes":28454912,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-18T15:29:25.983311Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4137773677,"revision":2828,"compact-revision":-1} {"level":"info","ts":"2026-09-18T15:32:35.245464Z","caller":"traceutil/trace.go:171","msg":"trace[523677741] transaction","detail":"{read_only:false; response_revision:6712; number_of_response:1; }","duration":"101.584338ms","start":"2026-09-18T15:32:35.143847Z","end":"2026-09-18T15:32:35.245431Z","steps":["trace[523677741] 'process raft request' (duration: 81.797907ms)","trace[523677741] 'compare' (duration: 19.239787ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:32:35.27864Z","caller":"traceutil/trace.go:171","msg":"trace[1876190451] transaction","detail":"{read_only:false; response_revision:6714; number_of_response:1; }","duration":"108.704914ms","start":"2026-09-18T15:32:35.16991Z","end":"2026-09-18T15:32:35.278615Z","steps":["trace[1876190451] 'process raft request' (duration: 108.664932ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:32:35.278677Z","caller":"traceutil/trace.go:171","msg":"trace[488686866] transaction","detail":"{read_only:false; response_revision:6713; number_of_response:1; }","duration":"112.831443ms","start":"2026-09-18T15:32:35.165805Z","end":"2026-09-18T15:32:35.278636Z","steps":["trace[488686866] 'process raft request' (duration: 112.638984ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:34:25.886783Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5409} {"level":"info","ts":"2026-09-18T15:34:25.961303Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5409,"took":"73.393061ms","hash":1525461229,"current-db-size-bytes":53288960,"current-db-size":"53 MB","current-db-size-in-use-bytes":18591744,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-18T15:34:25.961351Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1525461229,"revision":5409,"compact-revision":2828}