{"level":"warn","ts":"2026-09-03T02:31:47.352075Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-03T02:31:47.352179Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.79: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.79:2380","--initial-cluster=instance=https://162.253.55.79:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.79:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.79:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-03T02:31:47.352276Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-03T02:31:47.352304Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.79:2380"]} {"level":"info","ts":"2026-09-03T02:31:47.352337Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-03T02:31:47.353344Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"]} {"level":"info","ts":"2026-09-03T02:31:47.353463Z","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://162.253.55.79:2380"],"listen-peer-urls":["https://162.253.55.79:2380"],"advertise-client-urls":["https://162.253.55.79:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.79:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-03T02:31:47.35661Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.847918ms"} {"level":"info","ts":"2026-09-03T02:31:47.373753Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"401ca643156fc5da","cluster-id":"e9f568c3681bb0d0"} {"level":"info","ts":"2026-09-03T02:31:47.37388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=()"} {"level":"info","ts":"2026-09-03T02:31:47.373926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became follower at term 0"} {"level":"info","ts":"2026-09-03T02:31:47.373945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 401ca643156fc5da [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-03T02:31:47.373961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became follower at term 1"} {"level":"info","ts":"2026-09-03T02:31:47.374012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=(4619750124827952602)"} {"level":"warn","ts":"2026-09-03T02:31:47.384205Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-03T02:31:47.386435Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-03T02:31:47.387996Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-03T02:31:47.391747Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"401ca643156fc5da","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-03T02:31:47.392528Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"401ca643156fc5da","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-03T02:31:47.39265Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-03T02:31:47.392699Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-03T02:31:47.392719Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-03T02:31:47.395187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=(4619750124827952602)"} {"level":"info","ts":"2026-09-03T02:31:47.396179Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e9f568c3681bb0d0","local-member-id":"401ca643156fc5da","added-peer-id":"401ca643156fc5da","added-peer-peer-urls":["https://162.253.55.79:2380"]} {"level":"info","ts":"2026-09-03T02:31:47.397571Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-03T02:31:47.397862Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"401ca643156fc5da","initial-advertise-peer-urls":["https://162.253.55.79:2380"],"listen-peer-urls":["https://162.253.55.79:2380"],"advertise-client-urls":["https://162.253.55.79:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-03T02:31:47.397936Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-03T02:31:47.397999Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.79:2380"} {"level":"info","ts":"2026-09-03T02:31:47.398117Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.79:2380"} {"level":"info","ts":"2026-09-03T02:31:47.57508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da is starting a new election at term 1"} {"level":"info","ts":"2026-09-03T02:31:47.57517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became pre-candidate at term 1"} {"level":"info","ts":"2026-09-03T02:31:47.575203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da received MsgPreVoteResp from 401ca643156fc5da at term 1"} {"level":"info","ts":"2026-09-03T02:31:47.575223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became candidate at term 2"} {"level":"info","ts":"2026-09-03T02:31:47.575261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da received MsgVoteResp from 401ca643156fc5da at term 2"} {"level":"info","ts":"2026-09-03T02:31:47.575281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became leader at term 2"} {"level":"info","ts":"2026-09-03T02:31:47.575298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 401ca643156fc5da elected leader 401ca643156fc5da at term 2"} {"level":"info","ts":"2026-09-03T02:31:47.576559Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-03T02:31:47.577671Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-03T02:31:47.57766Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"401ca643156fc5da","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.79:2379]}","request-path":"/0/members/401ca643156fc5da/attributes","cluster-id":"e9f568c3681bb0d0","publish-timeout":"7s"} {"level":"info","ts":"2026-09-03T02:31:47.577715Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-03T02:31:47.577994Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-03T02:31:47.57803Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-03T02:31:47.578498Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e9f568c3681bb0d0","local-member-id":"401ca643156fc5da","cluster-version":"3.5"} {"level":"info","ts":"2026-09-03T02:31:47.5787Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-03T02:31:47.578744Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-03T02:31:47.579884Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-03T02:31:47.579953Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.79:2379"} {"level":"info","ts":"2026-09-03T02:32:07.387552Z","caller":"traceutil/trace.go:171","msg":"trace[1175784866] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"110.043551ms","start":"2026-09-03T02:32:07.277488Z","end":"2026-09-03T02:32:07.387531Z","steps":["trace[1175784866] 'process raft request' (duration: 109.914018ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:32:32.609098Z","caller":"traceutil/trace.go:171","msg":"trace[1902896949] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"258.794553ms","start":"2026-09-03T02:32:32.350257Z","end":"2026-09-03T02:32:32.609051Z","steps":["trace[1902896949] 'read index received' (duration: 258.115395ms)","trace[1902896949] 'applied index is now lower than readState.Index' (duration: 677.558µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:32:32.609215Z","caller":"traceutil/trace.go:171","msg":"trace[419954261] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"341.473509ms","start":"2026-09-03T02:32:32.267668Z","end":"2026-09-03T02:32:32.609141Z","steps":["trace[419954261] 'process raft request' (duration: 340.955605ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:32:32.609328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.044689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fsbv5\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-03T02:32:32.609434Z","caller":"traceutil/trace.go:171","msg":"trace[1288073085] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fsbv5; range_end:; response_count:1; response_revision:580; }","duration":"259.203624ms","start":"2026-09-03T02:32:32.35021Z","end":"2026-09-03T02:32:32.609414Z","steps":["trace[1288073085] 'agreement among raft nodes before linearized reading' (duration: 258.998748ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:32:32.609889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:32:32.267584Z","time spent":"341.746487ms","remote":"127.0.0.1:49484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-03T02:32:33.183547Z","caller":"traceutil/trace.go:171","msg":"trace[319086964] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"504.53069ms","start":"2026-09-03T02:32:32.678985Z","end":"2026-09-03T02:32:33.183516Z","steps":["trace[319086964] 'read index received' (duration: 465.191336ms)","trace[319086964] 'applied index is now lower than readState.Index' (duration: 39.337804ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:32:33.183663Z","caller":"traceutil/trace.go:171","msg":"trace[7549462] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"553.016703ms","start":"2026-09-03T02:32:32.63058Z","end":"2026-09-03T02:32:33.183597Z","steps":["trace[7549462] 'process raft request' (duration: 513.683909ms)","trace[7549462] 'compare' (duration: 38.939643ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T02:32:33.183782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.828932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T02:32:33.183821Z","caller":"traceutil/trace.go:171","msg":"trace[296088082] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:581; }","duration":"484.903104ms","start":"2026-09-03T02:32:32.698907Z","end":"2026-09-03T02:32:33.18381Z","steps":["trace[296088082] 'agreement among raft nodes before linearized reading' (duration: 484.789171ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:32:33.183851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:32:32.698829Z","time spent":"485.015247ms","remote":"127.0.0.1:49592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-09-03T02:32:33.183825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.818968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-03T02:32:33.183955Z","caller":"traceutil/trace.go:171","msg":"trace[421793609] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:581; }","duration":"505.019253ms","start":"2026-09-03T02:32:32.67888Z","end":"2026-09-03T02:32:33.1839Z","steps":["trace[421793609] 'agreement among raft nodes before linearized reading' (duration: 504.793127ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:32:33.184018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:32:32.678841Z","time spent":"505.165237ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-03T02:32:33.184155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:32:32.630539Z","time spent":"553.216208ms","remote":"127.0.0.1:49576","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-09-03T02:33:27.617071Z","caller":"traceutil/trace.go:171","msg":"trace[1995000649] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"100.826392ms","start":"2026-09-03T02:33:27.51622Z","end":"2026-09-03T02:33:27.617046Z","steps":["trace[1995000649] 'process raft request' (duration: 100.74661ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:34:17.968458Z","caller":"traceutil/trace.go:171","msg":"trace[597116942] linearizableReadLoop","detail":"{readStateIndex:1959; appliedIndex:1958; }","duration":"115.652021ms","start":"2026-09-03T02:34:17.852772Z","end":"2026-09-03T02:34:17.968424Z","steps":["trace[597116942] 'read index received' (duration: 115.419304ms)","trace[597116942] 'applied index is now lower than readState.Index' (duration: 231.386µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:34:17.968514Z","caller":"traceutil/trace.go:171","msg":"trace[78347254] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"119.717802ms","start":"2026-09-03T02:34:17.848766Z","end":"2026-09-03T02:34:17.968484Z","steps":["trace[78347254] 'process raft request' (duration: 119.501126ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:34:17.968781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.980779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-03T02:34:17.96884Z","caller":"traceutil/trace.go:171","msg":"trace[1044611203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1885; }","duration":"116.078311ms","start":"2026-09-03T02:34:17.852745Z","end":"2026-09-03T02:34:17.968824Z","steps":["trace[1044611203] 'agreement among raft nodes before linearized reading' (duration: 115.857565ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:34:18.114987Z","caller":"traceutil/trace.go:171","msg":"trace[379922257] linearizableReadLoop","detail":"{readStateIndex:1961; appliedIndex:1959; }","duration":"131.418344ms","start":"2026-09-03T02:34:17.983526Z","end":"2026-09-03T02:34:18.114944Z","steps":["trace[379922257] 'read index received' (duration: 24.147324ms)","trace[379922257] 'applied index is now lower than readState.Index' (duration: 107.26968ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:34:18.115127Z","caller":"traceutil/trace.go:171","msg":"trace[1650220921] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"141.022328ms","start":"2026-09-03T02:34:17.974025Z","end":"2026-09-03T02:34:18.115048Z","steps":["trace[1650220921] 'process raft request' (duration: 140.798462ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:34:18.115221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.664981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-03T02:34:18.115292Z","caller":"traceutil/trace.go:171","msg":"trace[802484933] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1887; }","duration":"131.771234ms","start":"2026-09-03T02:34:17.983498Z","end":"2026-09-03T02:34:18.115269Z","steps":["trace[802484933] 'agreement among raft nodes before linearized reading' (duration: 131.560528ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:35:15.197307Z","caller":"traceutil/trace.go:171","msg":"trace[1348049211] transaction","detail":"{read_only:false; response_revision:2241; number_of_response:1; }","duration":"186.204595ms","start":"2026-09-03T02:35:15.011083Z","end":"2026-09-03T02:35:15.197287Z","steps":["trace[1348049211] 'process raft request' (duration: 186.083272ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:35:15.56915Z","caller":"traceutil/trace.go:171","msg":"trace[422201084] linearizableReadLoop","detail":"{readStateIndex:2329; appliedIndex:2328; }","duration":"310.286928ms","start":"2026-09-03T02:35:15.258838Z","end":"2026-09-03T02:35:15.569125Z","steps":["trace[422201084] 'read index received' (duration: 310.128663ms)","trace[422201084] 'applied index is now lower than readState.Index' (duration: 157.405µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:35:15.56921Z","caller":"traceutil/trace.go:171","msg":"trace[11664107] transaction","detail":"{read_only:false; response_revision:2242; number_of_response:1; }","duration":"548.008411ms","start":"2026-09-03T02:35:15.021171Z","end":"2026-09-03T02:35:15.56918Z","steps":["trace[11664107] 'process raft request' (duration: 547.797945ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:35:15.569331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.470112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-03T02:35:15.569367Z","caller":"traceutil/trace.go:171","msg":"trace[318288111] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2242; }","duration":"310.548785ms","start":"2026-09-03T02:35:15.258809Z","end":"2026-09-03T02:35:15.569358Z","steps":["trace[318288111] 'agreement among raft nodes before linearized reading' (duration: 310.409451ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:35:15.569398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:35:15.258796Z","time spent":"310.593466ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-03T02:35:15.569395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:35:15.021163Z","time spent":"548.142604ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T02:35:15.576026Z","caller":"traceutil/trace.go:171","msg":"trace[889225402] transaction","detail":"{read_only:false; response_revision:2243; number_of_response:1; }","duration":"122.657005ms","start":"2026-09-03T02:35:15.453352Z","end":"2026-09-03T02:35:15.576009Z","steps":["trace[889225402] 'process raft request' (duration: 122.44449ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:35:15.706491Z","caller":"traceutil/trace.go:171","msg":"trace[1980604412] linearizableReadLoop","detail":"{readStateIndex:2332; appliedIndex:2331; }","duration":"121.35102ms","start":"2026-09-03T02:35:15.58511Z","end":"2026-09-03T02:35:15.706461Z","steps":["trace[1980604412] 'read index received' (duration: 25.466247ms)","trace[1980604412] 'applied index is now lower than readState.Index' (duration: 95.881263ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:35:15.706514Z","caller":"traceutil/trace.go:171","msg":"trace[443678752] transaction","detail":"{read_only:false; response_revision:2245; number_of_response:1; }","duration":"132.269228ms","start":"2026-09-03T02:35:15.574209Z","end":"2026-09-03T02:35:15.706478Z","steps":["trace[443678752] 'process raft request' (duration: 36.444907ms)","trace[443678752] 'compare' (duration: 95.292607ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T02:35:15.706672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.608267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-03T02:35:15.706753Z","caller":"traceutil/trace.go:171","msg":"trace[1557071682] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2246; }","duration":"121.723419ms","start":"2026-09-03T02:35:15.585014Z","end":"2026-09-03T02:35:15.706737Z","steps":["trace[1557071682] 'agreement among raft nodes before linearized reading' (duration: 121.530914ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:35:30.453897Z","caller":"traceutil/trace.go:171","msg":"trace[1276348043] transaction","detail":"{read_only:false; response_revision:2335; number_of_response:1; }","duration":"115.513079ms","start":"2026-09-03T02:35:30.338348Z","end":"2026-09-03T02:35:30.453861Z","steps":["trace[1276348043] 'process raft request' (duration: 115.300904ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:35:58.779425Z","caller":"traceutil/trace.go:171","msg":"trace[1220445939] linearizableReadLoop","detail":"{readStateIndex:2755; appliedIndex:2754; }","duration":"154.674424ms","start":"2026-09-03T02:35:58.624724Z","end":"2026-09-03T02:35:58.779398Z","steps":["trace[1220445939] 'read index received' (duration: 154.417977ms)","trace[1220445939] 'applied index is now lower than readState.Index' (duration: 255.197µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:35:58.779473Z","caller":"traceutil/trace.go:171","msg":"trace[1437441040] transaction","detail":"{read_only:false; response_revision:2651; number_of_response:1; }","duration":"168.581287ms","start":"2026-09-03T02:35:58.610864Z","end":"2026-09-03T02:35:58.779446Z","steps":["trace[1437441040] 'process raft request' (duration: 168.381522ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:35:58.779623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.866233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T02:35:58.779664Z","caller":"traceutil/trace.go:171","msg":"trace[2044897826] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2651; }","duration":"132.972626ms","start":"2026-09-03T02:35:58.646681Z","end":"2026-09-03T02:35:58.779653Z","steps":["trace[2044897826] 'agreement among raft nodes before linearized reading' (duration: 132.861423ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:35:58.779874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.030424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-03T02:35:58.780033Z","caller":"traceutil/trace.go:171","msg":"trace[1179843853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2651; }","duration":"155.303341ms","start":"2026-09-03T02:35:58.62468Z","end":"2026-09-03T02:35:58.779983Z","steps":["trace[1179843853] 'agreement among raft nodes before linearized reading' (duration: 154.832108ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:36:32.164658Z","caller":"traceutil/trace.go:171","msg":"trace[119958425] transaction","detail":"{read_only:false; response_revision:2854; number_of_response:1; }","duration":"213.100235ms","start":"2026-09-03T02:36:31.95151Z","end":"2026-09-03T02:36:32.16461Z","steps":["trace[119958425] 'process raft request' (duration: 204.675183ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:36:32.186287Z","caller":"traceutil/trace.go:171","msg":"trace[1861060823] transaction","detail":"{read_only:false; response_revision:2855; number_of_response:1; }","duration":"233.564549ms","start":"2026-09-03T02:36:31.952699Z","end":"2026-09-03T02:36:32.186263Z","steps":["trace[1861060823] 'process raft request' (duration: 233.263541ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:36:32.429871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.712344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-03T02:36:32.429959Z","caller":"traceutil/trace.go:171","msg":"trace[1597082251] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2856; }","duration":"134.859548ms","start":"2026-09-03T02:36:32.295082Z","end":"2026-09-03T02:36:32.429942Z","steps":["trace[1597082251] 'range keys from in-memory index tree' (duration: 134.493807ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:36:32.611256Z","caller":"traceutil/trace.go:171","msg":"trace[1946939742] transaction","detail":"{read_only:false; response_revision:2857; number_of_response:1; }","duration":"172.392453ms","start":"2026-09-03T02:36:32.438831Z","end":"2026-09-03T02:36:32.611224Z","steps":["trace[1946939742] 'process raft request' (duration: 172.176287ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:36:32.798937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.935609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T02:36:32.799079Z","caller":"traceutil/trace.go:171","msg":"trace[1830850368] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2857; }","duration":"152.112973ms","start":"2026-09-03T02:36:32.646939Z","end":"2026-09-03T02:36:32.799052Z","steps":["trace[1830850368] 'range keys from in-memory index tree' (duration: 151.871797ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:39:44.807821Z","caller":"traceutil/trace.go:171","msg":"trace[1621781237] linearizableReadLoop","detail":"{readStateIndex:4222; appliedIndex:4221; }","duration":"160.662297ms","start":"2026-09-03T02:39:44.647142Z","end":"2026-09-03T02:39:44.807804Z","steps":["trace[1621781237] 'read index received' (duration: 160.511573ms)","trace[1621781237] 'applied index is now lower than readState.Index' (duration: 149.734µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:39:44.808025Z","caller":"traceutil/trace.go:171","msg":"trace[359475950] transaction","detail":"{read_only:false; response_revision:4067; number_of_response:1; }","duration":"169.739207ms","start":"2026-09-03T02:39:44.638278Z","end":"2026-09-03T02:39:44.808017Z","steps":["trace[359475950] 'process raft request' (duration: 169.420387ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:39:44.808191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.043518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T02:39:44.808219Z","caller":"traceutil/trace.go:171","msg":"trace[1133941326] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4067; }","duration":"161.11651ms","start":"2026-09-03T02:39:44.647093Z","end":"2026-09-03T02:39:44.80821Z","steps":["trace[1133941326] 'agreement among raft nodes before linearized reading' (duration: 161.062429ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:39:44.808408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.199793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T02:39:44.808488Z","caller":"traceutil/trace.go:171","msg":"trace[481245523] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:4067; }","duration":"117.323346ms","start":"2026-09-03T02:39:44.691144Z","end":"2026-09-03T02:39:44.808468Z","steps":["trace[481245523] 'agreement among raft nodes before linearized reading' (duration: 117.191333ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:39:44.808603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.212338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-03T02:39:44.808634Z","caller":"traceutil/trace.go:171","msg":"trace[838993095] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4067; }","duration":"103.29145ms","start":"2026-09-03T02:39:44.705336Z","end":"2026-09-03T02:39:44.808628Z","steps":["trace[838993095] 'agreement among raft nodes before linearized reading' (duration: 103.176396ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:39:45.009986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.640024ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-03T02:39:45.010137Z","caller":"traceutil/trace.go:171","msg":"trace[1505083997] transaction","detail":"{read_only:false; response_revision:4068; number_of_response:1; }","duration":"198.441866ms","start":"2026-09-03T02:39:44.811677Z","end":"2026-09-03T02:39:45.010118Z","steps":["trace[1505083997] 'process raft request' (duration: 52.453023ms)","trace[1505083997] 'compare' (duration: 145.538461ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:41:11.967029Z","caller":"traceutil/trace.go:171","msg":"trace[994235436] linearizableReadLoop","detail":"{readStateIndex:5259; appliedIndex:5258; }","duration":"156.362527ms","start":"2026-09-03T02:41:11.810644Z","end":"2026-09-03T02:41:11.967006Z","steps":["trace[994235436] 'read index received' (duration: 156.134721ms)","trace[994235436] 'applied index is now lower than readState.Index' (duration: 226.786µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:41:11.967063Z","caller":"traceutil/trace.go:171","msg":"trace[1580287967] transaction","detail":"{read_only:false; response_revision:5064; number_of_response:1; }","duration":"174.302531ms","start":"2026-09-03T02:41:11.792732Z","end":"2026-09-03T02:41:11.967034Z","steps":["trace[1580287967] 'process raft request' (duration: 174.118006ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:41:11.96732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.662205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-09-03T02:41:11.967397Z","caller":"traceutil/trace.go:171","msg":"trace[480313536] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5064; }","duration":"156.770348ms","start":"2026-09-03T02:41:11.810609Z","end":"2026-09-03T02:41:11.967379Z","steps":["trace[480313536] 'agreement among raft nodes before linearized reading' (duration: 156.513542ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:41:18.576034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.827541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-z6qgp-tls\" ","response":"range_response_count:1 size:4427"} {"level":"info","ts":"2026-09-03T02:41:18.576115Z","caller":"traceutil/trace.go:171","msg":"trace[962771929] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-z6qgp-tls; range_end:; response_count:1; response_revision:5281; }","duration":"287.939644ms","start":"2026-09-03T02:41:18.288159Z","end":"2026-09-03T02:41:18.576098Z","steps":["trace[962771929] 'range keys from in-memory index tree' (duration: 287.701088ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:18.943537Z","caller":"traceutil/trace.go:171","msg":"trace[1943923463] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5284; }","duration":"118.745714ms","start":"2026-09-03T02:41:18.82477Z","end":"2026-09-03T02:41:18.943516Z","steps":["trace[1943923463] 'process raft request' (duration: 118.637121ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:27.171902Z","caller":"traceutil/trace.go:171","msg":"trace[2130848706] transaction","detail":"{read_only:false; response_revision:5450; number_of_response:1; }","duration":"102.450376ms","start":"2026-09-03T02:41:27.069418Z","end":"2026-09-03T02:41:27.171869Z","steps":["trace[2130848706] 'process raft request' (duration: 102.23318ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:27.171905Z","caller":"traceutil/trace.go:171","msg":"trace[878235566] transaction","detail":"{read_only:false; response_revision:5449; number_of_response:1; }","duration":"103.287989ms","start":"2026-09-03T02:41:27.068581Z","end":"2026-09-03T02:41:27.171869Z","steps":["trace[878235566] 'process raft request' (duration: 35.846646ms)","trace[878235566] 'compare' (duration: 66.986251ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:41:27.328591Z","caller":"traceutil/trace.go:171","msg":"trace[498022172] transaction","detail":"{read_only:false; response_revision:5452; number_of_response:1; }","duration":"151.465253ms","start":"2026-09-03T02:41:27.177079Z","end":"2026-09-03T02:41:27.328544Z","steps":["trace[498022172] 'process raft request' (duration: 151.079763ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:27.328734Z","caller":"traceutil/trace.go:171","msg":"trace[64709287] transaction","detail":"{read_only:false; response_revision:5453; number_of_response:1; }","duration":"149.659182ms","start":"2026-09-03T02:41:27.179032Z","end":"2026-09-03T02:41:27.328692Z","steps":["trace[64709287] 'process raft request' (duration: 149.351394ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:27.328783Z","caller":"traceutil/trace.go:171","msg":"trace[661696464] linearizableReadLoop","detail":"{readStateIndex:5664; appliedIndex:5660; }","duration":"117.13549ms","start":"2026-09-03T02:41:27.211599Z","end":"2026-09-03T02:41:27.328734Z","steps":["trace[661696464] 'read index received' (duration: 116.502072ms)","trace[661696464] 'applied index is now lower than readState.Index' (duration: 631.848µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:41:27.328926Z","caller":"traceutil/trace.go:171","msg":"trace[111726518] transaction","detail":"{read_only:false; response_revision:5454; number_of_response:1; }","duration":"148.345627ms","start":"2026-09-03T02:41:27.180548Z","end":"2026-09-03T02:41:27.328894Z","steps":["trace[111726518] 'process raft request' (duration: 147.973507ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:27.328908Z","caller":"traceutil/trace.go:171","msg":"trace[1770925973] transaction","detail":"{read_only:false; response_revision:5455; number_of_response:1; }","duration":"145.485268ms","start":"2026-09-03T02:41:27.18341Z","end":"2026-09-03T02:41:27.328896Z","steps":["trace[1770925973] 'process raft request' (duration: 145.240951ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:41:27.329202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.577402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-03T02:41:27.329307Z","caller":"traceutil/trace.go:171","msg":"trace[278159130] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5455; }","duration":"117.689665ms","start":"2026-09-03T02:41:27.211592Z","end":"2026-09-03T02:41:27.329282Z","steps":["trace[278159130] 'agreement among raft nodes before linearized reading' (duration: 117.398647ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:41:27.330831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.414256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-03T02:41:27.331187Z","caller":"traceutil/trace.go:171","msg":"trace[21503317] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:5456; }","duration":"110.824577ms","start":"2026-09-03T02:41:27.220338Z","end":"2026-09-03T02:41:27.331163Z","steps":["trace[21503317] 'agreement among raft nodes before linearized reading' (duration: 110.341354ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:33.628572Z","caller":"traceutil/trace.go:171","msg":"trace[1223971121] transaction","detail":"{read_only:false; response_revision:5565; number_of_response:1; }","duration":"156.09011ms","start":"2026-09-03T02:41:33.472439Z","end":"2026-09-03T02:41:33.628529Z","steps":["trace[1223971121] 'process raft request' (duration: 155.811072ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:33.628604Z","caller":"traceutil/trace.go:171","msg":"trace[1426031716] transaction","detail":"{read_only:false; response_revision:5562; number_of_response:1; }","duration":"278.487625ms","start":"2026-09-03T02:41:33.3501Z","end":"2026-09-03T02:41:33.628587Z","steps":["trace[1426031716] 'process raft request' (duration: 238.906097ms)","trace[1426031716] 'compare' (duration: 38.918329ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:41:33.628655Z","caller":"traceutil/trace.go:171","msg":"trace[1488550475] transaction","detail":"{read_only:false; response_revision:5566; number_of_response:1; }","duration":"153.689004ms","start":"2026-09-03T02:41:33.474918Z","end":"2026-09-03T02:41:33.628607Z","steps":["trace[1488550475] 'process raft request' (duration: 153.362995ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:33.628574Z","caller":"traceutil/trace.go:171","msg":"trace[1768195453] transaction","detail":"{read_only:false; response_revision:5563; number_of_response:1; }","duration":"215.923765ms","start":"2026-09-03T02:41:33.412607Z","end":"2026-09-03T02:41:33.62853Z","steps":["trace[1768195453] 'process raft request' (duration: 215.507834ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:33.628655Z","caller":"traceutil/trace.go:171","msg":"trace[1223171187] transaction","detail":"{read_only:false; response_revision:5564; number_of_response:1; }","duration":"157.332184ms","start":"2026-09-03T02:41:33.471306Z","end":"2026-09-03T02:41:33.628638Z","steps":["trace[1223171187] 'process raft request' (duration: 156.868571ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:33.829571Z","caller":"traceutil/trace.go:171","msg":"trace[1992433894] transaction","detail":"{read_only:false; response_revision:5568; number_of_response:1; }","duration":"196.877082ms","start":"2026-09-03T02:41:33.632669Z","end":"2026-09-03T02:41:33.829546Z","steps":["trace[1992433894] 'process raft request' (duration: 123.70366ms)","trace[1992433894] 'compare' (duration: 72.989256ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:41:33.830435Z","caller":"traceutil/trace.go:171","msg":"trace[556230390] transaction","detail":"{read_only:false; response_revision:5569; number_of_response:1; }","duration":"169.587951ms","start":"2026-09-03T02:41:33.660804Z","end":"2026-09-03T02:41:33.830392Z","steps":["trace[556230390] 'process raft request' (duration: 168.683287ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:41:33.830855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.974819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T02:41:33.830931Z","caller":"traceutil/trace.go:171","msg":"trace[341754306] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5569; }","duration":"183.091242ms","start":"2026-09-03T02:41:33.647819Z","end":"2026-09-03T02:41:33.830911Z","steps":["trace[341754306] 'agreement among raft nodes before linearized reading' (duration: 182.920747ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:33.830572Z","caller":"traceutil/trace.go:171","msg":"trace[1401629580] linearizableReadLoop","detail":"{readStateIndex:5779; appliedIndex:5777; }","duration":"182.690341ms","start":"2026-09-03T02:41:33.647853Z","end":"2026-09-03T02:41:33.830544Z","steps":["trace[1401629580] 'read index received' (duration: 38.624941ms)","trace[1401629580] 'applied index is now lower than readState.Index' (duration: 144.06271ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:41:33.831144Z","caller":"traceutil/trace.go:171","msg":"trace[2070060988] transaction","detail":"{read_only:false; response_revision:5570; number_of_response:1; }","duration":"140.490861ms","start":"2026-09-03T02:41:33.690632Z","end":"2026-09-03T02:41:33.831123Z","steps":["trace[2070060988] 'process raft request' (duration: 139.117324ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:33.83118Z","caller":"traceutil/trace.go:171","msg":"trace[1863542201] transaction","detail":"{read_only:false; response_revision:5571; number_of_response:1; }","duration":"140.306196ms","start":"2026-09-03T02:41:33.690857Z","end":"2026-09-03T02:41:33.831163Z","steps":["trace[1863542201] 'process raft request' (duration: 140.198593ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:45.540237Z","caller":"traceutil/trace.go:171","msg":"trace[1568574757] transaction","detail":"{read_only:false; response_revision:5793; number_of_response:1; }","duration":"167.73464ms","start":"2026-09-03T02:41:45.372475Z","end":"2026-09-03T02:41:45.540209Z","steps":["trace[1568574757] 'process raft request' (duration: 167.535385ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:45.577461Z","caller":"traceutil/trace.go:171","msg":"trace[847948860] linearizableReadLoop","detail":"{readStateIndex:6009; appliedIndex:6007; }","duration":"141.991173ms","start":"2026-09-03T02:41:45.435441Z","end":"2026-09-03T02:41:45.577432Z","steps":["trace[847948860] 'read index received' (duration: 104.615156ms)","trace[847948860] 'applied index is now lower than readState.Index' (duration: 37.374187ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:41:45.577519Z","caller":"traceutil/trace.go:171","msg":"trace[1704100549] transaction","detail":"{read_only:false; response_revision:5794; number_of_response:1; }","duration":"168.039518ms","start":"2026-09-03T02:41:45.409451Z","end":"2026-09-03T02:41:45.57749Z","steps":["trace[1704100549] 'process raft request' (duration: 167.856343ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:41:45.577763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.283311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-03T02:41:45.577825Z","caller":"traceutil/trace.go:171","msg":"trace[197716694] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5794; }","duration":"142.384044ms","start":"2026-09-03T02:41:45.435425Z","end":"2026-09-03T02:41:45.577809Z","steps":["trace[197716694] 'agreement among raft nodes before linearized reading' (duration: 142.145218ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:45.748978Z","caller":"traceutil/trace.go:171","msg":"trace[219382786] linearizableReadLoop","detail":"{readStateIndex:6010; appliedIndex:6009; }","duration":"102.221359ms","start":"2026-09-03T02:41:45.646737Z","end":"2026-09-03T02:41:45.748959Z","steps":["trace[219382786] 'read index received' (duration: 102.123976ms)","trace[219382786] 'applied index is now lower than readState.Index' (duration: 95.963µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:41:45.749029Z","caller":"traceutil/trace.go:171","msg":"trace[965538408] transaction","detail":"{read_only:false; response_revision:5795; number_of_response:1; }","duration":"156.884252ms","start":"2026-09-03T02:41:45.592117Z","end":"2026-09-03T02:41:45.749001Z","steps":["trace[965538408] 'process raft request' (duration: 156.704777ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:41:45.749136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.384143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T02:41:45.749219Z","caller":"traceutil/trace.go:171","msg":"trace[673662537] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5795; }","duration":"102.521967ms","start":"2026-09-03T02:41:45.646683Z","end":"2026-09-03T02:41:45.749205Z","steps":["trace[673662537] 'agreement among raft nodes before linearized reading' (duration: 102.391423ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:41:45.772713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.951844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-03T02:41:45.772812Z","caller":"traceutil/trace.go:171","msg":"trace[1023265189] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5798; }","duration":"117.081508ms","start":"2026-09-03T02:41:45.655703Z","end":"2026-09-03T02:41:45.772785Z","steps":["trace[1023265189] 'agreement among raft nodes before linearized reading' (duration: 116.791ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:41:45.853196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.865897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T02:41:45.853282Z","caller":"traceutil/trace.go:171","msg":"trace[1338015384] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5803; }","duration":"103.017532ms","start":"2026-09-03T02:41:45.750244Z","end":"2026-09-03T02:41:45.853261Z","steps":["trace[1338015384] 'agreement among raft nodes before linearized reading' (duration: 102.838607ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:47.786139Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2940} {"level":"info","ts":"2026-09-03T02:41:47.86324Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2940,"took":"75.509566ms","hash":3413182144,"current-db-size-bytes":56958976,"current-db-size":"57 MB","current-db-size-in-use-bytes":32399360,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-03T02:41:47.863301Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3413182144,"revision":2940,"compact-revision":-1} {"level":"warn","ts":"2026-09-03T02:41:58.077918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.898598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-03T02:41:58.077995Z","caller":"traceutil/trace.go:171","msg":"trace[478345647] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5916; }","duration":"127.032801ms","start":"2026-09-03T02:41:57.950943Z","end":"2026-09-03T02:41:58.077976Z","steps":["trace[478345647] 'range keys from in-memory index tree' (duration: 126.578649ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:41:58.206884Z","caller":"traceutil/trace.go:171","msg":"trace[119067416] transaction","detail":"{read_only:false; response_revision:5917; number_of_response:1; }","duration":"124.246464ms","start":"2026-09-03T02:41:58.082613Z","end":"2026-09-03T02:41:58.206859Z","steps":["trace[119067416] 'process raft request' (duration: 124.123751ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:46:47.794899Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5838} {"level":"info","ts":"2026-09-03T02:46:47.891285Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5838,"took":"94.365065ms","hash":3683716894,"current-db-size-bytes":56958976,"current-db-size":"57 MB","current-db-size-in-use-bytes":26152960,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-03T02:46:47.891384Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3683716894,"revision":5838,"compact-revision":2940} {"level":"warn","ts":"2026-09-03T02:48:05.221763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.957461ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-03T02:48:05.22196Z","caller":"traceutil/trace.go:171","msg":"trace[615346969] transaction","detail":"{read_only:false; response_revision:8651; number_of_response:1; }","duration":"268.495923ms","start":"2026-09-03T02:48:04.953446Z","end":"2026-09-03T02:48:05.221942Z","steps":["trace[615346969] 'process raft request' (duration: 268.433791ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:05.222185Z","caller":"traceutil/trace.go:171","msg":"trace[958176544] linearizableReadLoop","detail":"{readStateIndex:8957; appliedIndex:8956; }","duration":"461.92541ms","start":"2026-09-03T02:48:04.760236Z","end":"2026-09-03T02:48:05.222161Z","steps":["trace[958176544] 'read index received' (duration: 324.487146ms)","trace[958176544] 'applied index is now lower than readState.Index' (duration: 137.435804ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:48:05.222215Z","caller":"traceutil/trace.go:171","msg":"trace[1699802459] transaction","detail":"{read_only:false; response_revision:8650; number_of_response:1; }","duration":"466.036783ms","start":"2026-09-03T02:48:04.756134Z","end":"2026-09-03T02:48:05.222171Z","steps":["trace[1699802459] 'process raft request' (duration: 328.576779ms)","trace[1699802459] 'compare' (duration: 136.808856ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T02:48:05.222389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.137966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-09-03T02:48:05.222406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:48:04.756112Z","time spent":"466.179696ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T02:48:05.222449Z","caller":"traceutil/trace.go:171","msg":"trace[429971415] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8651; }","duration":"462.231248ms","start":"2026-09-03T02:48:04.760204Z","end":"2026-09-03T02:48:05.222435Z","steps":["trace[429971415] 'agreement among raft nodes before linearized reading' (duration: 462.021621ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:48:05.22248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:48:04.76019Z","time spent":"462.2831ms","remote":"127.0.0.1:49632","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":"info","ts":"2026-09-03T02:48:05.280461Z","caller":"traceutil/trace.go:171","msg":"trace[154038982] transaction","detail":"{read_only:false; response_revision:8652; number_of_response:1; }","duration":"100.634306ms","start":"2026-09-03T02:48:05.179803Z","end":"2026-09-03T02:48:05.280438Z","steps":["trace[154038982] 'process raft request' (duration: 100.476141ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:05.325542Z","caller":"traceutil/trace.go:171","msg":"trace[232360571] transaction","detail":"{read_only:false; response_revision:8653; number_of_response:1; }","duration":"143.969512ms","start":"2026-09-03T02:48:05.181548Z","end":"2026-09-03T02:48:05.325517Z","steps":["trace[232360571] 'process raft request' (duration: 143.730756ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:05.325837Z","caller":"traceutil/trace.go:171","msg":"trace[1120795436] linearizableReadLoop","detail":"{readStateIndex:8960; appliedIndex:8958; }","duration":"103.566156ms","start":"2026-09-03T02:48:05.22224Z","end":"2026-09-03T02:48:05.325806Z","steps":["trace[1120795436] 'read index received' (duration: 58.06237ms)","trace[1120795436] 'applied index is now lower than readState.Index' (duration: 45.502886ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T02:48:05.325992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.32211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-03T02:48:05.326026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.833586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"info","ts":"2026-09-03T02:48:05.326086Z","caller":"traceutil/trace.go:171","msg":"trace[1734200804] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:8655; }","duration":"558.451225ms","start":"2026-09-03T02:48:04.767599Z","end":"2026-09-03T02:48:05.32605Z","steps":["trace[1734200804] 'agreement among raft nodes before linearized reading' (duration: 558.30655ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:05.326087Z","caller":"traceutil/trace.go:171","msg":"trace[1481561394] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8655; }","duration":"366.905648ms","start":"2026-09-03T02:48:04.959166Z","end":"2026-09-03T02:48:05.326072Z","steps":["trace[1481561394] 'agreement among raft nodes before linearized reading' (duration: 366.728402ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:48:05.326132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:48:04.959105Z","time spent":"367.016411ms","remote":"127.0.0.1:49576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12234,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-09-03T02:48:05.326133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:48:04.767569Z","time spent":"558.551558ms","remote":"127.0.0.1:49878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":3,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-09-03T02:48:15.527935Z","caller":"traceutil/trace.go:171","msg":"trace[927463856] transaction","detail":"{read_only:false; response_revision:8703; number_of_response:1; }","duration":"170.350556ms","start":"2026-09-03T02:48:15.357563Z","end":"2026-09-03T02:48:15.527914Z","steps":["trace[927463856] 'process raft request' (duration: 170.237843ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:15.527928Z","caller":"traceutil/trace.go:171","msg":"trace[83578628] transaction","detail":"{read_only:false; response_revision:8702; number_of_response:1; }","duration":"218.207916ms","start":"2026-09-03T02:48:15.309691Z","end":"2026-09-03T02:48:15.527899Z","steps":["trace[83578628] 'process raft request' (duration: 214.891546ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:15.528136Z","caller":"traceutil/trace.go:171","msg":"trace[237592909] linearizableReadLoop","detail":"{readStateIndex:9013; appliedIndex:9010; }","duration":"162.4943ms","start":"2026-09-03T02:48:15.365628Z","end":"2026-09-03T02:48:15.528122Z","steps":["trace[237592909] 'read index received' (duration: 159.045756ms)","trace[237592909] 'applied index is now lower than readState.Index' (duration: 3.447574ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:48:15.528181Z","caller":"traceutil/trace.go:171","msg":"trace[338515991] transaction","detail":"{read_only:false; response_revision:8704; number_of_response:1; }","duration":"170.575621ms","start":"2026-09-03T02:48:15.357583Z","end":"2026-09-03T02:48:15.528159Z","steps":["trace[338515991] 'process raft request' (duration: 170.289724ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:48:15.528353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.690335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-03T02:48:15.528392Z","caller":"traceutil/trace.go:171","msg":"trace[2133337223] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8704; }","duration":"162.807098ms","start":"2026-09-03T02:48:15.365576Z","end":"2026-09-03T02:48:15.528383Z","steps":["trace[2133337223] 'agreement among raft nodes before linearized reading' (duration: 162.619603ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:15.765476Z","caller":"traceutil/trace.go:171","msg":"trace[1357063933] transaction","detail":"{read_only:false; response_revision:8705; number_of_response:1; }","duration":"398.01739ms","start":"2026-09-03T02:48:15.367416Z","end":"2026-09-03T02:48:15.765433Z","steps":["trace[1357063933] 'process raft request' (duration: 315.944883ms)","trace[1357063933] 'compare' (duration: 81.486931ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T02:48:15.765674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:48:15.367397Z","time spent":"398.177564ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T02:48:15.767346Z","caller":"traceutil/trace.go:171","msg":"trace[1601331038] transaction","detail":"{read_only:false; response_revision:8707; number_of_response:1; }","duration":"234.564814ms","start":"2026-09-03T02:48:15.53272Z","end":"2026-09-03T02:48:15.767285Z","steps":["trace[1601331038] 'process raft request' (duration: 234.490102ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:15.767817Z","caller":"traceutil/trace.go:171","msg":"trace[273431553] linearizableReadLoop","detail":"{readStateIndex:9015; appliedIndex:9013; }","duration":"239.587131ms","start":"2026-09-03T02:48:15.528171Z","end":"2026-09-03T02:48:15.767758Z","steps":["trace[273431553] 'read index received' (duration: 155.20535ms)","trace[273431553] 'applied index is now lower than readState.Index' (duration: 84.376211ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T02:48:15.768072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.941645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T02:48:15.768107Z","caller":"traceutil/trace.go:171","msg":"trace[219744762] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8707; }","duration":"120.050827ms","start":"2026-09-03T02:48:15.648046Z","end":"2026-09-03T02:48:15.768097Z","steps":["trace[219744762] 'agreement among raft nodes before linearized reading' (duration: 119.945804ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:48:15.768099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.058454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"warn","ts":"2026-09-03T02:48:15.768132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.765261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-03T02:48:15.76817Z","caller":"traceutil/trace.go:171","msg":"trace[1388307002] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8707; }","duration":"244.182377ms","start":"2026-09-03T02:48:15.52397Z","end":"2026-09-03T02:48:15.768152Z","steps":["trace[1388307002] 'agreement among raft nodes before linearized reading' (duration: 243.93548ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:15.768195Z","caller":"traceutil/trace.go:171","msg":"trace[991007418] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:8707; }","duration":"199.887594ms","start":"2026-09-03T02:48:15.56829Z","end":"2026-09-03T02:48:15.768177Z","steps":["trace[991007418] 'agreement among raft nodes before linearized reading' (duration: 199.704869ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:15.768655Z","caller":"traceutil/trace.go:171","msg":"trace[1028391724] transaction","detail":"{read_only:false; response_revision:8706; number_of_response:1; }","duration":"398.338518ms","start":"2026-09-03T02:48:15.369531Z","end":"2026-09-03T02:48:15.767869Z","steps":["trace[1028391724] 'process raft request' (duration: 396.700443ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:48:15.768751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T02:48:15.369511Z","time spent":"399.177661ms","remote":"127.0.0.1:35244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":415274,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-03T02:48:16.518955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.992992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-03T02:48:16.519026Z","caller":"traceutil/trace.go:171","msg":"trace[492737846] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8708; }","duration":"102.114446ms","start":"2026-09-03T02:48:16.416896Z","end":"2026-09-03T02:48:16.51901Z","steps":["trace[492737846] 'range keys from in-memory index tree' (duration: 101.88623ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:17.052262Z","caller":"traceutil/trace.go:171","msg":"trace[997379658] transaction","detail":"{read_only:false; response_revision:8712; number_of_response:1; }","duration":"190.736253ms","start":"2026-09-03T02:48:16.861498Z","end":"2026-09-03T02:48:17.052234Z","steps":["trace[997379658] 'process raft request' (duration: 190.514237ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:17.052713Z","caller":"traceutil/trace.go:171","msg":"trace[1017465973] linearizableReadLoop","detail":"{readStateIndex:9022; appliedIndex:9021; }","duration":"121.971221ms","start":"2026-09-03T02:48:16.930727Z","end":"2026-09-03T02:48:17.052698Z","steps":["trace[1017465973] 'read index received' (duration: 121.337963ms)","trace[1017465973] 'applied index is now lower than readState.Index' (duration: 632.058µs)"],"step_count":2} {"level":"warn","ts":"2026-09-03T02:48:17.052854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.097514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-03T02:48:17.052893Z","caller":"traceutil/trace.go:171","msg":"trace[277878411] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:8712; }","duration":"122.183067ms","start":"2026-09-03T02:48:16.930696Z","end":"2026-09-03T02:48:17.052879Z","steps":["trace[277878411] 'agreement among raft nodes before linearized reading' (duration: 122.055583ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:23.818369Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000236c.wal"} {"level":"warn","ts":"2026-09-03T02:48:43.112701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.066717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/rook-ceph/csi-rbdplugin-metrics\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T02:48:43.112807Z","caller":"traceutil/trace.go:171","msg":"trace[1417839820] range","detail":"{range_begin:/registry/services/specs/rook-ceph/csi-rbdplugin-metrics; range_end:; response_count:0; response_revision:8904; }","duration":"113.232811ms","start":"2026-09-03T02:48:42.999551Z","end":"2026-09-03T02:48:43.112784Z","steps":["trace[1417839820] 'range keys from in-memory index tree' (duration: 112.940963ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:47.606349Z","caller":"traceutil/trace.go:171","msg":"trace[1637523466] transaction","detail":"{read_only:false; response_revision:8928; number_of_response:1; }","duration":"101.646464ms","start":"2026-09-03T02:48:47.504681Z","end":"2026-09-03T02:48:47.606328Z","steps":["trace[1637523466] 'process raft request' (duration: 101.52134ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:47.878529Z","caller":"traceutil/trace.go:171","msg":"trace[1407049591] transaction","detail":"{read_only:false; response_revision:8929; number_of_response:1; }","duration":"214.727971ms","start":"2026-09-03T02:48:47.663778Z","end":"2026-09-03T02:48:47.878506Z","steps":["trace[1407049591] 'process raft request' (duration: 214.584247ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:47.879302Z","caller":"traceutil/trace.go:171","msg":"trace[1578505907] transaction","detail":"{read_only:false; response_revision:8931; number_of_response:1; }","duration":"206.674591ms","start":"2026-09-03T02:48:47.672573Z","end":"2026-09-03T02:48:47.879247Z","steps":["trace[1578505907] 'process raft request' (duration: 206.63103ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:47.879663Z","caller":"traceutil/trace.go:171","msg":"trace[1229221027] transaction","detail":"{read_only:false; response_revision:8930; number_of_response:1; }","duration":"214.513986ms","start":"2026-09-03T02:48:47.665133Z","end":"2026-09-03T02:48:47.879647Z","steps":["trace[1229221027] 'process raft request' (duration: 213.982052ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:49.19246Z","caller":"traceutil/trace.go:171","msg":"trace[157363499] linearizableReadLoop","detail":"{readStateIndex:9255; appliedIndex:9254; }","duration":"159.053767ms","start":"2026-09-03T02:48:49.033388Z","end":"2026-09-03T02:48:49.192442Z","steps":["trace[157363499] 'read index received' (duration: 158.937543ms)","trace[157363499] 'applied index is now lower than readState.Index' (duration: 115.573µs)"],"step_count":2} {"level":"warn","ts":"2026-09-03T02:48:49.192557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.147569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T02:48:49.192578Z","caller":"traceutil/trace.go:171","msg":"trace[714853168] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:8936; }","duration":"159.21072ms","start":"2026-09-03T02:48:49.03336Z","end":"2026-09-03T02:48:49.192571Z","steps":["trace[714853168] 'agreement among raft nodes before linearized reading' (duration: 159.153388ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:49.192655Z","caller":"traceutil/trace.go:171","msg":"trace[156363999] transaction","detail":"{read_only:false; response_revision:8936; number_of_response:1; }","duration":"178.213732ms","start":"2026-09-03T02:48:49.014418Z","end":"2026-09-03T02:48:49.192631Z","steps":["trace[156363999] 'process raft request' (duration: 177.899593ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:56.504864Z","caller":"traceutil/trace.go:171","msg":"trace[1060116197] transaction","detail":"{read_only:false; response_revision:8977; number_of_response:1; }","duration":"133.049116ms","start":"2026-09-03T02:48:56.37179Z","end":"2026-09-03T02:48:56.504839Z","steps":["trace[1060116197] 'process raft request' (duration: 132.919242ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:48:57.371503Z","caller":"traceutil/trace.go:171","msg":"trace[1789412698] transaction","detail":"{read_only:false; response_revision:8979; number_of_response:1; }","duration":"148.929579ms","start":"2026-09-03T02:48:57.222548Z","end":"2026-09-03T02:48:57.371477Z","steps":["trace[1789412698] 'process raft request' (duration: 148.786145ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:49:00.323812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.928931ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-03T02:49:00.324034Z","caller":"traceutil/trace.go:171","msg":"trace[1757237099] linearizableReadLoop","detail":"{readStateIndex:9328; appliedIndex:9326; }","duration":"273.080922ms","start":"2026-09-03T02:49:00.050938Z","end":"2026-09-03T02:49:00.324019Z","steps":["trace[1757237099] 'read index received' (duration: 173.896725ms)","trace[1757237099] 'applied index is now lower than readState.Index' (duration: 99.183247ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:49:00.324124Z","caller":"traceutil/trace.go:171","msg":"trace[2142409121] transaction","detail":"{read_only:false; response_revision:9005; number_of_response:1; }","duration":"295.617798ms","start":"2026-09-03T02:49:00.028497Z","end":"2026-09-03T02:49:00.324115Z","steps":["trace[2142409121] 'process raft request' (duration: 295.432513ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:49:00.324154Z","caller":"traceutil/trace.go:171","msg":"trace[1252360522] transaction","detail":"{read_only:false; number_of_response:1; response_revision:9004; }","duration":"297.566602ms","start":"2026-09-03T02:49:00.026525Z","end":"2026-09-03T02:49:00.324092Z","steps":["trace[1252360522] 'compare' (duration: 274.738146ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:49:00.324661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.841966ms","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-09-03T02:49:00.324698Z","caller":"traceutil/trace.go:171","msg":"trace[1315812589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9005; }","duration":"271.910529ms","start":"2026-09-03T02:49:00.052779Z","end":"2026-09-03T02:49:00.32469Z","steps":["trace[1315812589] 'agreement among raft nodes before linearized reading' (duration: 271.779385ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:49:00.324915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.984956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-03T02:49:00.324956Z","caller":"traceutil/trace.go:171","msg":"trace[485891045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9005; }","duration":"274.062638ms","start":"2026-09-03T02:49:00.050885Z","end":"2026-09-03T02:49:00.324948Z","steps":["trace[485891045] 'agreement among raft nodes before linearized reading' (duration: 273.983195ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:49:00.456474Z","caller":"traceutil/trace.go:171","msg":"trace[1640078625] transaction","detail":"{read_only:false; response_revision:9006; number_of_response:1; }","duration":"124.930792ms","start":"2026-09-03T02:49:00.331518Z","end":"2026-09-03T02:49:00.456449Z","steps":["trace[1640078625] 'process raft request' (duration: 124.789128ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:49:00.461776Z","caller":"traceutil/trace.go:171","msg":"trace[1480594867] linearizableReadLoop","detail":"{readStateIndex:9330; appliedIndex:9328; }","duration":"128.624844ms","start":"2026-09-03T02:49:00.333123Z","end":"2026-09-03T02:49:00.461748Z","steps":["trace[1480594867] 'read index received' (duration: 123.207026ms)","trace[1480594867] 'applied index is now lower than readState.Index' (duration: 5.416458ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:49:00.461924Z","caller":"traceutil/trace.go:171","msg":"trace[1887259565] transaction","detail":"{read_only:false; response_revision:9007; number_of_response:1; }","duration":"130.318819ms","start":"2026-09-03T02:49:00.331582Z","end":"2026-09-03T02:49:00.4619Z","steps":["trace[1887259565] 'process raft request' (duration: 130.019641ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:49:00.461986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.83661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-2vczx\" ","response":"range_response_count:1 size:4646"} {"level":"info","ts":"2026-09-03T02:49:00.462042Z","caller":"traceutil/trace.go:171","msg":"trace[1694934294] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-2vczx; range_end:; response_count:1; response_revision:9007; }","duration":"128.920212ms","start":"2026-09-03T02:49:00.333105Z","end":"2026-09-03T02:49:00.462026Z","steps":["trace[1694934294] 'agreement among raft nodes before linearized reading' (duration: 128.747637ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:50:01.176191Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"401ca643156fc5da","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-03T02:50:01.185898Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-09-03T02:50:01.185993Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-09-03T02:50:14.11385Z","caller":"traceutil/trace.go:171","msg":"trace[1164471217] transaction","detail":"{read_only:false; response_revision:9767; number_of_response:1; }","duration":"103.473025ms","start":"2026-09-03T02:50:14.010345Z","end":"2026-09-03T02:50:14.113818Z","steps":["trace[1164471217] 'process raft request' (duration: 55.673376ms)","trace[1164471217] 'compare' (duration: 47.619064ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:50:28.270609Z","caller":"traceutil/trace.go:171","msg":"trace[714222666] transaction","detail":"{read_only:false; response_revision:9846; number_of_response:1; }","duration":"270.091059ms","start":"2026-09-03T02:50:28.000491Z","end":"2026-09-03T02:50:28.270582Z","steps":["trace[714222666] 'process raft request' (duration: 269.878023ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:50:28.45154Z","caller":"traceutil/trace.go:171","msg":"trace[1634821161] transaction","detail":"{read_only:false; response_revision:9848; number_of_response:1; }","duration":"187.220078ms","start":"2026-09-03T02:50:28.264299Z","end":"2026-09-03T02:50:28.451519Z","steps":["trace[1634821161] 'process raft request' (duration: 187.118195ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:50:28.452018Z","caller":"traceutil/trace.go:171","msg":"trace[1251916574] transaction","detail":"{read_only:false; response_revision:9847; number_of_response:1; }","duration":"198.231901ms","start":"2026-09-03T02:50:28.253758Z","end":"2026-09-03T02:50:28.45199Z","steps":["trace[1251916574] 'process raft request' (duration: 186.19476ms)","trace[1251916574] 'compare' (duration: 11.209477ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:50:28.452077Z","caller":"traceutil/trace.go:171","msg":"trace[1021377703] transaction","detail":"{read_only:false; response_revision:9849; number_of_response:1; }","duration":"173.265816ms","start":"2026-09-03T02:50:28.278755Z","end":"2026-09-03T02:50:28.45202Z","steps":["trace[1021377703] 'process raft request' (duration: 172.71614ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:51:47.801289Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8009} {"level":"info","ts":"2026-09-03T02:51:47.866375Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8009,"took":"63.106829ms","hash":3907743319,"current-db-size-bytes":56958976,"current-db-size":"57 MB","current-db-size-in-use-bytes":27881472,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-03T02:51:47.866425Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3907743319,"revision":8009,"compact-revision":5838} {"level":"info","ts":"2026-09-03T02:55:49.82375Z","caller":"traceutil/trace.go:171","msg":"trace[1205605237] transaction","detail":"{read_only:false; response_revision:12180; number_of_response:1; }","duration":"112.253745ms","start":"2026-09-03T02:55:49.711468Z","end":"2026-09-03T02:55:49.823721Z","steps":["trace[1205605237] 'process raft request' (duration: 112.053689ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T02:55:49.824484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.631669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-g5tld\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-09-03T02:55:49.824541Z","caller":"traceutil/trace.go:171","msg":"trace[307482122] range","detail":"{range_begin:/registry/pods/openstack/keepalived-g5tld; range_end:; response_count:1; response_revision:12181; }","duration":"103.70462ms","start":"2026-09-03T02:55:49.720824Z","end":"2026-09-03T02:55:49.824529Z","steps":["trace[307482122] 'agreement among raft nodes before linearized reading' (duration: 103.129285ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T02:56:09.885576Z","caller":"traceutil/trace.go:171","msg":"trace[1385030585] transaction","detail":"{read_only:false; response_revision:12290; number_of_response:1; }","duration":"271.072365ms","start":"2026-09-03T02:56:09.61447Z","end":"2026-09-03T02:56:09.885542Z","steps":["trace[1385030585] 'process raft request' (duration: 222.444353ms)","trace[1385030585] 'compare' (duration: 48.516559ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T02:56:47.808012Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10380} {"level":"info","ts":"2026-09-03T02:56:47.902023Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10380,"took":"91.512426ms","hash":1192810097,"current-db-size-bytes":56958976,"current-db-size":"57 MB","current-db-size-in-use-bytes":26185728,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-03T02:56:47.902091Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1192810097,"revision":10380,"compact-revision":8009} {"level":"info","ts":"2026-09-03T03:01:47.813838Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12563} {"level":"info","ts":"2026-09-03T03:01:47.895507Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12563,"took":"79.389076ms","hash":541500851,"current-db-size-bytes":56958976,"current-db-size":"57 MB","current-db-size-in-use-bytes":27607040,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-03T03:01:47.895688Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":541500851,"revision":12563,"compact-revision":10380} {"level":"info","ts":"2026-09-03T03:02:18.972828Z","caller":"traceutil/trace.go:171","msg":"trace[2087920750] linearizableReadLoop","detail":"{readStateIndex:15293; appliedIndex:15291; }","duration":"200.067925ms","start":"2026-09-03T03:02:18.772739Z","end":"2026-09-03T03:02:18.972807Z","steps":["trace[2087920750] 'read index received' (duration: 74.02883ms)","trace[2087920750] 'applied index is now lower than readState.Index' (duration: 126.038305ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T03:02:18.972979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.220009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-03T03:02:18.972959Z","caller":"traceutil/trace.go:171","msg":"trace[1850969346] transaction","detail":"{read_only:false; response_revision:14778; number_of_response:1; }","duration":"217.629646ms","start":"2026-09-03T03:02:18.755303Z","end":"2026-09-03T03:02:18.972933Z","steps":["trace[1850969346] 'process raft request' (duration: 217.297836ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:02:18.972974Z","caller":"traceutil/trace.go:171","msg":"trace[240817918] transaction","detail":"{read_only:false; response_revision:14779; number_of_response:1; }","duration":"196.935889ms","start":"2026-09-03T03:02:18.775994Z","end":"2026-09-03T03:02:18.97293Z","steps":["trace[240817918] 'process raft request' (duration: 196.750154ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:02:18.973017Z","caller":"traceutil/trace.go:171","msg":"trace[1463357694] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:14779; }","duration":"200.305151ms","start":"2026-09-03T03:02:18.772701Z","end":"2026-09-03T03:02:18.973006Z","steps":["trace[1463357694] 'agreement among raft nodes before linearized reading' (duration: 200.218549ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:02:18.973684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.299859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T03:02:18.973744Z","caller":"traceutil/trace.go:171","msg":"trace[204326705] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:14780; }","duration":"166.396402ms","start":"2026-09-03T03:02:18.807334Z","end":"2026-09-03T03:02:18.97373Z","steps":["trace[204326705] 'agreement among raft nodes before linearized reading' (duration: 166.297509ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:02:18.973965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.710729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T03:02:18.974021Z","caller":"traceutil/trace.go:171","msg":"trace[835201403] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:14780; }","duration":"120.798481ms","start":"2026-09-03T03:02:18.853208Z","end":"2026-09-03T03:02:18.974007Z","steps":["trace[835201403] 'agreement among raft nodes before linearized reading' (duration: 120.715089ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:02:18.974149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.665941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-03T03:02:18.974227Z","caller":"traceutil/trace.go:171","msg":"trace[782985645] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:14780; }","duration":"134.783045ms","start":"2026-09-03T03:02:18.839413Z","end":"2026-09-03T03:02:18.974196Z","steps":["trace[782985645] 'agreement among raft nodes before linearized reading' (duration: 134.674062ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:02:59.668104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.713274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-03T03:02:59.668193Z","caller":"traceutil/trace.go:171","msg":"trace[1112584726] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15007; }","duration":"381.850887ms","start":"2026-09-03T03:02:59.28632Z","end":"2026-09-03T03:02:59.668171Z","steps":["trace[1112584726] 'range keys from in-memory index tree' (duration: 381.430776ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:02:59.668228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:02:59.286297Z","time spent":"381.92305ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-03T03:02:59.668283Z","caller":"traceutil/trace.go:171","msg":"trace[1888384831] linearizableReadLoop","detail":"{readStateIndex:15533; appliedIndex:15532; }","duration":"215.906389ms","start":"2026-09-03T03:02:59.452343Z","end":"2026-09-03T03:02:59.66825Z","steps":["trace[1888384831] 'read index received' (duration: 183.585313ms)","trace[1888384831] 'applied index is now lower than readState.Index' (duration: 32.319035ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T03:02:59.668405Z","caller":"traceutil/trace.go:171","msg":"trace[1033055619] transaction","detail":"{read_only:false; response_revision:15008; number_of_response:1; }","duration":"275.616946ms","start":"2026-09-03T03:02:59.392709Z","end":"2026-09-03T03:02:59.668326Z","steps":["trace[1033055619] 'process raft request' (duration: 243.201927ms)","trace[1033055619] 'compare' (duration: 32.133711ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T03:02:59.668511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.149197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T03:02:59.668611Z","caller":"traceutil/trace.go:171","msg":"trace[954300485] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:15008; }","duration":"216.320561ms","start":"2026-09-03T03:02:59.452266Z","end":"2026-09-03T03:02:59.668587Z","steps":["trace[954300485] 'agreement among raft nodes before linearized reading' (duration: 216.115304ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:02:59.735888Z","caller":"traceutil/trace.go:171","msg":"trace[329260084] transaction","detail":"{read_only:false; response_revision:15009; number_of_response:1; }","duration":"266.854946ms","start":"2026-09-03T03:02:59.469011Z","end":"2026-09-03T03:02:59.735866Z","steps":["trace[329260084] 'process raft request' (duration: 266.487035ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:02:59.73619Z","caller":"traceutil/trace.go:171","msg":"trace[1993196774] transaction","detail":"{read_only:false; response_revision:15010; number_of_response:1; }","duration":"266.020593ms","start":"2026-09-03T03:02:59.470136Z","end":"2026-09-03T03:02:59.736156Z","steps":["trace[1993196774] 'process raft request' (duration: 265.674763ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:02:59.736234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.527676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-03T03:02:59.736334Z","caller":"traceutil/trace.go:171","msg":"trace[1600400991] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:15010; }","duration":"150.704322ms","start":"2026-09-03T03:02:59.58561Z","end":"2026-09-03T03:02:59.736314Z","steps":["trace[1600400991] 'agreement among raft nodes before linearized reading' (duration: 150.502256ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:02:59.736529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.387145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-g5tld\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-09-03T03:02:59.736624Z","caller":"traceutil/trace.go:171","msg":"trace[1229764698] range","detail":"{range_begin:/registry/pods/openstack/keepalived-g5tld; range_end:; response_count:1; response_revision:15010; }","duration":"269.538519ms","start":"2026-09-03T03:02:59.467062Z","end":"2026-09-03T03:02:59.736601Z","steps":["trace[1229764698] 'agreement among raft nodes before linearized reading' (duration: 269.171729ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:03:23.259788Z","caller":"traceutil/trace.go:171","msg":"trace[484232867] linearizableReadLoop","detail":"{readStateIndex:15861; appliedIndex:15860; }","duration":"260.041339ms","start":"2026-09-03T03:03:22.999726Z","end":"2026-09-03T03:03:23.259767Z","steps":["trace[484232867] 'read index received' (duration: 259.946967ms)","trace[484232867] 'applied index is now lower than readState.Index' (duration: 93.412µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T03:03:23.25992Z","caller":"traceutil/trace.go:171","msg":"trace[15605935] transaction","detail":"{read_only:false; response_revision:15322; number_of_response:1; }","duration":"379.638317ms","start":"2026-09-03T03:03:22.880243Z","end":"2026-09-03T03:03:23.259881Z","steps":["trace[15605935] 'process raft request' (duration: 379.352269ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:03:23.259991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.252444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-03T03:03:23.260025Z","caller":"traceutil/trace.go:171","msg":"trace[463256419] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15322; }","duration":"260.330357ms","start":"2026-09-03T03:03:22.999684Z","end":"2026-09-03T03:03:23.260015Z","steps":["trace[463256419] 'agreement among raft nodes before linearized reading' (duration: 260.200823ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:03:23.260114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:03:22.880202Z","time spent":"379.808442ms","remote":"127.0.0.1:49576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3738,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-03T03:03:23.264534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.360362ms","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-09-03T03:03:23.264634Z","caller":"traceutil/trace.go:171","msg":"trace[1007498524] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:15323; }","duration":"169.536278ms","start":"2026-09-03T03:03:23.095076Z","end":"2026-09-03T03:03:23.264613Z","steps":["trace[1007498524] 'agreement among raft nodes before linearized reading' (duration: 169.380393ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:03:23.264803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.222765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T03:03:23.26494Z","caller":"traceutil/trace.go:171","msg":"trace[996601013] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:15323; }","duration":"248.40486ms","start":"2026-09-03T03:03:23.016498Z","end":"2026-09-03T03:03:23.264902Z","steps":["trace[996601013] 'agreement among raft nodes before linearized reading' (duration: 248.177544ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:04:49.662365Z","caller":"traceutil/trace.go:171","msg":"trace[1090131542] transaction","detail":"{read_only:false; response_revision:16131; number_of_response:1; }","duration":"109.735093ms","start":"2026-09-03T03:04:49.552605Z","end":"2026-09-03T03:04:49.66234Z","steps":["trace[1090131542] 'process raft request' (duration: 109.297381ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:04:50.060073Z","caller":"traceutil/trace.go:171","msg":"trace[724765630] linearizableReadLoop","detail":"{readStateIndex:16695; appliedIndex:16694; }","duration":"265.55476ms","start":"2026-09-03T03:04:49.794494Z","end":"2026-09-03T03:04:50.060049Z","steps":["trace[724765630] 'read index received' (duration: 265.358734ms)","trace[724765630] 'applied index is now lower than readState.Index' (duration: 195.176µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T03:04:50.060359Z","caller":"traceutil/trace.go:171","msg":"trace[1531218197] transaction","detail":"{read_only:false; response_revision:16134; number_of_response:1; }","duration":"273.326524ms","start":"2026-09-03T03:04:49.787019Z","end":"2026-09-03T03:04:50.060346Z","steps":["trace[1531218197] 'process raft request' (duration: 272.890942ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:04:50.060679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.167498ms","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-09-03T03:04:50.06072Z","caller":"traceutil/trace.go:171","msg":"trace[1199838471] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:16134; }","duration":"266.244519ms","start":"2026-09-03T03:04:49.794465Z","end":"2026-09-03T03:04:50.06071Z","steps":["trace[1199838471] 'agreement among raft nodes before linearized reading' (duration: 266.108975ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:04:50.060815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.495249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T03:04:50.060901Z","caller":"traceutil/trace.go:171","msg":"trace[418265041] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:16134; }","duration":"143.641814ms","start":"2026-09-03T03:04:49.917241Z","end":"2026-09-03T03:04:50.060883Z","steps":["trace[418265041] 'agreement among raft nodes before linearized reading' (duration: 143.48509ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:04:50.061247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.905287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-03T03:04:50.061289Z","caller":"traceutil/trace.go:171","msg":"trace[800499623] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:16134; }","duration":"101.98668ms","start":"2026-09-03T03:04:49.959291Z","end":"2026-09-03T03:04:50.061277Z","steps":["trace[800499623] 'agreement among raft nodes before linearized reading' (duration: 101.928128ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:06:47.822846Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14547} {"level":"info","ts":"2026-09-03T03:06:47.90947Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14547,"took":"83.728719ms","hash":1621544394,"current-db-size-bytes":56958976,"current-db-size":"57 MB","current-db-size-in-use-bytes":30355456,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-09-03T03:06:47.909562Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1621544394,"revision":14547,"compact-revision":12563} {"level":"info","ts":"2026-09-03T03:07:54.120654Z","caller":"traceutil/trace.go:171","msg":"trace[1447095782] transaction","detail":"{read_only:false; response_revision:17636; number_of_response:1; }","duration":"102.347551ms","start":"2026-09-03T03:07:54.018264Z","end":"2026-09-03T03:07:54.120611Z","steps":["trace[1447095782] 'process raft request' (duration: 69.475231ms)","trace[1447095782] 'compare' (duration: 32.729916ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T03:07:54.123849Z","caller":"traceutil/trace.go:171","msg":"trace[670663040] transaction","detail":"{read_only:false; response_revision:17637; number_of_response:1; }","duration":"104.86862ms","start":"2026-09-03T03:07:54.018961Z","end":"2026-09-03T03:07:54.12383Z","steps":["trace[670663040] 'process raft request' (duration: 104.273724ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:11:10.25599Z","caller":"traceutil/trace.go:171","msg":"trace[2030769164] linearizableReadLoop","detail":"{readStateIndex:19565; appliedIndex:19564; }","duration":"222.968527ms","start":"2026-09-03T03:11:10.032998Z","end":"2026-09-03T03:11:10.255967Z","steps":["trace[2030769164] 'read index received' (duration: 222.73638ms)","trace[2030769164] 'applied index is now lower than readState.Index' (duration: 230.517µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T03:11:10.256038Z","caller":"traceutil/trace.go:171","msg":"trace[755693469] transaction","detail":"{read_only:false; response_revision:18913; number_of_response:1; }","duration":"224.280533ms","start":"2026-09-03T03:11:10.031727Z","end":"2026-09-03T03:11:10.256008Z","steps":["trace[755693469] 'process raft request' (duration: 224.091418ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:11:10.256276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.264945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-03T03:11:10.256308Z","caller":"traceutil/trace.go:171","msg":"trace[1953608327] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18913; }","duration":"223.330767ms","start":"2026-09-03T03:11:10.032969Z","end":"2026-09-03T03:11:10.2563Z","steps":["trace[1953608327] 'agreement among raft nodes before linearized reading' (duration: 223.120931ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:11:17.644754Z","caller":"traceutil/trace.go:171","msg":"trace[647510888] linearizableReadLoop","detail":"{readStateIndex:19608; appliedIndex:19607; }","duration":"195.053404ms","start":"2026-09-03T03:11:17.449674Z","end":"2026-09-03T03:11:17.644728Z","steps":["trace[647510888] 'read index received' (duration: 194.894269ms)","trace[647510888] 'applied index is now lower than readState.Index' (duration: 158.195µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T03:11:17.645103Z","caller":"traceutil/trace.go:171","msg":"trace[1310808793] transaction","detail":"{read_only:false; response_revision:18953; number_of_response:1; }","duration":"282.224525ms","start":"2026-09-03T03:11:17.362865Z","end":"2026-09-03T03:11:17.64509Z","steps":["trace[1310808793] 'process raft request' (duration: 281.31594ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:11:17.645451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.763163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-phjwj\" ","response":"range_response_count:1 size:9788"} {"level":"info","ts":"2026-09-03T03:11:17.645499Z","caller":"traceutil/trace.go:171","msg":"trace[1184179324] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-phjwj; range_end:; response_count:1; response_revision:18953; }","duration":"195.847925ms","start":"2026-09-03T03:11:17.449637Z","end":"2026-09-03T03:11:17.645485Z","steps":["trace[1184179324] 'agreement among raft nodes before linearized reading' (duration: 195.706741ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:11:17.733674Z","caller":"traceutil/trace.go:171","msg":"trace[1616015659] transaction","detail":"{read_only:false; response_revision:18955; number_of_response:1; }","duration":"102.780693ms","start":"2026-09-03T03:11:17.630873Z","end":"2026-09-03T03:11:17.733653Z","steps":["trace[1616015659] 'process raft request' (duration: 102.733372ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:11:17.73381Z","caller":"traceutil/trace.go:171","msg":"trace[556598046] transaction","detail":"{read_only:false; response_revision:18954; number_of_response:1; }","duration":"119.504435ms","start":"2026-09-03T03:11:17.614296Z","end":"2026-09-03T03:11:17.733801Z","steps":["trace[556598046] 'process raft request' (duration: 119.183096ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:11:17.734692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.849184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-09-03T03:11:17.73473Z","caller":"traceutil/trace.go:171","msg":"trace[783524604] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18955; }","duration":"166.939356ms","start":"2026-09-03T03:11:17.567782Z","end":"2026-09-03T03:11:17.734721Z","steps":["trace[783524604] 'agreement among raft nodes before linearized reading' (duration: 166.820123ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:11:17.734785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.991928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:24 size:217538"} {"level":"info","ts":"2026-09-03T03:11:17.735039Z","caller":"traceutil/trace.go:171","msg":"trace[1466949853] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:24; response_revision:18955; }","duration":"163.08368ms","start":"2026-09-03T03:11:17.571756Z","end":"2026-09-03T03:11:17.73484Z","steps":["trace[1466949853] 'agreement among raft nodes before linearized reading' (duration: 162.683149ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:11:17.776006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.969807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-03T03:11:17.776078Z","caller":"traceutil/trace.go:171","msg":"trace[2082598214] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18956; }","duration":"125.08347ms","start":"2026-09-03T03:11:17.650971Z","end":"2026-09-03T03:11:17.776054Z","steps":["trace[2082598214] 'agreement among raft nodes before linearized reading' (duration: 124.113303ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:11:17.776852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.981593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:95 size:953646"} {"level":"info","ts":"2026-09-03T03:11:17.776938Z","caller":"traceutil/trace.go:171","msg":"trace[216442389] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:95; response_revision:18956; }","duration":"122.113006ms","start":"2026-09-03T03:11:17.654807Z","end":"2026-09-03T03:11:17.77692Z","steps":["trace[216442389] 'agreement among raft nodes before linearized reading' (duration: 120.379979ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:11:18.143887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.920731ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-03T03:11:18.144044Z","caller":"traceutil/trace.go:171","msg":"trace[651847411] linearizableReadLoop","detail":"{readStateIndex:19613; appliedIndex:19611; }","duration":"367.222416ms","start":"2026-09-03T03:11:17.776809Z","end":"2026-09-03T03:11:18.144031Z","steps":["trace[651847411] 'read index received' (duration: 95.050159ms)","trace[651847411] 'applied index is now lower than readState.Index' (duration: 272.171607ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T03:11:18.144039Z","caller":"traceutil/trace.go:171","msg":"trace[1769191923] transaction","detail":"{read_only:false; response_revision:18957; number_of_response:1; }","duration":"405.752241ms","start":"2026-09-03T03:11:17.738265Z","end":"2026-09-03T03:11:18.144017Z","steps":["trace[1769191923] 'process raft request' (duration: 133.616875ms)","trace[1769191923] 'compare' (duration: 271.680023ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T03:11:18.144111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.299578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-03T03:11:18.14413Z","caller":"traceutil/trace.go:171","msg":"trace[86339718] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18958; }","duration":"367.34281ms","start":"2026-09-03T03:11:17.77678Z","end":"2026-09-03T03:11:18.144123Z","steps":["trace[86339718] 'agreement among raft nodes before linearized reading' (duration: 367.284558ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:11:18.144146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:11:17.738245Z","time spent":"405.839674ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-03T03:11:18.144152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:11:17.776768Z","time spent":"367.37794ms","remote":"127.0.0.1:49378","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-09-03T03:11:18.144314Z","caller":"traceutil/trace.go:171","msg":"trace[1109337495] transaction","detail":"{read_only:false; response_revision:18958; number_of_response:1; }","duration":"378.792816ms","start":"2026-09-03T03:11:17.765513Z","end":"2026-09-03T03:11:18.144305Z","steps":["trace[1109337495] 'process raft request' (duration: 378.441166ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:11:18.144358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:11:17.765482Z","time spent":"378.852998ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T03:11:18.153339Z","caller":"traceutil/trace.go:171","msg":"trace[957797545] transaction","detail":"{read_only:false; response_revision:18959; number_of_response:1; }","duration":"339.073398ms","start":"2026-09-03T03:11:17.81424Z","end":"2026-09-03T03:11:18.153314Z","steps":["trace[957797545] 'process raft request' (duration: 338.936634ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:11:18.15344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:11:17.814188Z","time spent":"339.203221ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-03T03:11:18.812473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.593177ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-03T03:11:18.812784Z","caller":"traceutil/trace.go:171","msg":"trace[2058662377] linearizableReadLoop","detail":"{readStateIndex:19616; appliedIndex:19614; }","duration":"593.789612ms","start":"2026-09-03T03:11:18.218973Z","end":"2026-09-03T03:11:18.812763Z","steps":["trace[2058662377] 'read index received' (duration: 208.837366ms)","trace[2058662377] 'applied index is now lower than readState.Index' (duration: 384.951316ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T03:11:18.812973Z","caller":"traceutil/trace.go:171","msg":"trace[1924660322] transaction","detail":"{read_only:false; response_revision:18960; number_of_response:1; }","duration":"781.801401ms","start":"2026-09-03T03:11:18.031152Z","end":"2026-09-03T03:11:18.812953Z","steps":["trace[1924660322] 'process raft request' (duration: 396.611959ms)","trace[1924660322] 'compare' (duration: 383.828535ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T03:11:18.813398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:11:18.031132Z","time spent":"782.198242ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T03:11:18.813655Z","caller":"traceutil/trace.go:171","msg":"trace[1712639771] transaction","detail":"{read_only:false; response_revision:18961; number_of_response:1; }","duration":"666.217084ms","start":"2026-09-03T03:11:18.147421Z","end":"2026-09-03T03:11:18.813638Z","steps":["trace[1712639771] 'process raft request' (duration: 665.257268ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:11:18.813774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:11:18.147405Z","time spent":"666.329287ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-03T03:11:18.813958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.985995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-03T03:11:18.814034Z","caller":"traceutil/trace.go:171","msg":"trace[221615157] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:18961; }","duration":"595.096519ms","start":"2026-09-03T03:11:18.218919Z","end":"2026-09-03T03:11:18.814016Z","steps":["trace[221615157] 'agreement among raft nodes before linearized reading' (duration: 594.950775ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:11:18.814111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:11:18.218898Z","time spent":"595.194971ms","remote":"127.0.0.1:39228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":59,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-09-03T03:11:18.814498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.021365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-09-03T03:11:18.815756Z","caller":"traceutil/trace.go:171","msg":"trace[1973511176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18961; }","duration":"524.30046ms","start":"2026-09-03T03:11:18.291438Z","end":"2026-09-03T03:11:18.815738Z","steps":["trace[1973511176] 'agreement among raft nodes before linearized reading' (duration: 522.942003ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:11:18.815857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:11:18.291421Z","time spent":"524.417493ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-03T03:11:18.816011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.726672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-09-03T03:11:18.816042Z","caller":"traceutil/trace.go:171","msg":"trace[1359663152] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18961; }","duration":"353.795154ms","start":"2026-09-03T03:11:18.462239Z","end":"2026-09-03T03:11:18.816034Z","steps":["trace[1359663152] 'agreement among raft nodes before linearized reading' (duration: 353.342512ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:11:18.816061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:11:18.462194Z","time spent":"353.861507ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-03T03:11:18.816304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.155847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-09-03T03:11:18.816329Z","caller":"traceutil/trace.go:171","msg":"trace[1025002064] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18961; }","duration":"353.206538ms","start":"2026-09-03T03:11:18.463115Z","end":"2026-09-03T03:11:18.816322Z","steps":["trace[1025002064] 'agreement among raft nodes before linearized reading' (duration: 353.058004ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:11:18.816346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:11:18.4631Z","time spent":"353.241399ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-03T03:11:18.816537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.369713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-09-03T03:11:18.814544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.102963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-09-03T03:11:18.815484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.077944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-03T03:11:18.817573Z","caller":"traceutil/trace.go:171","msg":"trace[978213362] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:18961; }","duration":"146.156332ms","start":"2026-09-03T03:11:18.671394Z","end":"2026-09-03T03:11:18.81755Z","steps":["trace[978213362] 'agreement among raft nodes before linearized reading' (duration: 143.775756ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:11:18.817837Z","caller":"traceutil/trace.go:171","msg":"trace[22944129] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18961; }","duration":"524.68167ms","start":"2026-09-03T03:11:18.293141Z","end":"2026-09-03T03:11:18.817822Z","steps":["trace[22944129] 'agreement among raft nodes before linearized reading' (duration: 523.303461ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:11:18.818082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:11:18.29313Z","time spent":"524.931207ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-03T03:11:18.818332Z","caller":"traceutil/trace.go:171","msg":"trace[616112381] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:18961; }","duration":"242.913108ms","start":"2026-09-03T03:11:18.575401Z","end":"2026-09-03T03:11:18.818314Z","steps":["trace[616112381] 'agreement among raft nodes before linearized reading' (duration: 239.107243ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:11:19.011111Z","caller":"traceutil/trace.go:171","msg":"trace[1597398183] transaction","detail":"{read_only:false; response_revision:18964; number_of_response:1; }","duration":"189.167432ms","start":"2026-09-03T03:11:18.821913Z","end":"2026-09-03T03:11:19.01108Z","steps":["trace[1597398183] 'process raft request' (duration: 189.050898ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:11:19.011466Z","caller":"traceutil/trace.go:171","msg":"trace[176790439] transaction","detail":"{read_only:false; response_revision:18963; number_of_response:1; }","duration":"189.412419ms","start":"2026-09-03T03:11:18.821746Z","end":"2026-09-03T03:11:19.011159Z","steps":["trace[176790439] 'process raft request' (duration: 189.019718ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:11:19.011484Z","caller":"traceutil/trace.go:171","msg":"trace[1681424872] linearizableReadLoop","detail":"{readStateIndex:19620; appliedIndex:19617; }","duration":"102.879565ms","start":"2026-09-03T03:11:18.908525Z","end":"2026-09-03T03:11:19.011405Z","steps":["trace[1681424872] 'read index received' (duration: 101.294451ms)","trace[1681424872] 'applied index is now lower than readState.Index' (duration: 1.550283ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T03:11:19.011708Z","caller":"traceutil/trace.go:171","msg":"trace[2088669074] transaction","detail":"{read_only:false; response_revision:18965; number_of_response:1; }","duration":"189.577463ms","start":"2026-09-03T03:11:18.821965Z","end":"2026-09-03T03:11:19.011543Z","steps":["trace[2088669074] 'process raft request' (duration: 189.063969ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:11:19.011761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.209285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-03T03:11:19.012695Z","caller":"traceutil/trace.go:171","msg":"trace[1744329653] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat; range_end:; response_count:0; response_revision:18965; }","duration":"104.185512ms","start":"2026-09-03T03:11:18.908472Z","end":"2026-09-03T03:11:19.012657Z","steps":["trace[1744329653] 'agreement among raft nodes before linearized reading' (duration: 103.117022ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:11:47.830281Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16902} {"level":"info","ts":"2026-09-03T03:11:47.935142Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16902,"took":"101.778355ms","hash":3502940178,"current-db-size-bytes":56958976,"current-db-size":"57 MB","current-db-size-in-use-bytes":32067584,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-03T03:11:47.935197Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3502940178,"revision":16902,"compact-revision":14547} {"level":"info","ts":"2026-09-03T03:11:53.778941Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"401ca643156fc5da","local-member-applied-index":20003,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-03T03:11:53.793584Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20003} {"level":"info","ts":"2026-09-03T03:11:53.793761Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15003} {"level":"info","ts":"2026-09-03T03:16:47.836956Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19281} {"level":"info","ts":"2026-09-03T03:16:47.9434Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19281,"took":"102.771443ms","hash":1510864353,"current-db-size-bytes":56958976,"current-db-size":"57 MB","current-db-size-in-use-bytes":33456128,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-09-03T03:16:47.943461Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1510864353,"revision":19281,"compact-revision":16902} {"level":"info","ts":"2026-09-03T03:17:01.964939Z","caller":"traceutil/trace.go:171","msg":"trace[1152577840] transaction","detail":"{read_only:false; response_revision:21627; number_of_response:1; }","duration":"129.861657ms","start":"2026-09-03T03:17:01.835043Z","end":"2026-09-03T03:17:01.964905Z","steps":["trace[1152577840] 'process raft request' (duration: 129.668812ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:17:23.260018Z","caller":"traceutil/trace.go:171","msg":"trace[398742116] transaction","detail":"{read_only:false; response_revision:21735; number_of_response:1; }","duration":"179.502064ms","start":"2026-09-03T03:17:23.080492Z","end":"2026-09-03T03:17:23.259994Z","steps":["trace[398742116] 'process raft request' (duration: 179.34841ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:17:23.617154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.236772ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-03T03:17:23.61734Z","caller":"traceutil/trace.go:171","msg":"trace[980143789] linearizableReadLoop","detail":"{readStateIndex:22485; appliedIndex:22482; }","duration":"531.613238ms","start":"2026-09-03T03:17:23.085712Z","end":"2026-09-03T03:17:23.617326Z","steps":["trace[980143789] 'read index received' (duration: 174.331358ms)","trace[980143789] 'applied index is now lower than readState.Index' (duration: 357.28109ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T03:17:23.617586Z","caller":"traceutil/trace.go:171","msg":"trace[439240770] transaction","detail":"{read_only:false; response_revision:21736; number_of_response:1; }","duration":"536.102904ms","start":"2026-09-03T03:17:23.08147Z","end":"2026-09-03T03:17:23.617573Z","steps":["trace[439240770] 'process raft request' (duration: 359.357827ms)","trace[439240770] 'compare' (duration: 175.877303ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T03:17:23.617656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:17:23.081462Z","time spent":"536.160416ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T03:17:23.617816Z","caller":"traceutil/trace.go:171","msg":"trace[2100892753] transaction","detail":"{read_only:false; response_revision:21737; number_of_response:1; }","duration":"533.777788ms","start":"2026-09-03T03:17:23.084029Z","end":"2026-09-03T03:17:23.617806Z","steps":["trace[2100892753] 'process raft request' (duration: 533.211582ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:17:23.617873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:17:23.084018Z","time spent":"533.82677ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T03:17:23.617996Z","caller":"traceutil/trace.go:171","msg":"trace[1510219104] transaction","detail":"{read_only:false; response_revision:21738; number_of_response:1; }","duration":"533.198522ms","start":"2026-09-03T03:17:23.084789Z","end":"2026-09-03T03:17:23.617987Z","steps":["trace[1510219104] 'process raft request' (duration: 532.501843ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:17:23.618051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:17:23.084781Z","time spent":"533.242673ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-03T03:17:23.61824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.542254ms","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-09-03T03:17:23.618277Z","caller":"traceutil/trace.go:171","msg":"trace[1968086660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21738; }","duration":"532.640607ms","start":"2026-09-03T03:17:23.085625Z","end":"2026-09-03T03:17:23.618266Z","steps":["trace[1968086660] 'agreement among raft nodes before linearized reading' (duration: 532.531844ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:17:23.618303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:17:23.08555Z","time spent":"532.74636ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-03T03:17:23.61848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.563791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-03T03:17:23.618513Z","caller":"traceutil/trace.go:171","msg":"trace[352838716] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:21738; }","duration":"480.599072ms","start":"2026-09-03T03:17:23.137905Z","end":"2026-09-03T03:17:23.618504Z","steps":["trace[352838716] 'agreement among raft nodes before linearized reading' (duration: 480.515789ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:17:23.618537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:17:23.137859Z","time spent":"480.670423ms","remote":"127.0.0.1:49542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":13,"response size":31,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-09-03T03:17:23.618876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.693827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-03T03:17:23.618913Z","caller":"traceutil/trace.go:171","msg":"trace[1513578217] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:21738; }","duration":"322.767379ms","start":"2026-09-03T03:17:23.296138Z","end":"2026-09-03T03:17:23.618905Z","steps":["trace[1513578217] 'agreement among raft nodes before linearized reading' (duration: 322.682525ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:17:23.61894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:17:23.296123Z","time spent":"322.807949ms","remote":"127.0.0.1:49830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":44,"response size":31,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-09-03T03:17:23.973023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.975728ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-03T03:17:23.973171Z","caller":"traceutil/trace.go:171","msg":"trace[1844949853] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:21738; }","duration":"115.141302ms","start":"2026-09-03T03:17:23.858008Z","end":"2026-09-03T03:17:23.973149Z","steps":["trace[1844949853] 'range keys from in-memory index tree' (duration: 114.955696ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:17:23.973202Z","caller":"traceutil/trace.go:171","msg":"trace[2099351835] linearizableReadLoop","detail":"{readStateIndex:22486; appliedIndex:22485; }","duration":"286.380823ms","start":"2026-09-03T03:17:23.686801Z","end":"2026-09-03T03:17:23.973182Z","steps":["trace[2099351835] 'read index received' (duration: 190.533445ms)","trace[2099351835] 'applied index is now lower than readState.Index' (duration: 95.846138ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T03:17:23.973264Z","caller":"traceutil/trace.go:171","msg":"trace[2036419575] transaction","detail":"{read_only:false; response_revision:21739; number_of_response:1; }","duration":"349.182982ms","start":"2026-09-03T03:17:23.624057Z","end":"2026-09-03T03:17:23.97324Z","steps":["trace[2036419575] 'process raft request' (duration: 253.335923ms)","trace[2036419575] 'compare' (duration: 95.645433ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T03:17:23.973344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.392972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-03T03:17:23.973373Z","caller":"traceutil/trace.go:171","msg":"trace[797934139] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21739; }","duration":"238.467084ms","start":"2026-09-03T03:17:23.734899Z","end":"2026-09-03T03:17:23.973366Z","steps":["trace[797934139] 'agreement among raft nodes before linearized reading' (duration: 238.401643ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:17:23.973373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:17:23.624039Z","time spent":"349.269545ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-03T03:17:23.973394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.591769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/neutron-l3-agent-default-wbqp4.18d1b103b602426b\" ","response":"range_response_count:1 size:1387"} {"level":"info","ts":"2026-09-03T03:17:23.973441Z","caller":"traceutil/trace.go:171","msg":"trace[2087555105] range","detail":"{range_begin:/registry/events/openstack/neutron-l3-agent-default-wbqp4.18d1b103b602426b; range_end:; response_count:1; response_revision:21739; }","duration":"286.679551ms","start":"2026-09-03T03:17:23.686745Z","end":"2026-09-03T03:17:23.973425Z","steps":["trace[2087555105] 'agreement among raft nodes before linearized reading' (duration: 286.521237ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:17:23.973535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.709994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-09-03T03:17:23.973581Z","caller":"traceutil/trace.go:171","msg":"trace[2088960027] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21739; }","duration":"139.794946ms","start":"2026-09-03T03:17:23.833775Z","end":"2026-09-03T03:17:23.97357Z","steps":["trace[2088960027] 'agreement among raft nodes before linearized reading' (duration: 139.630792ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:17:24.321675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.622343ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-03T03:17:24.32191Z","caller":"traceutil/trace.go:171","msg":"trace[889951481] transaction","detail":"{read_only:false; response_revision:21741; number_of_response:1; }","duration":"311.374047ms","start":"2026-09-03T03:17:24.010513Z","end":"2026-09-03T03:17:24.321887Z","steps":["trace[889951481] 'process raft request' (duration: 311.283204ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:17:24.322021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:17:24.010498Z","time spent":"311.465289ms","remote":"127.0.0.1:49632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T03:17:24.322038Z","caller":"traceutil/trace.go:171","msg":"trace[1592607172] linearizableReadLoop","detail":"{readStateIndex:22487; appliedIndex:22486; }","duration":"344.83413ms","start":"2026-09-03T03:17:23.977177Z","end":"2026-09-03T03:17:24.322012Z","steps":["trace[1592607172] 'read index received' (duration: 156.830786ms)","trace[1592607172] 'applied index is now lower than readState.Index' (duration: 188.001644ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T03:17:24.322243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.057746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"warn","ts":"2026-09-03T03:17:24.322262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.658945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-09-03T03:17:24.322281Z","caller":"traceutil/trace.go:171","msg":"trace[346577313] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21741; }","duration":"345.118418ms","start":"2026-09-03T03:17:23.977153Z","end":"2026-09-03T03:17:24.322271Z","steps":["trace[346577313] 'agreement among raft nodes before linearized reading' (duration: 344.961283ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:17:24.322304Z","caller":"traceutil/trace.go:171","msg":"trace[308115082] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21741; }","duration":"257.746527ms","start":"2026-09-03T03:17:24.064545Z","end":"2026-09-03T03:17:24.322292Z","steps":["trace[308115082] 'agreement among raft nodes before linearized reading' (duration: 257.615404ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:17:24.322311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:17:23.977137Z","time spent":"345.16733ms","remote":"127.0.0.1:49576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12235,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-09-03T03:17:24.322651Z","caller":"traceutil/trace.go:171","msg":"trace[765171255] transaction","detail":"{read_only:false; response_revision:21740; number_of_response:1; }","duration":"345.918221ms","start":"2026-09-03T03:17:23.976137Z","end":"2026-09-03T03:17:24.322056Z","steps":["trace[765171255] 'process raft request' (duration: 157.812473ms)","trace[765171255] 'compare' (duration: 187.51189ms)"],"step_count":2} {"level":"warn","ts":"2026-09-03T03:17:24.322806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:17:23.976107Z","time spent":"346.592619ms","remote":"127.0.0.1:49466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1369,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T03:17:24.74544Z","caller":"traceutil/trace.go:171","msg":"trace[1048843931] linearizableReadLoop","detail":"{readStateIndex:22490; appliedIndex:22490; }","duration":"349.635745ms","start":"2026-09-03T03:17:24.39578Z","end":"2026-09-03T03:17:24.745416Z","steps":["trace[1048843931] 'read index received' (duration: 349.625784ms)","trace[1048843931] 'applied index is now lower than readState.Index' (duration: 8.751µs)"],"step_count":2} {"level":"info","ts":"2026-09-03T03:17:24.745479Z","caller":"traceutil/trace.go:171","msg":"trace[251357994] transaction","detail":"{read_only:false; response_revision:21743; number_of_response:1; }","duration":"416.468506ms","start":"2026-09-03T03:17:24.32897Z","end":"2026-09-03T03:17:24.745439Z","steps":["trace[251357994] 'process raft request' (duration: 416.267671ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:17:24.745611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.838831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-03T03:17:24.745619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:17:24.328952Z","time spent":"416.57443ms","remote":"127.0.0.1:49466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1377,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-03T03:17:24.745659Z","caller":"traceutil/trace.go:171","msg":"trace[1218130423] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21743; }","duration":"349.913293ms","start":"2026-09-03T03:17:24.395718Z","end":"2026-09-03T03:17:24.745631Z","steps":["trace[1218130423] 'agreement among raft nodes before linearized reading' (duration: 349.80748ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:17:24.745683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:17:24.395686Z","time spent":"349.992025ms","remote":"127.0.0.1:49830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-09-03T03:17:24.761077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.854063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-03T03:17:24.761075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.56415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-03T03:17:24.761149Z","caller":"traceutil/trace.go:171","msg":"trace[529182745] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21744; }","duration":"114.934687ms","start":"2026-09-03T03:17:24.646197Z","end":"2026-09-03T03:17:24.761132Z","steps":["trace[529182745] 'agreement among raft nodes before linearized reading' (duration: 114.769542ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:17:24.761168Z","caller":"traceutil/trace.go:171","msg":"trace[320186496] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:21744; }","duration":"350.732075ms","start":"2026-09-03T03:17:24.410413Z","end":"2026-09-03T03:17:24.761145Z","steps":["trace[320186496] 'agreement among raft nodes before linearized reading' (duration: 350.56537ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:17:24.76121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-03T03:17:24.410394Z","time spent":"350.805738ms","remote":"127.0.0.1:39864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true "} {"level":"info","ts":"2026-09-03T03:17:24.761522Z","caller":"traceutil/trace.go:171","msg":"trace[385973537] transaction","detail":"{read_only:false; response_revision:21744; number_of_response:1; }","duration":"159.064868ms","start":"2026-09-03T03:17:24.602434Z","end":"2026-09-03T03:17:24.761498Z","steps":["trace[385973537] 'process raft request' (duration: 158.364628ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:21:36.112488Z","caller":"traceutil/trace.go:171","msg":"trace[100054575] transaction","detail":"{read_only:false; response_revision:24308; number_of_response:1; }","duration":"137.154676ms","start":"2026-09-03T03:21:35.975309Z","end":"2026-09-03T03:21:36.112463Z","steps":["trace[100054575] 'process raft request' (duration: 136.679393ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:21:36.469113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.2012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-cainjector\" ","response":"range_response_count:1 size:987"} {"level":"info","ts":"2026-09-03T03:21:36.469183Z","caller":"traceutil/trace.go:171","msg":"trace[1642237718] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-cainjector; range_end:; response_count:1; response_revision:24308; }","duration":"238.309504ms","start":"2026-09-03T03:21:36.230858Z","end":"2026-09-03T03:21:36.469167Z","steps":["trace[1642237718] 'range keys from in-memory index tree' (duration: 237.997435ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:21:36.469289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.472521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-09-03T03:21:36.469368Z","caller":"traceutil/trace.go:171","msg":"trace[1849248298] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24308; }","duration":"268.560055ms","start":"2026-09-03T03:21:36.200792Z","end":"2026-09-03T03:21:36.469352Z","steps":["trace[1849248298] 'range keys from in-memory index tree' (duration: 268.307707ms)"],"step_count":1} {"level":"warn","ts":"2026-09-03T03:21:36.469486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.057003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-03T03:21:36.469556Z","caller":"traceutil/trace.go:171","msg":"trace[2092328575] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:24308; }","duration":"145.173697ms","start":"2026-09-03T03:21:36.324367Z","end":"2026-09-03T03:21:36.469541Z","steps":["trace[2092328575] 'count revisions from in-memory index tree' (duration: 144.965371ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:21:36.469852Z","caller":"traceutil/trace.go:171","msg":"trace[70724866] transaction","detail":"{read_only:false; response_revision:24309; number_of_response:1; }","duration":"130.605787ms","start":"2026-09-03T03:21:36.339229Z","end":"2026-09-03T03:21:36.469835Z","steps":["trace[70724866] 'process raft request' (duration: 81.649582ms)","trace[70724866] 'compare' (duration: 48.183243ms)"],"step_count":2} {"level":"info","ts":"2026-09-03T03:21:47.843038Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21556} {"level":"info","ts":"2026-09-03T03:21:47.95856Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21556,"took":"112.409047ms","hash":2727199271,"current-db-size-bytes":56958976,"current-db-size":"57 MB","current-db-size-in-use-bytes":42041344,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-09-03T03:21:47.958624Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2727199271,"revision":21556,"compact-revision":19281} {"level":"info","ts":"2026-09-03T03:22:22.408846Z","caller":"traceutil/trace.go:171","msg":"trace[1014348657] transaction","detail":"{read_only:false; response_revision:24745; number_of_response:1; }","duration":"103.702247ms","start":"2026-09-03T03:22:22.305116Z","end":"2026-09-03T03:22:22.408818Z","steps":["trace[1014348657] 'process raft request' (duration: 103.498082ms)"],"step_count":1} {"level":"info","ts":"2026-09-03T03:26:47.850689Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24412} {"level":"info","ts":"2026-09-03T03:26:48.007035Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24412,"took":"152.616874ms","hash":477912629,"current-db-size-bytes":56958976,"current-db-size":"57 MB","current-db-size-in-use-bytes":32284672,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-03T03:26:48.007107Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":477912629,"revision":24412,"compact-revision":21556} {"level":"info","ts":"2026-09-03T03:26:48.133656Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006cbc.wal"} {"level":"info","ts":"2026-09-03T03:31:31.413779Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"401ca643156fc5da","local-member-applied-index":30004,"local-member-snapshot-index":20003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-03T03:31:31.420304Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30004} {"level":"info","ts":"2026-09-03T03:31:31.420389Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25004} {"level":"info","ts":"2026-09-03T03:31:47.858282Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26933} {"level":"info","ts":"2026-09-03T03:31:48.022146Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26933,"took":"159.734057ms","hash":265080931,"current-db-size-bytes":56958976,"current-db-size":"57 MB","current-db-size-in-use-bytes":29364224,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-09-03T03:31:48.022235Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":265080931,"revision":26933,"compact-revision":24412}