{"level":"warn","ts":"2026-08-28T04:01:58.095279Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-28T04:01:58.095363Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.144:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.144:2380","--initial-cluster=instance=https://162.253.55.144:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.144:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.144:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-28T04:01:58.095428Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-28T04:01:58.095438Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.144:2380"]} {"level":"info","ts":"2026-08-28T04:01:58.095454Z","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-08-28T04:01:58.096071Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.144:2379"]} {"level":"info","ts":"2026-08-28T04:01:58.096142Z","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.144:2380"],"listen-peer-urls":["https://162.253.55.144:2380"],"advertise-client-urls":["https://162.253.55.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.144:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-28T04:01:58.101138Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.694465ms"} {"level":"info","ts":"2026-08-28T04:01:58.114163Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"873be3731fd7a3eb","cluster-id":"9ca43c00a45c1826"} {"level":"info","ts":"2026-08-28T04:01:58.114245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"873be3731fd7a3eb switched to configuration voters=()"} {"level":"info","ts":"2026-08-28T04:01:58.114268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"873be3731fd7a3eb became follower at term 0"} {"level":"info","ts":"2026-08-28T04:01:58.114279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 873be3731fd7a3eb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-28T04:01:58.114288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"873be3731fd7a3eb became follower at term 1"} {"level":"info","ts":"2026-08-28T04:01:58.114364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"873be3731fd7a3eb switched to configuration voters=(9744632302341170155)"} {"level":"warn","ts":"2026-08-28T04:01:58.124339Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-28T04:01:58.129325Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-28T04:01:58.130994Z","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-08-28T04:01:58.137817Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"873be3731fd7a3eb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-28T04:01:58.137878Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"873be3731fd7a3eb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-28T04:01:58.138045Z","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-08-28T04:01:58.138104Z","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-08-28T04:01:58.138114Z","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-08-28T04:01:58.138967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"873be3731fd7a3eb switched to configuration voters=(9744632302341170155)"} {"level":"info","ts":"2026-08-28T04:01:58.139079Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9ca43c00a45c1826","local-member-id":"873be3731fd7a3eb","added-peer-id":"873be3731fd7a3eb","added-peer-peer-urls":["https://162.253.55.144:2380"]} {"level":"info","ts":"2026-08-28T04:01:58.139983Z","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-08-28T04:01:58.140151Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"873be3731fd7a3eb","initial-advertise-peer-urls":["https://162.253.55.144:2380"],"listen-peer-urls":["https://162.253.55.144:2380"],"advertise-client-urls":["https://162.253.55.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-28T04:01:58.140174Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-28T04:01:58.140289Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.144:2380"} {"level":"info","ts":"2026-08-28T04:01:58.140326Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.144:2380"} {"level":"info","ts":"2026-08-28T04:01:58.515497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"873be3731fd7a3eb is starting a new election at term 1"} {"level":"info","ts":"2026-08-28T04:01:58.515575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"873be3731fd7a3eb became pre-candidate at term 1"} {"level":"info","ts":"2026-08-28T04:01:58.515607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"873be3731fd7a3eb received MsgPreVoteResp from 873be3731fd7a3eb at term 1"} {"level":"info","ts":"2026-08-28T04:01:58.515625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"873be3731fd7a3eb became candidate at term 2"} {"level":"info","ts":"2026-08-28T04:01:58.515633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"873be3731fd7a3eb received MsgVoteResp from 873be3731fd7a3eb at term 2"} {"level":"info","ts":"2026-08-28T04:01:58.515644Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"873be3731fd7a3eb became leader at term 2"} {"level":"info","ts":"2026-08-28T04:01:58.515656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 873be3731fd7a3eb elected leader 873be3731fd7a3eb at term 2"} {"level":"info","ts":"2026-08-28T04:01:58.51691Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-28T04:01:58.519601Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"873be3731fd7a3eb","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.144:2379]}","request-path":"/0/members/873be3731fd7a3eb/attributes","cluster-id":"9ca43c00a45c1826","publish-timeout":"7s"} {"level":"info","ts":"2026-08-28T04:01:58.519681Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-28T04:01:58.519858Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-28T04:01:58.520309Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9ca43c00a45c1826","local-member-id":"873be3731fd7a3eb","cluster-version":"3.5"} {"level":"info","ts":"2026-08-28T04:01:58.520399Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-28T04:01:58.520427Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-28T04:01:58.520594Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-28T04:01:58.520673Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-28T04:01:58.522634Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-28T04:01:58.523345Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.144:2379"} {"level":"warn","ts":"2026-08-28T04:02:04.193615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.03843ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-28T04:02:04.193897Z","caller":"traceutil/trace.go:171","msg":"trace[421895827] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"452.23081ms","start":"2026-08-28T04:02:03.741644Z","end":"2026-08-28T04:02:04.193875Z","steps":["trace[421895827] 'process raft request' (duration: 452.156169ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:02:04.194001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:02:03.741625Z","time spent":"452.33379ms","remote":"127.0.0.1:34610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":184,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-28T04:02:04.19439Z","caller":"traceutil/trace.go:171","msg":"trace[933882816] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"458.179393ms","start":"2026-08-28T04:02:03.73615Z","end":"2026-08-28T04:02:04.194329Z","steps":["trace[933882816] 'process raft request' (duration: 179.702382ms)","trace[933882816] 'compare' (duration: 276.687098ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T04:02:04.195663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:02:03.736131Z","time spent":"458.404934ms","remote":"127.0.0.1:34492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":677,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-28T04:02:04.454003Z","caller":"traceutil/trace.go:171","msg":"trace[478414397] linearizableReadLoop","detail":"{readStateIndex:275; appliedIndex:274; }","duration":"250.008602ms","start":"2026-08-28T04:02:04.203966Z","end":"2026-08-28T04:02:04.453975Z","steps":["trace[478414397] 'read index received' (duration: 156.582959ms)","trace[478414397] 'applied index is now lower than readState.Index' (duration: 93.424393ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T04:02:04.454111Z","caller":"traceutil/trace.go:171","msg":"trace[212034410] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"252.419398ms","start":"2026-08-28T04:02:04.201664Z","end":"2026-08-28T04:02:04.454083Z","steps":["trace[212034410] 'process raft request' (duration: 158.847214ms)","trace[212034410] 'compare' (duration: 93.330892ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T04:02:04.45431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.288304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-08-28T04:02:04.454355Z","caller":"traceutil/trace.go:171","msg":"trace[674339838] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:269; }","duration":"250.435404ms","start":"2026-08-28T04:02:04.203907Z","end":"2026-08-28T04:02:04.454342Z","steps":["trace[674339838] 'agreement among raft nodes before linearized reading' (duration: 250.190633ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:02:40.209791Z","caller":"traceutil/trace.go:171","msg":"trace[682559901] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:627; }","duration":"292.072213ms","start":"2026-08-28T04:02:39.917695Z","end":"2026-08-28T04:02:40.209767Z","steps":["trace[682559901] 'read index received' (duration: 291.646429ms)","trace[682559901] 'applied index is now lower than readState.Index' (duration: 424.554µs)"],"step_count":2} {"level":"info","ts":"2026-08-28T04:02:40.20987Z","caller":"traceutil/trace.go:171","msg":"trace[282696053] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"306.674665ms","start":"2026-08-28T04:02:39.903137Z","end":"2026-08-28T04:02:40.209812Z","steps":["trace[282696053] 'process raft request' (duration: 306.257121ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:02:40.209946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.233842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-08-28T04:02:40.209981Z","caller":"traceutil/trace.go:171","msg":"trace[450633740] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:607; }","duration":"292.301016ms","start":"2026-08-28T04:02:39.917668Z","end":"2026-08-28T04:02:40.209969Z","steps":["trace[450633740] 'agreement among raft nodes before linearized reading' (duration: 292.210161ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:02:40.210266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:02:39.903107Z","time spent":"306.844933ms","remote":"127.0.0.1:34442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-28T04:02:40.216792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.061881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T04:02:40.216852Z","caller":"traceutil/trace.go:171","msg":"trace[111531917] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:608; }","duration":"281.145446ms","start":"2026-08-28T04:02:39.935691Z","end":"2026-08-28T04:02:40.216836Z","steps":["trace[111531917] 'agreement among raft nodes before linearized reading' (duration: 281.03965ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:02:40.217323Z","caller":"traceutil/trace.go:171","msg":"trace[1664197339] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"216.327474ms","start":"2026-08-28T04:02:40.000978Z","end":"2026-08-28T04:02:40.217305Z","steps":["trace[1664197339] 'process raft request' (duration: 215.573782ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:02:43.486865Z","caller":"traceutil/trace.go:171","msg":"trace[673621841] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"116.964626ms","start":"2026-08-28T04:02:43.369872Z","end":"2026-08-28T04:02:43.486836Z","steps":["trace[673621841] 'process raft request' (duration: 116.359073ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:02:45.126071Z","caller":"traceutil/trace.go:171","msg":"trace[1787020632] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"146.870997ms","start":"2026-08-28T04:02:44.97916Z","end":"2026-08-28T04:02:45.126031Z","steps":["trace[1787020632] 'process raft request' (duration: 146.718049ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:02:45.734849Z","caller":"traceutil/trace.go:171","msg":"trace[1074482623] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"202.304708ms","start":"2026-08-28T04:02:45.532521Z","end":"2026-08-28T04:02:45.734826Z","steps":["trace[1074482623] 'process raft request' (duration: 201.627432ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:02:47.406123Z","caller":"traceutil/trace.go:171","msg":"trace[211386814] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"108.919264ms","start":"2026-08-28T04:02:47.297179Z","end":"2026-08-28T04:02:47.406099Z","steps":["trace[211386814] 'process raft request' (duration: 108.780487ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:03:32.664323Z","caller":"traceutil/trace.go:171","msg":"trace[1532805536] linearizableReadLoop","detail":"{readStateIndex:1245; appliedIndex:1244; }","duration":"104.274377ms","start":"2026-08-28T04:03:32.560024Z","end":"2026-08-28T04:03:32.664298Z","steps":["trace[1532805536] 'read index received' (duration: 104.174624ms)","trace[1532805536] 'applied index is now lower than readState.Index' (duration: 98.443µs)"],"step_count":2} {"level":"warn","ts":"2026-08-28T04:03:32.66446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.416591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T04:03:32.664498Z","caller":"traceutil/trace.go:171","msg":"trace[1493760797] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1211; }","duration":"104.496944ms","start":"2026-08-28T04:03:32.559989Z","end":"2026-08-28T04:03:32.664486Z","steps":["trace[1493760797] 'agreement among raft nodes before linearized reading' (duration: 104.413651ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:03:32.696187Z","caller":"traceutil/trace.go:171","msg":"trace[604929571] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"100.069922ms","start":"2026-08-28T04:03:32.59607Z","end":"2026-08-28T04:03:32.69614Z","steps":["trace[604929571] 'process raft request' (duration: 99.789352ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:03:46.416585Z","caller":"traceutil/trace.go:171","msg":"trace[1821271441] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"103.672724ms","start":"2026-08-28T04:03:46.312891Z","end":"2026-08-28T04:03:46.416564Z","steps":["trace[1821271441] 'process raft request' (duration: 103.51038ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:03:57.693327Z","caller":"traceutil/trace.go:171","msg":"trace[1143484799] linearizableReadLoop","detail":"{readStateIndex:1529; appliedIndex:1528; }","duration":"107.267494ms","start":"2026-08-28T04:03:57.586017Z","end":"2026-08-28T04:03:57.693285Z","steps":["trace[1143484799] 'read index received' (duration: 107.161341ms)","trace[1143484799] 'applied index is now lower than readState.Index' (duration: 104.703µs)"],"step_count":2} {"level":"info","ts":"2026-08-28T04:03:57.693414Z","caller":"traceutil/trace.go:171","msg":"trace[1406193356] transaction","detail":"{read_only:false; response_revision:1484; number_of_response:1; }","duration":"138.667282ms","start":"2026-08-28T04:03:57.554717Z","end":"2026-08-28T04:03:57.693384Z","steps":["trace[1406193356] 'process raft request' (duration: 138.415626ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:03:57.693499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.464069ms","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-08-28T04:03:57.693536Z","caller":"traceutil/trace.go:171","msg":"trace[1891915251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1484; }","duration":"107.544991ms","start":"2026-08-28T04:03:57.58598Z","end":"2026-08-28T04:03:57.693525Z","steps":["trace[1891915251] 'agreement among raft nodes before linearized reading' (duration: 107.415488ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:04:21.043815Z","caller":"traceutil/trace.go:171","msg":"trace[190635447] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"141.853693ms","start":"2026-08-28T04:04:20.901932Z","end":"2026-08-28T04:04:21.043786Z","steps":["trace[190635447] 'process raft request' (duration: 141.674389ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:04:30.224676Z","caller":"traceutil/trace.go:171","msg":"trace[1243088818] linearizableReadLoop","detail":"{readStateIndex:2045; appliedIndex:2043; }","duration":"103.182778ms","start":"2026-08-28T04:04:30.121474Z","end":"2026-08-28T04:04:30.224657Z","steps":["trace[1243088818] 'read index received' (duration: 72.807995ms)","trace[1243088818] 'applied index is now lower than readState.Index' (duration: 30.373713ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T04:04:30.224795Z","caller":"traceutil/trace.go:171","msg":"trace[1680949758] transaction","detail":"{read_only:false; response_revision:1969; number_of_response:1; }","duration":"106.095108ms","start":"2026-08-28T04:04:30.118669Z","end":"2026-08-28T04:04:30.224764Z","steps":["trace[1680949758] 'process raft request' (duration: 105.882304ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:04:30.22486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.363101ms","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":"info","ts":"2026-08-28T04:04:30.22489Z","caller":"traceutil/trace.go:171","msg":"trace[1294339835] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1969; }","duration":"103.431212ms","start":"2026-08-28T04:04:30.121449Z","end":"2026-08-28T04:04:30.22488Z","steps":["trace[1294339835] 'agreement among raft nodes before linearized reading' (duration: 103.30868ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:04:56.395343Z","caller":"traceutil/trace.go:171","msg":"trace[2010913269] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"110.781989ms","start":"2026-08-28T04:04:56.284524Z","end":"2026-08-28T04:04:56.395306Z","steps":["trace[2010913269] 'process raft request' (duration: 110.505824ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:04:56.747626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.071023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-08-28T04:04:56.747788Z","caller":"traceutil/trace.go:171","msg":"trace[1682368273] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2132; }","duration":"267.300278ms","start":"2026-08-28T04:04:56.480469Z","end":"2026-08-28T04:04:56.74777Z","steps":["trace[1682368273] 'range keys from in-memory index tree' (duration: 266.847349ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:04:56.748607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.552617ms","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-08-28T04:04:56.748634Z","caller":"traceutil/trace.go:171","msg":"trace[46110267] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2132; }","duration":"148.619017ms","start":"2026-08-28T04:04:56.600009Z","end":"2026-08-28T04:04:56.748628Z","steps":["trace[46110267] 'range keys from in-memory index tree' (duration: 148.331833ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:04:56.868761Z","caller":"traceutil/trace.go:171","msg":"trace[2116477505] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"115.726627ms","start":"2026-08-28T04:04:56.753012Z","end":"2026-08-28T04:04:56.868738Z","steps":["trace[2116477505] 'process raft request' (duration: 115.578624ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:04:56.909605Z","caller":"traceutil/trace.go:171","msg":"trace[436806330] linearizableReadLoop","detail":"{readStateIndex:2215; appliedIndex:2213; }","duration":"150.821527ms","start":"2026-08-28T04:04:56.758758Z","end":"2026-08-28T04:04:56.909579Z","steps":["trace[436806330] 'read index received' (duration: 109.77685ms)","trace[436806330] 'applied index is now lower than readState.Index' (duration: 41.041707ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T04:04:56.909736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.953579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-28T04:04:56.909786Z","caller":"traceutil/trace.go:171","msg":"trace[357372994] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:2134; }","duration":"151.040351ms","start":"2026-08-28T04:04:56.758731Z","end":"2026-08-28T04:04:56.909771Z","steps":["trace[357372994] 'agreement among raft nodes before linearized reading' (duration: 150.94172ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:04:56.90987Z","caller":"traceutil/trace.go:171","msg":"trace[844845753] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"152.12423ms","start":"2026-08-28T04:04:56.75772Z","end":"2026-08-28T04:04:56.909844Z","steps":["trace[844845753] 'process raft request' (duration: 151.716083ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:06:05.379411Z","caller":"traceutil/trace.go:171","msg":"trace[305240568] transaction","detail":"{read_only:false; response_revision:2603; number_of_response:1; }","duration":"167.518511ms","start":"2026-08-28T04:06:05.21187Z","end":"2026-08-28T04:06:05.379388Z","steps":["trace[305240568] 'process raft request' (duration: 167.391959ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:06:39.945051Z","caller":"traceutil/trace.go:171","msg":"trace[257355543] transaction","detail":"{read_only:false; response_revision:2794; number_of_response:1; }","duration":"116.30743ms","start":"2026-08-28T04:06:39.828709Z","end":"2026-08-28T04:06:39.945016Z","steps":["trace[257355543] 'process raft request' (duration: 116.134057ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:06:40.367733Z","caller":"traceutil/trace.go:171","msg":"trace[487476134] transaction","detail":"{read_only:false; response_revision:2795; number_of_response:1; }","duration":"244.487366ms","start":"2026-08-28T04:06:40.123209Z","end":"2026-08-28T04:06:40.367696Z","steps":["trace[487476134] 'process raft request' (duration: 244.217833ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:11:10.047579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.190246ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-28T04:11:10.047885Z","caller":"traceutil/trace.go:171","msg":"trace[18227632] transaction","detail":"{read_only:false; response_revision:4934; number_of_response:1; }","duration":"157.429969ms","start":"2026-08-28T04:11:09.890437Z","end":"2026-08-28T04:11:10.047867Z","steps":["trace[18227632] 'process raft request' (duration: 157.382688ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:11:10.047925Z","caller":"traceutil/trace.go:171","msg":"trace[1988026293] transaction","detail":"{read_only:false; response_revision:4930; number_of_response:1; }","duration":"420.313607ms","start":"2026-08-28T04:11:09.627541Z","end":"2026-08-28T04:11:10.047854Z","steps":["trace[1988026293] 'process raft request' (duration: 150.763975ms)","trace[1988026293] 'compare' (duration: 269.026221ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T04:11:10.047976Z","caller":"traceutil/trace.go:171","msg":"trace[1647872277] transaction","detail":"{read_only:false; response_revision:4932; number_of_response:1; }","duration":"414.256692ms","start":"2026-08-28T04:11:09.633689Z","end":"2026-08-28T04:11:10.047946Z","steps":["trace[1647872277] 'process raft request' (duration: 414.049227ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:11:10.048042Z","caller":"traceutil/trace.go:171","msg":"trace[716926134] linearizableReadLoop","detail":"{readStateIndex:5122; appliedIndex:5118; }","duration":"353.923838ms","start":"2026-08-28T04:11:09.694082Z","end":"2026-08-28T04:11:10.048006Z","steps":["trace[716926134] 'read index received' (duration: 84.308004ms)","trace[716926134] 'applied index is now lower than readState.Index' (duration: 269.612134ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T04:11:10.048133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:11:09.633665Z","time spent":"414.375955ms","remote":"127.0.0.1:34684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1455,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-28T04:11:10.04816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:11:09.627506Z","time spent":"420.537141ms","remote":"127.0.0.1:34684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1869,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-28T04:11:10.048254Z","caller":"traceutil/trace.go:171","msg":"trace[239818142] transaction","detail":"{read_only:false; response_revision:4933; number_of_response:1; }","duration":"414.021358ms","start":"2026-08-28T04:11:09.634212Z","end":"2026-08-28T04:11:10.048233Z","steps":["trace[239818142] 'process raft request' (duration: 413.561648ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:11:10.048309Z","caller":"traceutil/trace.go:171","msg":"trace[965633104] transaction","detail":"{read_only:false; response_revision:4931; number_of_response:1; }","duration":"419.214824ms","start":"2026-08-28T04:11:09.62908Z","end":"2026-08-28T04:11:10.048295Z","steps":["trace[965633104] 'process raft request' (duration: 418.599831ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:11:10.048376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:11:09.629066Z","time spent":"419.271205ms","remote":"127.0.0.1:34564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1283,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-28T04:11:10.048369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.266765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T04:11:10.048444Z","caller":"traceutil/trace.go:171","msg":"trace[944611008] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:4934; }","duration":"354.394418ms","start":"2026-08-28T04:11:09.694032Z","end":"2026-08-28T04:11:10.048426Z","steps":["trace[944611008] 'agreement among raft nodes before linearized reading' (duration: 354.276286ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:11:10.048479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:11:09.694004Z","time spent":"354.466199ms","remote":"127.0.0.1:52454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-08-28T04:11:10.048498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:11:09.634202Z","time spent":"414.10446ms","remote":"127.0.0.1:34564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":906,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-28T04:11:10.11087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.216168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-28T04:11:10.110973Z","caller":"traceutil/trace.go:171","msg":"trace[70354879] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4935; }","duration":"410.378681ms","start":"2026-08-28T04:11:09.700573Z","end":"2026-08-28T04:11:10.110952Z","steps":["trace[70354879] 'agreement among raft nodes before linearized reading' (duration: 410.099696ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:11:10.111019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:11:09.70055Z","time spent":"410.459472ms","remote":"127.0.0.1:34672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-28T04:11:10.111423Z","caller":"traceutil/trace.go:171","msg":"trace[417961812] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"111.297114ms","start":"2026-08-28T04:11:10.000099Z","end":"2026-08-28T04:11:10.111396Z","steps":["trace[417961812] 'process raft request' (duration: 110.428196ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:11:10.111655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.916031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-28T04:11:10.111716Z","caller":"traceutil/trace.go:171","msg":"trace[649868472] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4935; }","duration":"320.991233ms","start":"2026-08-28T04:11:09.790697Z","end":"2026-08-28T04:11:10.111688Z","steps":["trace[649868472] 'agreement among raft nodes before linearized reading' (duration: 320.83041ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:11:10.111679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.60989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-28T04:11:10.111751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:11:09.790681Z","time spent":"321.063024ms","remote":"127.0.0.1:34672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-28T04:11:10.111813Z","caller":"traceutil/trace.go:171","msg":"trace[636337648] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4935; }","duration":"175.792343ms","start":"2026-08-28T04:11:09.935977Z","end":"2026-08-28T04:11:10.111769Z","steps":["trace[636337648] 'agreement among raft nodes before linearized reading' (duration: 175.533758ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:11:10.705132Z","caller":"traceutil/trace.go:171","msg":"trace[1047797906] linearizableReadLoop","detail":"{readStateIndex:5136; appliedIndex:5134; }","duration":"102.272769ms","start":"2026-08-28T04:11:10.602839Z","end":"2026-08-28T04:11:10.705112Z","steps":["trace[1047797906] 'read index received' (duration: 6.750088ms)","trace[1047797906] 'applied index is now lower than readState.Index' (duration: 95.521761ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T04:11:10.70525Z","caller":"traceutil/trace.go:171","msg":"trace[1414982291] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"102.394452ms","start":"2026-08-28T04:11:10.602844Z","end":"2026-08-28T04:11:10.705238Z","steps":["trace[1414982291] 'process raft request' (duration: 102.189148ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:11:10.705259Z","caller":"traceutil/trace.go:171","msg":"trace[1153815823] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"102.469243ms","start":"2026-08-28T04:11:10.602766Z","end":"2026-08-28T04:11:10.705235Z","steps":["trace[1153815823] 'process raft request' (duration: 48.298176ms)","trace[1153815823] 'compare' (duration: 53.738488ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T04:11:10.705593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.738668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:129981"} {"level":"info","ts":"2026-08-28T04:11:10.705633Z","caller":"traceutil/trace.go:171","msg":"trace[435427310] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:4948; }","duration":"102.814369ms","start":"2026-08-28T04:11:10.602809Z","end":"2026-08-28T04:11:10.705623Z","steps":["trace[435427310] 'agreement among raft nodes before linearized reading' (duration: 102.609105ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:11:23.832028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.356724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-08-28T04:11:23.83219Z","caller":"traceutil/trace.go:171","msg":"trace[591612186] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5146; }","duration":"109.557878ms","start":"2026-08-28T04:11:23.722616Z","end":"2026-08-28T04:11:23.832174Z","steps":["trace[591612186] 'range keys from in-memory index tree' (duration: 109.163421ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:11:24.036971Z","caller":"traceutil/trace.go:171","msg":"trace[31154923] transaction","detail":"{read_only:false; response_revision:5150; number_of_response:1; }","duration":"100.016776ms","start":"2026-08-28T04:11:23.93693Z","end":"2026-08-28T04:11:24.036946Z","steps":["trace[31154923] 'process raft request' (duration: 99.909543ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:11:24.037252Z","caller":"traceutil/trace.go:171","msg":"trace[1734643157] transaction","detail":"{read_only:false; response_revision:5151; number_of_response:1; }","duration":"100.296912ms","start":"2026-08-28T04:11:23.936931Z","end":"2026-08-28T04:11:24.037228Z","steps":["trace[1734643157] 'process raft request' (duration: 99.945315ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:11:24.037464Z","caller":"traceutil/trace.go:171","msg":"trace[1852603823] transaction","detail":"{read_only:false; response_revision:5149; number_of_response:1; }","duration":"100.573897ms","start":"2026-08-28T04:11:23.936878Z","end":"2026-08-28T04:11:24.037452Z","steps":["trace[1852603823] 'process raft request' (duration: 99.849682ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:11:24.294954Z","caller":"traceutil/trace.go:171","msg":"trace[846734036] transaction","detail":"{read_only:false; response_revision:5156; number_of_response:1; }","duration":"139.779461ms","start":"2026-08-28T04:11:24.155145Z","end":"2026-08-28T04:11:24.294925Z","steps":["trace[846734036] 'process raft request' (duration: 139.634408ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:11:24.295331Z","caller":"traceutil/trace.go:171","msg":"trace[1080435001] transaction","detail":"{read_only:false; response_revision:5155; number_of_response:1; }","duration":"141.551317ms","start":"2026-08-28T04:11:24.153754Z","end":"2026-08-28T04:11:24.295305Z","steps":["trace[1080435001] 'process raft request' (duration: 55.676656ms)","trace[1080435001] 'compare' (duration: 85.165817ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T04:11:24.295463Z","caller":"traceutil/trace.go:171","msg":"trace[978296240] linearizableReadLoop","detail":"{readStateIndex:5352; appliedIndex:5349; }","duration":"109.256789ms","start":"2026-08-28T04:11:24.186196Z","end":"2026-08-28T04:11:24.295453Z","steps":["trace[978296240] 'read index received' (duration: 23.189945ms)","trace[978296240] 'applied index is now lower than readState.Index' (duration: 86.065794ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T04:11:24.295653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.444453ms","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-08-28T04:11:24.295682Z","caller":"traceutil/trace.go:171","msg":"trace[1910190769] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5157; }","duration":"109.524015ms","start":"2026-08-28T04:11:24.18615Z","end":"2026-08-28T04:11:24.295674Z","steps":["trace[1910190769] 'agreement among raft nodes before linearized reading' (duration: 109.367092ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:11:24.295403Z","caller":"traceutil/trace.go:171","msg":"trace[602390196] transaction","detail":"{read_only:false; response_revision:5157; number_of_response:1; }","duration":"132.187529ms","start":"2026-08-28T04:11:24.163196Z","end":"2026-08-28T04:11:24.295383Z","steps":["trace[602390196] 'process raft request' (duration: 131.671059ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:11:58.548049Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2894} {"level":"info","ts":"2026-08-28T04:11:58.623183Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2894,"took":"73.415044ms","hash":3550432859,"current-db-size-bytes":53317632,"current-db-size":"53 MB","current-db-size-in-use-bytes":28643328,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-28T04:11:58.623242Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3550432859,"revision":2894,"compact-revision":-1} {"level":"info","ts":"2026-08-28T04:12:14.915243Z","caller":"traceutil/trace.go:171","msg":"trace[964765050] transaction","detail":"{read_only:false; response_revision:5591; number_of_response:1; }","duration":"152.948391ms","start":"2026-08-28T04:12:14.762271Z","end":"2026-08-28T04:12:14.915219Z","steps":["trace[964765050] 'process raft request' (duration: 152.822049ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:12:15.121553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.785111ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-28T04:12:15.121732Z","caller":"traceutil/trace.go:171","msg":"trace[1540454906] linearizableReadLoop","detail":"{readStateIndex:5801; appliedIndex:5798; }","duration":"239.5747ms","start":"2026-08-28T04:12:14.882138Z","end":"2026-08-28T04:12:15.121712Z","steps":["trace[1540454906] 'read index received' (duration: 33.018087ms)","trace[1540454906] 'applied index is now lower than readState.Index' (duration: 206.555483ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T04:12:15.121842Z","caller":"traceutil/trace.go:171","msg":"trace[414172223] transaction","detail":"{read_only:false; response_revision:5593; number_of_response:1; }","duration":"282.525954ms","start":"2026-08-28T04:12:14.839301Z","end":"2026-08-28T04:12:15.121827Z","steps":["trace[414172223] 'process raft request' (duration: 282.349421ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:12:15.121961Z","caller":"traceutil/trace.go:171","msg":"trace[212712122] transaction","detail":"{read_only:false; response_revision:5592; number_of_response:1; }","duration":"359.091145ms","start":"2026-08-28T04:12:14.762836Z","end":"2026-08-28T04:12:15.121927Z","steps":["trace[212712122] 'process raft request' (duration: 211.822526ms)","trace[212712122] 'compare' (duration: 146.422384ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T04:12:15.122048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.642466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T04:12:15.122111Z","caller":"traceutil/trace.go:171","msg":"trace[732461920] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5593; }","duration":"187.740307ms","start":"2026-08-28T04:12:14.934353Z","end":"2026-08-28T04:12:15.122093Z","steps":["trace[732461920] 'agreement among raft nodes before linearized reading' (duration: 187.633545ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:12:15.122117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:12:14.762813Z","time spent":"359.233358ms","remote":"127.0.0.1:34672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-28T04:12:15.122173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.042719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-08-28T04:12:15.122207Z","caller":"traceutil/trace.go:171","msg":"trace[1317753212] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5593; }","duration":"240.108211ms","start":"2026-08-28T04:12:14.882082Z","end":"2026-08-28T04:12:15.12219Z","steps":["trace[1317753212] 'agreement among raft nodes before linearized reading' (duration: 240.003408ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:12:15.404409Z","caller":"traceutil/trace.go:171","msg":"trace[1168150606] transaction","detail":"{read_only:false; response_revision:5595; number_of_response:1; }","duration":"176.28751ms","start":"2026-08-28T04:12:15.228099Z","end":"2026-08-28T04:12:15.404387Z","steps":["trace[1168150606] 'process raft request' (duration: 109.918013ms)","trace[1168150606] 'compare' (duration: 66.127902ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T04:12:15.74043Z","caller":"traceutil/trace.go:171","msg":"trace[2085582862] linearizableReadLoop","detail":"{readStateIndex:5804; appliedIndex:5803; }","duration":"155.427664ms","start":"2026-08-28T04:12:15.584974Z","end":"2026-08-28T04:12:15.740402Z","steps":["trace[2085582862] 'read index received' (duration: 78.393555ms)","trace[2085582862] 'applied index is now lower than readState.Index' (duration: 77.032979ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T04:12:15.740504Z","caller":"traceutil/trace.go:171","msg":"trace[830592700] transaction","detail":"{read_only:false; response_revision:5596; number_of_response:1; }","duration":"332.018368ms","start":"2026-08-28T04:12:15.408451Z","end":"2026-08-28T04:12:15.74047Z","steps":["trace[830592700] 'process raft request' (duration: 254.957099ms)","trace[830592700] 'compare' (duration: 76.876356ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T04:12:15.740738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:12:15.408427Z","time spent":"332.239453ms","remote":"127.0.0.1:34672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-28T04:12:15.740989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.010945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-08-28T04:12:15.741069Z","caller":"traceutil/trace.go:171","msg":"trace[237337480] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5596; }","duration":"156.095737ms","start":"2026-08-28T04:12:15.584959Z","end":"2026-08-28T04:12:15.741055Z","steps":["trace[237337480] 'agreement among raft nodes before linearized reading' (duration: 155.554636ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:12:15.94847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.971988ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-28T04:12:15.948565Z","caller":"traceutil/trace.go:171","msg":"trace[1004655026] linearizableReadLoop","detail":"{readStateIndex:5805; appliedIndex:5804; }","duration":"208.039612ms","start":"2026-08-28T04:12:15.740514Z","end":"2026-08-28T04:12:15.948553Z","steps":["trace[1004655026] 'read index received' (duration: 101.87158ms)","trace[1004655026] 'applied index is now lower than readState.Index' (duration: 106.165422ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T04:12:15.948643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.000291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-28T04:12:15.948638Z","caller":"traceutil/trace.go:171","msg":"trace[2039916210] transaction","detail":"{read_only:false; response_revision:5597; number_of_response:1; }","duration":"280.668467ms","start":"2026-08-28T04:12:15.667946Z","end":"2026-08-28T04:12:15.948615Z","steps":["trace[2039916210] 'process raft request' (duration: 174.443954ms)","trace[2039916210] 'compare' (duration: 105.858536ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T04:12:15.948757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.079305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-08-28T04:12:15.948776Z","caller":"traceutil/trace.go:171","msg":"trace[851953596] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5597; }","duration":"205.127277ms","start":"2026-08-28T04:12:15.743644Z","end":"2026-08-28T04:12:15.948771Z","steps":["trace[851953596] 'agreement among raft nodes before linearized reading' (duration: 205.040705ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:12:15.948666Z","caller":"traceutil/trace.go:171","msg":"trace[599197183] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:5597; }","duration":"358.062053ms","start":"2026-08-28T04:12:15.590595Z","end":"2026-08-28T04:12:15.948657Z","steps":["trace[599197183] 'agreement among raft nodes before linearized reading' (duration: 358.018342ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:12:15.948909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:12:15.590574Z","time spent":"358.313248ms","remote":"127.0.0.1:51414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":31,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true "} {"level":"warn","ts":"2026-08-28T04:12:15.948984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.940304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T04:12:15.949005Z","caller":"traceutil/trace.go:171","msg":"trace[1147857809] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5597; }","duration":"175.013236ms","start":"2026-08-28T04:12:15.773987Z","end":"2026-08-28T04:12:15.949Z","steps":["trace[1147857809] 'agreement among raft nodes before linearized reading' (duration: 174.982055ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:12:15.949106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.576426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T04:12:15.949126Z","caller":"traceutil/trace.go:171","msg":"trace[556351500] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5597; }","duration":"175.626566ms","start":"2026-08-28T04:12:15.773494Z","end":"2026-08-28T04:12:15.949121Z","steps":["trace[556351500] 'agreement among raft nodes before linearized reading' (duration: 175.596485ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:12:16.405681Z","caller":"traceutil/trace.go:171","msg":"trace[742708371] transaction","detail":"{read_only:false; response_revision:5598; number_of_response:1; }","duration":"115.533246ms","start":"2026-08-28T04:12:16.289884Z","end":"2026-08-28T04:12:16.405417Z","steps":["trace[742708371] 'process raft request' (duration: 115.357973ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:12:16.569714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.364688ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-28T04:12:16.569854Z","caller":"traceutil/trace.go:171","msg":"trace[419249447] transaction","detail":"{read_only:false; response_revision:5599; number_of_response:1; }","duration":"173.203287ms","start":"2026-08-28T04:12:16.396625Z","end":"2026-08-28T04:12:16.569828Z","steps":["trace[419249447] 'process raft request' (duration: 70.590026ms)","trace[419249447] 'compare' (duration: 101.99325ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T04:12:16.807307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.772652ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-28T04:12:16.807731Z","caller":"traceutil/trace.go:171","msg":"trace[745966016] transaction","detail":"{read_only:false; response_revision:5600; number_of_response:1; }","duration":"161.572907ms","start":"2026-08-28T04:12:16.646139Z","end":"2026-08-28T04:12:16.807712Z","steps":["trace[745966016] 'process raft request' (duration: 55.329946ms)","trace[745966016] 'compare' (duration: 105.675321ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T04:12:17.361186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.84754ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-28T04:12:17.361375Z","caller":"traceutil/trace.go:171","msg":"trace[102706222] transaction","detail":"{read_only:false; response_revision:5602; number_of_response:1; }","duration":"349.530149ms","start":"2026-08-28T04:12:17.011833Z","end":"2026-08-28T04:12:17.361363Z","steps":["trace[102706222] 'process raft request' (duration: 349.488088ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:12:17.361454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:12:17.011809Z","time spent":"349.60753ms","remote":"127.0.0.1:34672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-28T04:12:17.361504Z","caller":"traceutil/trace.go:171","msg":"trace[589564690] transaction","detail":"{read_only:false; response_revision:5601; number_of_response:1; }","duration":"550.686605ms","start":"2026-08-28T04:12:16.810781Z","end":"2026-08-28T04:12:17.361468Z","steps":["trace[589564690] 'process raft request' (duration: 240.49673ms)","trace[589564690] 'compare' (duration: 309.778017ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T04:12:17.361588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:12:16.810756Z","time spent":"550.789487ms","remote":"127.0.0.1:34672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-28T04:12:17.36164Z","caller":"traceutil/trace.go:171","msg":"trace[958745409] linearizableReadLoop","detail":"{readStateIndex:5809; appliedIndex:5808; }","duration":"442.464247ms","start":"2026-08-28T04:12:16.919139Z","end":"2026-08-28T04:12:17.361603Z","steps":["trace[958745409] 'read index received' (duration: 132.130199ms)","trace[958745409] 'applied index is now lower than readState.Index' (duration: 310.332818ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T04:12:17.361801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.668151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-28T04:12:17.362129Z","caller":"traceutil/trace.go:171","msg":"trace[1258016588] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5602; }","duration":"443.027338ms","start":"2026-08-28T04:12:16.919092Z","end":"2026-08-28T04:12:17.36212Z","steps":["trace[1258016588] 'agreement among raft nodes before linearized reading' (duration: 442.59963ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:12:17.36218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:12:16.919074Z","time spent":"443.098239ms","remote":"127.0.0.1:34672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-28T04:12:17.374749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.292436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-28T04:12:17.374877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.688636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-08-28T04:12:17.374874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.428619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-28T04:12:17.374992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.792335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-28T04:12:17.375114Z","caller":"traceutil/trace.go:171","msg":"trace[1706263143] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5603; }","duration":"439.398998ms","start":"2026-08-28T04:12:16.935404Z","end":"2026-08-28T04:12:17.374803Z","steps":["trace[1706263143] 'agreement among raft nodes before linearized reading' (duration: 439.270756ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:12:17.375187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:12:16.935393Z","time spent":"439.781856ms","remote":"127.0.0.1:34368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-28T04:12:17.37527Z","caller":"traceutil/trace.go:171","msg":"trace[2110850822] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5603; }","duration":"188.768319ms","start":"2026-08-28T04:12:17.18615Z","end":"2026-08-28T04:12:17.374919Z","steps":["trace[2110850822] 'agreement among raft nodes before linearized reading' (duration: 188.613416ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:12:17.375399Z","caller":"traceutil/trace.go:171","msg":"trace[868211293] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:5603; }","duration":"439.655054ms","start":"2026-08-28T04:12:16.935375Z","end":"2026-08-28T04:12:17.37503Z","steps":["trace[868211293] 'agreement among raft nodes before linearized reading' (duration: 439.456449ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T04:12:17.375461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T04:12:16.935358Z","time spent":"440.066822ms","remote":"127.0.0.1:34890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":18,"response size":31,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"info","ts":"2026-08-28T04:12:17.375646Z","caller":"traceutil/trace.go:171","msg":"trace[1787568323] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5603; }","duration":"248.881886ms","start":"2026-08-28T04:12:17.126155Z","end":"2026-08-28T04:12:17.375037Z","steps":["trace[1787568323] 'agreement among raft nodes before linearized reading' (duration: 248.654261ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:12:17.374723Z","caller":"traceutil/trace.go:171","msg":"trace[113534812] transaction","detail":"{read_only:false; response_revision:5603; number_of_response:1; }","duration":"248.835654ms","start":"2026-08-28T04:12:17.125858Z","end":"2026-08-28T04:12:17.374694Z","steps":["trace[113534812] 'process raft request' (duration: 248.670321ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:12:17.551154Z","caller":"traceutil/trace.go:171","msg":"trace[724049349] transaction","detail":"{read_only:false; response_revision:5607; number_of_response:1; }","duration":"141.514046ms","start":"2026-08-28T04:12:17.409599Z","end":"2026-08-28T04:12:17.551113Z","steps":["trace[724049349] 'process raft request' (duration: 141.349103ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:12:23.831193Z","caller":"traceutil/trace.go:171","msg":"trace[969282397] transaction","detail":"{read_only:false; response_revision:5660; number_of_response:1; }","duration":"120.542096ms","start":"2026-08-28T04:12:23.710628Z","end":"2026-08-28T04:12:23.83117Z","steps":["trace[969282397] 'process raft request' (duration: 95.371953ms)","trace[969282397] 'compare' (duration: 24.715874ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T04:12:24.198086Z","caller":"traceutil/trace.go:171","msg":"trace[65096293] transaction","detail":"{read_only:false; response_revision:5663; number_of_response:1; }","duration":"106.032913ms","start":"2026-08-28T04:12:24.092027Z","end":"2026-08-28T04:12:24.19806Z","steps":["trace[65096293] 'process raft request' (duration: 105.895321ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T04:16:58.5566Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5483} {"level":"info","ts":"2026-08-28T04:16:58.634066Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5483,"took":"76.153905ms","hash":1949879343,"current-db-size-bytes":53317632,"current-db-size":"53 MB","current-db-size-in-use-bytes":18550784,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-08-28T04:16:58.634119Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1949879343,"revision":5483,"compact-revision":2894}