{"level":"warn","ts":"2026-03-30T17:59:03.865248Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-30T17:59:03.865332Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22: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.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-03-30T17:59:03.865398Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-30T17:59:03.86541Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-03-30T17:59:03.865427Z","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-03-30T17:59:03.86604Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-03-30T17:59:03.866115Z","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":16,"max-cpu-available":16,"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.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-03-30T17:59:03.870425Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.02412ms"} {"level":"info","ts":"2026-03-30T17:59:03.880952Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-03-30T17:59:03.88104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-03-30T17:59:03.881065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-03-30T17:59:03.881076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-30T17:59:03.881084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-03-30T17:59:03.881129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-03-30T17:59:03.886856Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-30T17:59:03.888136Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-30T17:59:03.88903Z","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-03-30T17:59:03.891403Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-30T17:59:03.891601Z","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-03-30T17:59:03.891651Z","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-03-30T17:59:03.891664Z","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-03-30T17:59:03.891818Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-30T17:59:03.893921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-03-30T17:59:03.894143Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-03-30T17:59:03.896367Z","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-03-30T17:59:03.896607Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-30T17:59:03.896636Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-30T17:59:03.896689Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-03-30T17:59:03.896818Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-03-30T17:59:04.881391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-03-30T17:59:04.881454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-30T17:59:04.881503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-03-30T17:59:04.881524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-03-30T17:59:04.881536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-03-30T17:59:04.881553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-03-30T17:59:04.881568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-03-30T17:59:04.882447Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-30T17:59:04.883533Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-30T17:59:04.883524Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-03-30T17:59:04.883624Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-30T17:59:04.883858Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-30T17:59:04.883945Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-30T17:59:04.88414Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-03-30T17:59:04.884261Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-30T17:59:04.884301Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-30T17:59:04.886759Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-30T17:59:04.886973Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"warn","ts":"2026-03-30T17:59:09.579999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.679365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:59:09.580122Z","caller":"traceutil/trace.go:171","msg":"trace[1454564497] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:218; }","duration":"136.900841ms","start":"2026-03-30T17:59:09.443204Z","end":"2026-03-30T17:59:09.580105Z","steps":["trace[1454564497] 'range keys from in-memory index tree' (duration: 136.561422ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:59:21.908943Z","caller":"traceutil/trace.go:171","msg":"trace[1910982869] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"248.823487ms","start":"2026-03-30T17:59:21.660092Z","end":"2026-03-30T17:59:21.908916Z","steps":["trace[1910982869] 'process raft request' (duration: 248.667773ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:59:21.936616Z","caller":"traceutil/trace.go:171","msg":"trace[1807781080] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"275.55113ms","start":"2026-03-30T17:59:21.66103Z","end":"2026-03-30T17:59:21.936581Z","steps":["trace[1807781080] 'process raft request' (duration: 272.071274ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:59:27.241786Z","caller":"traceutil/trace.go:171","msg":"trace[774559766] linearizableReadLoop","detail":"{readStateIndex:398; appliedIndex:397; }","duration":"276.120634ms","start":"2026-03-30T17:59:26.965645Z","end":"2026-03-30T17:59:27.241765Z","steps":["trace[774559766] 'read index received' (duration: 275.902808ms)","trace[774559766] 'applied index is now lower than readState.Index' (duration: 216.926µs)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:59:27.241846Z","caller":"traceutil/trace.go:171","msg":"trace[2103745248] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"285.219894ms","start":"2026-03-30T17:59:26.95661Z","end":"2026-03-30T17:59:27.24183Z","steps":["trace[2103745248] 'process raft request' (duration: 285.031619ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:27.241898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.232028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:59:27.241924Z","caller":"traceutil/trace.go:171","msg":"trace[86585582] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:385; }","duration":"276.31279ms","start":"2026-03-30T17:59:26.965604Z","end":"2026-03-30T17:59:27.241916Z","steps":["trace[86585582] 'agreement among raft nodes before linearized reading' (duration: 276.250078ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:28.35059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:27.944025Z","time spent":"406.560799ms","remote":"127.0.0.1:56646","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-03-30T17:59:28.350716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.9132ms","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-03-30T17:59:28.350754Z","caller":"traceutil/trace.go:171","msg":"trace[1706362736] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:385; }","duration":"390.989573ms","start":"2026-03-30T17:59:27.959754Z","end":"2026-03-30T17:59:28.350744Z","steps":["trace[1706362736] 'agreement among raft nodes before linearized reading' (duration: 390.89888ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:28.350837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:27.959742Z","time spent":"391.085675ms","remote":"127.0.0.1:56874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-30T17:59:28.350585Z","caller":"traceutil/trace.go:171","msg":"trace[1554643145] linearizableReadLoop","detail":"{readStateIndex:399; appliedIndex:398; }","duration":"390.750946ms","start":"2026-03-30T17:59:27.959784Z","end":"2026-03-30T17:59:28.350535Z","steps":["trace[1554643145] 'read index received' (duration: 390.579021ms)","trace[1554643145] 'applied index is now lower than readState.Index' (duration: 170.705µs)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:59:28.598144Z","caller":"traceutil/trace.go:171","msg":"trace[842652241] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"242.447423ms","start":"2026-03-30T17:59:28.355676Z","end":"2026-03-30T17:59:28.598123Z","steps":["trace[842652241] 'process raft request' (duration: 242.417822ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:59:28.598535Z","caller":"traceutil/trace.go:171","msg":"trace[123038936] linearizableReadLoop","detail":"{readStateIndex:400; appliedIndex:399; }","duration":"247.297275ms","start":"2026-03-30T17:59:28.351226Z","end":"2026-03-30T17:59:28.598523Z","steps":["trace[123038936] 'read index received' (duration: 245.916808ms)","trace[123038936] 'applied index is now lower than readState.Index' (duration: 1.379227ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:59:28.598634Z","caller":"traceutil/trace.go:171","msg":"trace[1248185126] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"638.307959ms","start":"2026-03-30T17:59:27.960318Z","end":"2026-03-30T17:59:28.598626Z","steps":["trace[1248185126] 'process raft request' (duration: 636.813248ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:59:28.598678Z","caller":"traceutil/trace.go:171","msg":"trace[574529158] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"246.885464ms","start":"2026-03-30T17:59:28.351764Z","end":"2026-03-30T17:59:28.598649Z","steps":["trace[574529158] 'process raft request' (duration: 246.289478ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:28.598764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"632.919831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T17:59:28.598852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.49608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-03-30T17:59:28.598843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.139579ms","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-03-30T17:59:28.598852Z","caller":"traceutil/trace.go:171","msg":"trace[1332982688] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:388; }","duration":"633.039415ms","start":"2026-03-30T17:59:27.96578Z","end":"2026-03-30T17:59:28.598819Z","steps":["trace[1332982688] 'agreement among raft nodes before linearized reading' (duration: 632.921681ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:59:28.598887Z","caller":"traceutil/trace.go:171","msg":"trace[1386321406] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:388; }","duration":"520.571253ms","start":"2026-03-30T17:59:28.078306Z","end":"2026-03-30T17:59:28.598878Z","steps":["trace[1386321406] 'agreement among raft nodes before linearized reading' (duration: 520.514962ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:28.598914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:28.078278Z","time spent":"520.629934ms","remote":"127.0.0.1:56874","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-03-30T17:59:28.598923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:27.965718Z","time spent":"633.190138ms","remote":"127.0.0.1:56596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-30T17:59:28.598906Z","caller":"traceutil/trace.go:171","msg":"trace[466033310] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:388; }","duration":"144.249612ms","start":"2026-03-30T17:59:28.454642Z","end":"2026-03-30T17:59:28.598892Z","steps":["trace[466033310] 'agreement among raft nodes before linearized reading' (duration: 144.094747ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:28.599545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:27.960299Z","time spent":"638.35175ms","remote":"127.0.0.1:56874","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-03-30T17:59:33.594426Z","caller":"traceutil/trace.go:171","msg":"trace[990132478] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"270.275715ms","start":"2026-03-30T17:59:33.324127Z","end":"2026-03-30T17:59:33.594403Z","steps":["trace[990132478] 'process raft request' (duration: 265.650509ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:59:33.594797Z","caller":"traceutil/trace.go:171","msg":"trace[1467906378] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"266.275675ms","start":"2026-03-30T17:59:33.328483Z","end":"2026-03-30T17:59:33.594759Z","steps":["trace[1467906378] 'process raft request' (duration: 266.022258ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:47.468595Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512489091911035,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T17:59:47.927998Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.173079271s","expected-duration":"1s"} {"level":"info","ts":"2026-03-30T17:59:47.928352Z","caller":"traceutil/trace.go:171","msg":"trace[678929941] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"1.173582455s","start":"2026-03-30T17:59:46.754749Z","end":"2026-03-30T17:59:47.928332Z","steps":["trace[678929941] 'process raft request' (duration: 1.173446701s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:47.928491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:46.754727Z","time spent":"1.173684687s","remote":"127.0.0.1:56652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31121,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:59:47.934719Z","caller":"traceutil/trace.go:171","msg":"trace[570871454] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"1.171092907s","start":"2026-03-30T17:59:46.763592Z","end":"2026-03-30T17:59:47.934685Z","steps":["trace[570871454] 'process raft request' (duration: 1.17081719s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:47.934895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:46.763571Z","time spent":"1.171231181s","remote":"127.0.0.1:56652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23066,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:59:47.935359Z","caller":"traceutil/trace.go:171","msg":"trace[138085060] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"1.07122529s","start":"2026-03-30T17:59:46.86412Z","end":"2026-03-30T17:59:47.935345Z","steps":["trace[138085060] 'process raft request' (duration: 1.070408118s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:59:47.935364Z","caller":"traceutil/trace.go:171","msg":"trace[2066693556] linearizableReadLoop","detail":"{readStateIndex:548; appliedIndex:545; }","duration":"967.697974ms","start":"2026-03-30T17:59:46.967648Z","end":"2026-03-30T17:59:47.935346Z","steps":["trace[2066693556] 'read index received' (duration: 960.717273ms)","trace[2066693556] 'applied index is now lower than readState.Index' (duration: 6.979871ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T17:59:47.935417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:46.8641Z","time spent":"1.071293683s","remote":"127.0.0.1:56652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T17:59:47.935458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"967.815607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:59:47.935547Z","caller":"traceutil/trace.go:171","msg":"trace[620117430] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:529; }","duration":"967.90789ms","start":"2026-03-30T17:59:46.967628Z","end":"2026-03-30T17:59:47.935536Z","steps":["trace[620117430] 'agreement among raft nodes before linearized reading' (duration: 967.782726ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:47.935618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:46.967539Z","time spent":"968.068405ms","remote":"127.0.0.1:56596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-30T17:59:47.935739Z","caller":"traceutil/trace.go:171","msg":"trace[387357686] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"468.121326ms","start":"2026-03-30T17:59:47.467589Z","end":"2026-03-30T17:59:47.93571Z","steps":["trace[387357686] 'process raft request' (duration: 467.702515ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:47.936778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:47.467572Z","time spent":"469.035241ms","remote":"127.0.0.1:56874","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-03-30T17:59:54.851328Z","caller":"traceutil/trace.go:171","msg":"trace[1067463949] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:624; }","duration":"114.657241ms","start":"2026-03-30T17:59:54.736642Z","end":"2026-03-30T17:59:54.8513Z","steps":["trace[1067463949] 'read index received' (duration: 113.821858ms)","trace[1067463949] 'applied index is now lower than readState.Index' (duration: 834.383µs)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:59:54.851411Z","caller":"traceutil/trace.go:171","msg":"trace[1349024589] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"668.905018ms","start":"2026-03-30T17:59:54.18249Z","end":"2026-03-30T17:59:54.851395Z","steps":["trace[1349024589] 'process raft request' (duration: 668.2335ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:54.851547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:54.182465Z","time spent":"668.98609ms","remote":"127.0.0.1:56684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:59:54.851569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.919679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bgltm\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-03-30T17:59:54.851603Z","caller":"traceutil/trace.go:171","msg":"trace[734791197] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bgltm; range_end:; response_count:1; response_revision:604; }","duration":"115.011821ms","start":"2026-03-30T17:59:54.736579Z","end":"2026-03-30T17:59:54.851591Z","steps":["trace[734791197] 'agreement among raft nodes before linearized reading' (duration: 114.865967ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:59:55.128142Z","caller":"traceutil/trace.go:171","msg":"trace[2029093157] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"269.028352ms","start":"2026-03-30T17:59:54.859078Z","end":"2026-03-30T17:59:55.128106Z","steps":["trace[2029093157] 'process raft request' (duration: 268.780085ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:59:55.930146Z","caller":"traceutil/trace.go:171","msg":"trace[1437303983] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"1.070011406s","start":"2026-03-30T17:59:54.860113Z","end":"2026-03-30T17:59:55.930125Z","steps":["trace[1437303983] 'process raft request' (duration: 1.06650187s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:55.93029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:54.860077Z","time spent":"1.07013541s","remote":"127.0.0.1:56874","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-03-30T17:59:55.930346Z","caller":"traceutil/trace.go:171","msg":"trace[1462968126] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"1.070092599s","start":"2026-03-30T17:59:54.860214Z","end":"2026-03-30T17:59:55.930306Z","steps":["trace[1462968126] 'process raft request' (duration: 1.069860703s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:55.930475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:54.860207Z","time spent":"1.070207032s","remote":"127.0.0.1:56874","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-03-30T17:59:55.930908Z","caller":"traceutil/trace.go:171","msg":"trace[716143051] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"1.070600612s","start":"2026-03-30T17:59:54.860295Z","end":"2026-03-30T17:59:55.930895Z","steps":["trace[716143051] 'process raft request' (duration: 1.069953455s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:55.930974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:54.860286Z","time spent":"1.070650775s","remote":"127.0.0.1:56874","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-03-30T17:59:55.93113Z","caller":"traceutil/trace.go:171","msg":"trace[1567618575] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"1.0617787s","start":"2026-03-30T17:59:54.86934Z","end":"2026-03-30T17:59:55.931119Z","steps":["trace[1567618575] 'process raft request' (duration: 1.061537884s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:55.931206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:54.8693Z","time spent":"1.061881814s","remote":"127.0.0.1:56794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:59:55.931264Z","caller":"traceutil/trace.go:171","msg":"trace[1439468930] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"1.008867521s","start":"2026-03-30T17:59:54.922389Z","end":"2026-03-30T17:59:55.931257Z","steps":["trace[1439468930] 'process raft request' (duration: 1.008626765s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:59:55.931275Z","caller":"traceutil/trace.go:171","msg":"trace[568601576] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:625; }","duration":"963.338334ms","start":"2026-03-30T17:59:54.967919Z","end":"2026-03-30T17:59:55.931257Z","steps":["trace[568601576] 'read index received' (duration: 159.945623ms)","trace[568601576] 'applied index is now lower than readState.Index' (duration: 803.391401ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T17:59:55.931303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:54.922348Z","time spent":"1.008936833s","remote":"127.0.0.1:56848","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-03-30T17:59:55.931432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.505568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:59:55.931511Z","caller":"traceutil/trace.go:171","msg":"trace[1792686448] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"963.654033ms","start":"2026-03-30T17:59:54.967836Z","end":"2026-03-30T17:59:55.93149Z","steps":["trace[1792686448] 'agreement among raft nodes before linearized reading' (duration: 963.462277ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:55.931551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:54.967807Z","time spent":"963.737215ms","remote":"127.0.0.1:56596","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-03-30T17:59:57.23953Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.170539891s","expected-duration":"1s"} {"level":"warn","ts":"2026-03-30T17:59:57.777591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.536959ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-30T17:59:57.777927Z","caller":"traceutil/trace.go:171","msg":"trace[1639503566] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.746849482s","start":"2026-03-30T17:59:56.031045Z","end":"2026-03-30T17:59:57.777894Z","steps":["trace[1639503566] 'process raft request' (duration: 1.208678407s)","trace[1639503566] 'compare' (duration: 537.079005ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:59:57.777954Z","caller":"traceutil/trace.go:171","msg":"trace[1247387337] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:633; }","duration":"811.061922ms","start":"2026-03-30T17:59:56.966877Z","end":"2026-03-30T17:59:57.777939Z","steps":["trace[1247387337] 'read index received' (duration: 272.795824ms)","trace[1247387337] 'applied index is now lower than readState.Index' (duration: 538.265078ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:59:57.778002Z","caller":"traceutil/trace.go:171","msg":"trace[1976792779] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"1.74425165s","start":"2026-03-30T17:59:56.033727Z","end":"2026-03-30T17:59:57.777979Z","steps":["trace[1976792779] 'process raft request' (duration: 1.743972663s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:57.778037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:56.031004Z","time spent":"1.746988636s","remote":"127.0.0.1:56674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T17:59:57.778133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:56.033715Z","time spent":"1.744343544s","remote":"127.0.0.1:56848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-30T17:59:57.778212Z","caller":"traceutil/trace.go:171","msg":"trace[1190094680] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"1.743605222s","start":"2026-03-30T17:59:56.034595Z","end":"2026-03-30T17:59:57.7782Z","steps":["trace[1190094680] 'process raft request' (duration: 1.743259993s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:57.778295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:56.034583Z","time spent":"1.743667385s","remote":"127.0.0.1:56794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:59:57.778347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.867529ms","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-03-30T17:59:57.778384Z","caller":"traceutil/trace.go:171","msg":"trace[220301760] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:615; }","duration":"644.936311ms","start":"2026-03-30T17:59:57.133433Z","end":"2026-03-30T17:59:57.778369Z","steps":["trace[220301760] 'agreement among raft nodes before linearized reading' (duration: 644.806018ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:57.778409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:57.133413Z","time spent":"644.992312ms","remote":"127.0.0.1:56874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-30T17:59:57.778391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.498544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:59:57.778552Z","caller":"traceutil/trace.go:171","msg":"trace[1950768278] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"811.642879ms","start":"2026-03-30T17:59:56.966816Z","end":"2026-03-30T17:59:57.778459Z","steps":["trace[1950768278] 'agreement among raft nodes before linearized reading' (duration: 811.458313ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:57.778595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:56.966791Z","time spent":"811.796282ms","remote":"127.0.0.1:56596","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-03-30T17:59:58.436072Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512489091911207,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T17:59:58.936878Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011512489091911207,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-30T17:59:59.076122Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.266160792s","expected-duration":"1s"} {"level":"warn","ts":"2026-03-30T17:59:59.527004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.441861ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-30T17:59:59.527283Z","caller":"traceutil/trace.go:171","msg":"trace[1858604623] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"1.744622761s","start":"2026-03-30T17:59:57.782612Z","end":"2026-03-30T17:59:59.527234Z","steps":["trace[1858604623] 'process raft request' (duration: 1.2938388s)","trace[1858604623] 'compare' (duration: 450.295457ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T17:59:59.527344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:57.782594Z","time spent":"1.744724853s","remote":"127.0.0.1:56874","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-03-30T17:59:59.527485Z","caller":"traceutil/trace.go:171","msg":"trace[805540050] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:636; }","duration":"1.592488122s","start":"2026-03-30T17:59:57.934964Z","end":"2026-03-30T17:59:59.527452Z","steps":["trace[805540050] 'read index received' (duration: 1.141474045s)","trace[805540050] 'applied index is now lower than readState.Index' (duration: 451.012516ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T17:59:59.527608Z","caller":"traceutil/trace.go:171","msg":"trace[528167069] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"1.457339519s","start":"2026-03-30T17:59:58.070237Z","end":"2026-03-30T17:59:59.527577Z","steps":["trace[528167069] 'process raft request' (duration: 1.456890577s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:59.527731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.592531103s","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-03-30T17:59:59.527738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.59276994s","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-03-30T17:59:59.527765Z","caller":"traceutil/trace.go:171","msg":"trace[1158497584] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:617; }","duration":"1.592652847s","start":"2026-03-30T17:59:57.935102Z","end":"2026-03-30T17:59:59.527755Z","steps":["trace[1158497584] 'agreement among raft nodes before linearized reading' (duration: 1.592499423s)"],"step_count":1} {"level":"info","ts":"2026-03-30T17:59:59.527774Z","caller":"traceutil/trace.go:171","msg":"trace[1696658854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:617; }","duration":"1.592861262s","start":"2026-03-30T17:59:57.9349Z","end":"2026-03-30T17:59:59.527761Z","steps":["trace[1696658854] 'agreement among raft nodes before linearized reading' (duration: 1.592686277s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:59.527771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:58.070193Z","time spent":"1.457488383s","remote":"127.0.0.1:56874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T17:59:59.527813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:57.93488Z","time spent":"1.592925164s","remote":"127.0.0.1:56874","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-03-30T17:59:59.527811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.579007803s","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-03-30T17:59:59.527849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.58185129s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-03-30T17:59:59.527867Z","caller":"traceutil/trace.go:171","msg":"trace[1384352208] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:617; }","duration":"1.581928383s","start":"2026-03-30T17:59:57.945934Z","end":"2026-03-30T17:59:59.527862Z","steps":["trace[1384352208] 'agreement among raft nodes before linearized reading' (duration: 1.581871931s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:59.52789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:57.945913Z","time spent":"1.581973083s","remote":"127.0.0.1:56646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.22\" "} {"level":"info","ts":"2026-03-30T17:59:59.527885Z","caller":"traceutil/trace.go:171","msg":"trace[1822553403] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:617; }","duration":"1.579154127s","start":"2026-03-30T17:59:57.948702Z","end":"2026-03-30T17:59:59.527857Z","steps":["trace[1822553403] 'agreement among raft nodes before linearized reading' (duration: 1.578942901s)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:59.527792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:57.935059Z","time spent":"1.592724539s","remote":"127.0.0.1:56874","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-03-30T17:59:59.527936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:57.948661Z","time spent":"1.579258829s","remote":"127.0.0.1:56874","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-03-30T17:59:59.528001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.378867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T17:59:59.528029Z","caller":"traceutil/trace.go:171","msg":"trace[277887127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:617; }","duration":"562.439979ms","start":"2026-03-30T17:59:58.965582Z","end":"2026-03-30T17:59:59.528022Z","steps":["trace[277887127] 'agreement among raft nodes before linearized reading' (duration: 562.398808ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T17:59:59.528051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T17:59:58.965564Z","time spent":"562.48204ms","remote":"127.0.0.1:56596","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-03-30T18:00:02.118852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"816.964304ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T18:00:02.118924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.152522417s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T18:00:02.118975Z","caller":"traceutil/trace.go:171","msg":"trace[1278764799] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"1.152597699s","start":"2026-03-30T18:00:00.966354Z","end":"2026-03-30T18:00:02.118951Z","steps":["trace[1278764799] 'range keys from in-memory index tree' (duration: 1.152357464s)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:00:02.118994Z","caller":"traceutil/trace.go:171","msg":"trace[410860755] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:630; }","duration":"817.111778ms","start":"2026-03-30T18:00:01.301834Z","end":"2026-03-30T18:00:02.118946Z","steps":["trace[410860755] 'range keys from in-memory index tree' (duration: 816.946584ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:02.119007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T18:00:00.966332Z","time spent":"1.152667202s","remote":"127.0.0.1:56606","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-03-30T18:00:02.119045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.501036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bgltm\" ","response":"range_response_count:1 size:17520"} {"level":"warn","ts":"2026-03-30T18:00:02.119084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.824272ms","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-03-30T18:00:02.11912Z","caller":"traceutil/trace.go:171","msg":"trace[1747249378] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bgltm; range_end:; response_count:1; response_revision:630; }","duration":"349.612789ms","start":"2026-03-30T18:00:01.769482Z","end":"2026-03-30T18:00:02.119095Z","steps":["trace[1747249378] 'range keys from in-memory index tree' (duration: 349.325301ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:02.119172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T18:00:01.769462Z","time spent":"349.701271ms","remote":"127.0.0.1:56794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17543,"request content":"key:\"/registry/pods/kube-system/cilium-bgltm\" "} {"level":"warn","ts":"2026-03-30T18:00:02.119043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.728668ms","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-03-30T18:00:02.119177Z","caller":"traceutil/trace.go:171","msg":"trace[1362840378] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:630; }","duration":"558.919384ms","start":"2026-03-30T18:00:01.560215Z","end":"2026-03-30T18:00:02.119134Z","steps":["trace[1362840378] 'range keys from in-memory index tree' (duration: 558.624776ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:00:02.119208Z","caller":"traceutil/trace.go:171","msg":"trace[158649143] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:630; }","duration":"585.932224ms","start":"2026-03-30T18:00:01.533263Z","end":"2026-03-30T18:00:02.119195Z","steps":["trace[158649143] 'range keys from in-memory index tree' (duration: 585.476522ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:02.119213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T18:00:01.560197Z","time spent":"559.007306ms","remote":"127.0.0.1:56874","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-03-30T18:00:02.119247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T18:00:01.533244Z","time spent":"585.993346ms","remote":"127.0.0.1:56874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-30T18:00:02.119306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.453121ms","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-03-30T18:00:02.119344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.48998ms","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-03-30T18:00:02.119404Z","caller":"traceutil/trace.go:171","msg":"trace[1920686569] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:630; }","duration":"581.576235ms","start":"2026-03-30T18:00:01.537804Z","end":"2026-03-30T18:00:02.119381Z","steps":["trace[1920686569] 'range keys from in-memory index tree' (duration: 581.210354ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:02.120239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T18:00:01.537796Z","time spent":"582.422998ms","remote":"127.0.0.1:56874","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":"info","ts":"2026-03-30T18:00:02.120884Z","caller":"traceutil/trace.go:171","msg":"trace[1149573822] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:630; }","duration":"559.612793ms","start":"2026-03-30T18:00:01.559779Z","end":"2026-03-30T18:00:02.119392Z","steps":["trace[1149573822] 'range keys from in-memory index tree' (duration: 559.266034ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:02.120924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T18:00:01.559759Z","time spent":"561.154205ms","remote":"127.0.0.1:56874","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-03-30T18:00:05.210783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.192312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-03-30T18:00:05.210897Z","caller":"traceutil/trace.go:171","msg":"trace[1784922899] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:689; }","duration":"236.362346ms","start":"2026-03-30T18:00:04.974506Z","end":"2026-03-30T18:00:05.210868Z","steps":["trace[1784922899] 'range keys from in-memory index tree' (duration: 235.966456ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:21.154615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.72319ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-30T18:00:21.154714Z","caller":"traceutil/trace.go:171","msg":"trace[554536685] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"142.756132ms","start":"2026-03-30T18:00:21.011944Z","end":"2026-03-30T18:00:21.1547Z","steps":["trace[554536685] 'process raft request' (duration: 36.885329ms)","trace[554536685] 'compare' (duration: 105.599486ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T18:00:21.653676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.456269ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T18:00:21.653843Z","caller":"traceutil/trace.go:171","msg":"trace[1233793012] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:793; }","duration":"351.420786ms","start":"2026-03-30T18:00:21.302396Z","end":"2026-03-30T18:00:21.653816Z","steps":["trace[1233793012] 'range keys from in-memory index tree' (duration: 350.426808ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:00:22.490214Z","caller":"traceutil/trace.go:171","msg":"trace[185326689] linearizableReadLoop","detail":"{readStateIndex:822; appliedIndex:821; }","duration":"266.769121ms","start":"2026-03-30T18:00:22.223426Z","end":"2026-03-30T18:00:22.490196Z","steps":["trace[185326689] 'read index received' (duration: 266.618727ms)","trace[185326689] 'applied index is now lower than readState.Index' (duration: 149.614µs)"],"step_count":2} {"level":"info","ts":"2026-03-30T18:00:22.490386Z","caller":"traceutil/trace.go:171","msg":"trace[104028925] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"486.048926ms","start":"2026-03-30T18:00:22.00423Z","end":"2026-03-30T18:00:22.490279Z","steps":["trace[104028925] 'process raft request' (duration: 485.83154ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:22.490656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T18:00:22.004207Z","time spent":"486.396634ms","remote":"127.0.0.1:56848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-30T18:00:22.490499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.988923ms","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-03-30T18:00:22.490746Z","caller":"traceutil/trace.go:171","msg":"trace[182626963] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:794; }","duration":"265.279021ms","start":"2026-03-30T18:00:22.22546Z","end":"2026-03-30T18:00:22.490739Z","steps":["trace[182626963] 'agreement among raft nodes before linearized reading' (duration: 264.88305ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:22.490532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.994356ms","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-03-30T18:00:22.490872Z","caller":"traceutil/trace.go:171","msg":"trace[112539806] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:794; }","duration":"264.396336ms","start":"2026-03-30T18:00:22.226463Z","end":"2026-03-30T18:00:22.49086Z","steps":["trace[112539806] 'agreement among raft nodes before linearized reading' (duration: 263.917883ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:22.490563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.342048ms","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-03-30T18:00:22.491235Z","caller":"traceutil/trace.go:171","msg":"trace[291260708] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:794; }","duration":"263.994675ms","start":"2026-03-30T18:00:22.227197Z","end":"2026-03-30T18:00:22.491191Z","steps":["trace[291260708] 'agreement among raft nodes before linearized reading' (duration: 263.177683ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:22.490568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.151832ms","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-03-30T18:00:22.49144Z","caller":"traceutil/trace.go:171","msg":"trace[225293190] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:794; }","duration":"268.015956ms","start":"2026-03-30T18:00:22.22337Z","end":"2026-03-30T18:00:22.491386Z","steps":["trace[225293190] 'agreement among raft nodes before linearized reading' (duration: 266.945157ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:00:45.608935Z","caller":"traceutil/trace.go:171","msg":"trace[958431165] linearizableReadLoop","detail":"{readStateIndex:1197; appliedIndex:1196; }","duration":"289.01585ms","start":"2026-03-30T18:00:45.319888Z","end":"2026-03-30T18:00:45.608904Z","steps":["trace[958431165] 'read index received' (duration: 288.793604ms)","trace[958431165] 'applied index is now lower than readState.Index' (duration: 220.906µs)"],"step_count":2} {"level":"info","ts":"2026-03-30T18:00:45.608979Z","caller":"traceutil/trace.go:171","msg":"trace[828272125] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"309.572711ms","start":"2026-03-30T18:00:45.299384Z","end":"2026-03-30T18:00:45.608957Z","steps":["trace[828272125] 'process raft request' (duration: 309.375686ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:45.6091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T18:00:45.299373Z","time spent":"309.666154ms","remote":"127.0.0.1:56874","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-30T18:00:45.609182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.263407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T18:00:45.609251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.22127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T18:00:45.609294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.502313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T18:00:45.60931Z","caller":"traceutil/trace.go:171","msg":"trace[1994191930] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:1164; }","duration":"244.527964ms","start":"2026-03-30T18:00:45.364777Z","end":"2026-03-30T18:00:45.609305Z","steps":["trace[1994191930] 'agreement among raft nodes before linearized reading' (duration: 244.500033ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:00:45.609258Z","caller":"traceutil/trace.go:171","msg":"trace[912348982] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:1164; }","duration":"289.381149ms","start":"2026-03-30T18:00:45.319859Z","end":"2026-03-30T18:00:45.60924Z","steps":["trace[912348982] 'agreement among raft nodes before linearized reading' (duration: 289.185954ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:45.609341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.718151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T18:00:45.609436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.346839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T18:00:45.609509Z","caller":"traceutil/trace.go:171","msg":"trace[1063182316] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:1164; }","duration":"289.569345ms","start":"2026-03-30T18:00:45.319922Z","end":"2026-03-30T18:00:45.609491Z","steps":["trace[1063182316] 'agreement among raft nodes before linearized reading' (duration: 289.145943ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:00:45.609302Z","caller":"traceutil/trace.go:171","msg":"trace[321717694] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:1164; }","duration":"227.277122ms","start":"2026-03-30T18:00:45.382007Z","end":"2026-03-30T18:00:45.609284Z","steps":["trace[321717694] 'agreement among raft nodes before linearized reading' (duration: 227.219451ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:45.609534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.341844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T18:00:45.609582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.089799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T18:00:45.609622Z","caller":"traceutil/trace.go:171","msg":"trace[1913876702] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:1164; }","duration":"245.14239ms","start":"2026-03-30T18:00:45.36447Z","end":"2026-03-30T18:00:45.609612Z","steps":["trace[1913876702] 'agreement among raft nodes before linearized reading' (duration: 245.086609ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:00:45.609589Z","caller":"traceutil/trace.go:171","msg":"trace[1932652913] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:1164; }","duration":"277.930997ms","start":"2026-03-30T18:00:45.331513Z","end":"2026-03-30T18:00:45.609444Z","steps":["trace[1932652913] 'agreement among raft nodes before linearized reading' (duration: 277.637419ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:45.609751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.712981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T18:00:45.609765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.182143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T18:00:45.609341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.110728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-30T18:00:45.609818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.833222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T18:00:45.609833Z","caller":"traceutil/trace.go:171","msg":"trace[801489044] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:1164; }","duration":"263.240465ms","start":"2026-03-30T18:00:45.346561Z","end":"2026-03-30T18:00:45.609801Z","steps":["trace[801489044] 'agreement among raft nodes before linearized reading' (duration: 263.176374ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:45.609849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.171473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T18:00:45.609882Z","caller":"traceutil/trace.go:171","msg":"trace[341166496] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:1164; }","duration":"227.718374ms","start":"2026-03-30T18:00:45.382139Z","end":"2026-03-30T18:00:45.609858Z","steps":["trace[341166496] 'agreement among raft nodes before linearized reading' (duration: 227.047216ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:00:45.609883Z","caller":"traceutil/trace.go:171","msg":"trace[1703385924] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:1164; }","duration":"289.940205ms","start":"2026-03-30T18:00:45.319927Z","end":"2026-03-30T18:00:45.609867Z","steps":["trace[1703385924] 'agreement among raft nodes before linearized reading' (duration: 289.838923ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:45.60961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.727798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T18:00:45.609923Z","caller":"traceutil/trace.go:171","msg":"trace[1785432164] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:1164; }","duration":"263.276446ms","start":"2026-03-30T18:00:45.346624Z","end":"2026-03-30T18:00:45.6099Z","steps":["trace[1785432164] 'agreement among raft nodes before linearized reading' (duration: 263.118812ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:00:45.609946Z","caller":"traceutil/trace.go:171","msg":"trace[419011991] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:1164; }","duration":"279.108239ms","start":"2026-03-30T18:00:45.330819Z","end":"2026-03-30T18:00:45.609927Z","steps":["trace[419011991] 'agreement among raft nodes before linearized reading' (duration: 278.654057ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:45.609183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.695828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T18:00:45.610054Z","caller":"traceutil/trace.go:171","msg":"trace[357892266] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:1164; }","duration":"245.600213ms","start":"2026-03-30T18:00:45.364444Z","end":"2026-03-30T18:00:45.610044Z","steps":["trace[357892266] 'agreement among raft nodes before linearized reading' (duration: 244.648117ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:00:45.610023Z","caller":"traceutil/trace.go:171","msg":"trace[865511706] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:1164; }","duration":"227.424196ms","start":"2026-03-30T18:00:45.382169Z","end":"2026-03-30T18:00:45.609593Z","steps":["trace[865511706] 'agreement among raft nodes before linearized reading' (duration: 227.308883ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:45.609693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.81186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T18:00:45.61016Z","caller":"traceutil/trace.go:171","msg":"trace[1394367277] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:1164; }","duration":"279.285244ms","start":"2026-03-30T18:00:45.330851Z","end":"2026-03-30T18:00:45.610136Z","steps":["trace[1394367277] 'agreement among raft nodes before linearized reading' (duration: 278.817001ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:00:45.609826Z","caller":"traceutil/trace.go:171","msg":"trace[131396737] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:1164; }","duration":"262.786552ms","start":"2026-03-30T18:00:45.347013Z","end":"2026-03-30T18:00:45.609799Z","steps":["trace[131396737] 'agreement among raft nodes before linearized reading' (duration: 262.716141ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:00:53.066894Z","caller":"traceutil/trace.go:171","msg":"trace[1019992148] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"336.936829ms","start":"2026-03-30T18:00:52.729929Z","end":"2026-03-30T18:00:53.066866Z","steps":["trace[1019992148] 'process raft request' (duration: 336.756674ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:53.067058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-30T18:00:52.729908Z","time spent":"337.066913ms","remote":"127.0.0.1:56874","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-03-30T18:00:53.067253Z","caller":"traceutil/trace.go:171","msg":"trace[141901573] linearizableReadLoop","detail":"{readStateIndex:1239; appliedIndex:1239; }","duration":"249.646703ms","start":"2026-03-30T18:00:52.817576Z","end":"2026-03-30T18:00:53.067223Z","steps":["trace[141901573] 'read index received' (duration: 249.629902ms)","trace[141901573] 'applied index is now lower than readState.Index' (duration: 13.701µs)"],"step_count":2} {"level":"warn","ts":"2026-03-30T18:00:53.067501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.902881ms","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-03-30T18:00:53.067538Z","caller":"traceutil/trace.go:171","msg":"trace[388426948] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1205; }","duration":"249.989582ms","start":"2026-03-30T18:00:52.817539Z","end":"2026-03-30T18:00:53.067528Z","steps":["trace[388426948] 'agreement among raft nodes before linearized reading' (duration: 249.817028ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:00:53.070361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.34763ms","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-03-30T18:00:53.070395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.792623ms","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-03-30T18:00:53.070408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.385713ms","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-03-30T18:00:53.070458Z","caller":"traceutil/trace.go:171","msg":"trace[986610777] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1205; }","duration":"251.479774ms","start":"2026-03-30T18:00:52.818954Z","end":"2026-03-30T18:00:53.070434Z","steps":["trace[986610777] 'agreement among raft nodes before linearized reading' (duration: 251.230467ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:00:53.070458Z","caller":"traceutil/trace.go:171","msg":"trace[655091214] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1205; }","duration":"247.880525ms","start":"2026-03-30T18:00:52.822562Z","end":"2026-03-30T18:00:53.070443Z","steps":["trace[655091214] 'agreement among raft nodes before linearized reading' (duration: 247.726741ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:00:53.070491Z","caller":"traceutil/trace.go:171","msg":"trace[703600926] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1205; }","duration":"194.492976ms","start":"2026-03-30T18:00:52.875973Z","end":"2026-03-30T18:00:53.070466Z","steps":["trace[703600926] 'agreement among raft nodes before linearized reading' (duration: 194.24686ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:08:59.938596Z","caller":"traceutil/trace.go:171","msg":"trace[755594578] transaction","detail":"{read_only:false; response_revision:2895; number_of_response:1; }","duration":"131.261954ms","start":"2026-03-30T18:08:59.807275Z","end":"2026-03-30T18:08:59.938537Z","steps":["trace[755594578] 'process raft request' (duration: 48.251688ms)","trace[755594578] 'compare' (duration: 82.778769ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T18:09:01.911177Z","caller":"traceutil/trace.go:171","msg":"trace[519895617] transaction","detail":"{read_only:false; response_revision:2902; number_of_response:1; }","duration":"140.210489ms","start":"2026-03-30T18:09:01.770897Z","end":"2026-03-30T18:09:01.911107Z","steps":["trace[519895617] 'process raft request' (duration: 140.012923ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:09:05.124569Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1905} {"level":"warn","ts":"2026-03-30T18:09:05.127888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.021978ms","expected-duration":"100ms","prefix":"","request":"header: compaction: ","response":"size:5"} {"level":"info","ts":"2026-03-30T18:09:05.128142Z","caller":"traceutil/trace.go:171","msg":"trace[2075412796] linearizableReadLoop","detail":"{readStateIndex:3050; appliedIndex:3049; }","duration":"161.044387ms","start":"2026-03-30T18:09:04.967078Z","end":"2026-03-30T18:09:05.128122Z","steps":["trace[2075412796] 'read index received' (duration: 4.277986ms)","trace[2075412796] 'applied index is now lower than readState.Index' (duration: 156.763031ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T18:09:05.12817Z","caller":"traceutil/trace.go:171","msg":"trace[348094525] compact","detail":"{revision:1905; response_revision:2913; }","duration":"213.089918ms","start":"2026-03-30T18:09:04.915058Z","end":"2026-03-30T18:09:05.128148Z","steps":["trace[348094525] 'process raft request' (duration: 56.284927ms)","trace[348094525] 'check and update compact revision' (duration: 152.806492ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T18:09:05.128285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.201852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-30T18:09:05.128343Z","caller":"traceutil/trace.go:171","msg":"trace[476030415] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2913; }","duration":"161.313924ms","start":"2026-03-30T18:09:04.967018Z","end":"2026-03-30T18:09:05.128332Z","steps":["trace[476030415] 'agreement among raft nodes before linearized reading' (duration: 161.179791ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:09:05.397074Z","caller":"traceutil/trace.go:171","msg":"trace[1267314974] linearizableReadLoop","detail":"{readStateIndex:3051; appliedIndex:3050; }","duration":"109.317515ms","start":"2026-03-30T18:09:05.287735Z","end":"2026-03-30T18:09:05.397052Z","steps":["trace[1267314974] 'read index received' (duration: 29.187247ms)","trace[1267314974] 'applied index is now lower than readState.Index' (duration: 80.129488ms)"],"step_count":2} {"level":"warn","ts":"2026-03-30T18:09:05.397201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.444149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-30T18:09:05.397229Z","caller":"traceutil/trace.go:171","msg":"trace[385304534] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:2914; }","duration":"109.504351ms","start":"2026-03-30T18:09:05.287718Z","end":"2026-03-30T18:09:05.397223Z","steps":["trace[385304534] 'agreement among raft nodes before linearized reading' (duration: 109.413368ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:09:05.397196Z","caller":"traceutil/trace.go:171","msg":"trace[1830880969] transaction","detail":"{read_only:false; response_revision:2914; number_of_response:1; }","duration":"252.500534ms","start":"2026-03-30T18:09:05.144641Z","end":"2026-03-30T18:09:05.397142Z","steps":["trace[1830880969] 'process raft request' (duration: 172.268083ms)","trace[1830880969] 'compare' (duration: 36.629111ms)","trace[1830880969] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; req_size:530; } (duration: 43.400375ms)"],"step_count":3} {"level":"info","ts":"2026-03-30T18:09:05.580042Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":1905,"took":"454.559762ms","hash":4154822278,"current-db-size-bytes":26578944,"current-db-size":"27 MB","current-db-size-in-use-bytes":9019392,"current-db-size-in-use":"9.0 MB"} {"level":"info","ts":"2026-03-30T18:09:05.580119Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4154822278,"revision":1905,"compact-revision":-1} {"level":"warn","ts":"2026-03-30T18:09:06.194298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.58393ms","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-03-30T18:09:06.194495Z","caller":"traceutil/trace.go:171","msg":"trace[1805711907] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2916; }","duration":"121.832356ms","start":"2026-03-30T18:09:06.072636Z","end":"2026-03-30T18:09:06.194468Z","steps":["trace[1805711907] 'range keys from in-memory index tree' (duration: 121.373054ms)"],"step_count":1} {"level":"warn","ts":"2026-03-30T18:09:06.194513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.575422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-03-30T18:09:06.194576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.94194ms","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-03-30T18:09:06.194602Z","caller":"traceutil/trace.go:171","msg":"trace[1873724642] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2916; }","duration":"202.709735ms","start":"2026-03-30T18:09:05.991871Z","end":"2026-03-30T18:09:06.194581Z","steps":["trace[1873724642] 'range keys from in-memory index tree' (duration: 202.299734ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:09:06.194644Z","caller":"traceutil/trace.go:171","msg":"trace[754115226] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2916; }","duration":"122.061383ms","start":"2026-03-30T18:09:06.072565Z","end":"2026-03-30T18:09:06.194627Z","steps":["trace[754115226] 'range keys from in-memory index tree' (duration: 121.750134ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:09:06.303472Z","caller":"traceutil/trace.go:171","msg":"trace[1699315037] transaction","detail":"{read_only:false; response_revision:2917; number_of_response:1; }","duration":"105.243794ms","start":"2026-03-30T18:09:06.198202Z","end":"2026-03-30T18:09:06.303446Z","steps":["trace[1699315037] 'process raft request' (duration: 105.076019ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:09:06.304992Z","caller":"traceutil/trace.go:171","msg":"trace[1248258842] transaction","detail":"{read_only:false; response_revision:2919; number_of_response:1; }","duration":"106.249431ms","start":"2026-03-30T18:09:06.198724Z","end":"2026-03-30T18:09:06.304973Z","steps":["trace[1248258842] 'process raft request' (duration: 106.2042ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:09:06.305155Z","caller":"traceutil/trace.go:171","msg":"trace[1678143896] transaction","detail":"{read_only:false; response_revision:2918; number_of_response:1; }","duration":"106.764265ms","start":"2026-03-30T18:09:06.198375Z","end":"2026-03-30T18:09:06.30514Z","steps":["trace[1678143896] 'process raft request' (duration: 106.433956ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:09:07.914784Z","caller":"traceutil/trace.go:171","msg":"trace[1786864401] transaction","detail":"{read_only:false; response_revision:2921; number_of_response:1; }","duration":"128.462348ms","start":"2026-03-30T18:09:07.786281Z","end":"2026-03-30T18:09:07.914743Z","steps":["trace[1786864401] 'process raft request' (duration: 128.252862ms)"],"step_count":1} {"level":"info","ts":"2026-03-30T18:09:32.611615Z","caller":"traceutil/trace.go:171","msg":"trace[142713778] transaction","detail":"{read_only:false; response_revision:3006; number_of_response:1; }","duration":"140.446265ms","start":"2026-03-30T18:09:32.471132Z","end":"2026-03-30T18:09:32.611578Z","steps":["trace[142713778] 'process raft request' (duration: 75.083631ms)","trace[142713778] 'compare' (duration: 65.21971ms)"],"step_count":2} {"level":"info","ts":"2026-03-30T18:09:32.617805Z","caller":"traceutil/trace.go:171","msg":"trace[1733332924] transaction","detail":"{read_only:false; response_revision:3007; number_of_response:1; }","duration":"143.738904ms","start":"2026-03-30T18:09:32.47403Z","end":"2026-03-30T18:09:32.617769Z","steps":["trace[1733332924] 'process raft request' (duration: 143.517348ms)"],"step_count":1}