{"level":"warn","ts":"2026-10-07T05:42:15.901915Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-07T05:42:15.902044Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.210: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.210:2380","--initial-cluster=instance=https://162.253.55.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.210: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-10-07T05:42:15.902177Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-07T05:42:15.902198Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.210:2380"]} {"level":"info","ts":"2026-10-07T05:42:15.902228Z","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-10-07T05:42:15.903471Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.210:2379"]} {"level":"info","ts":"2026-10-07T05:42:15.903605Z","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.210:2380"],"listen-peer-urls":["https://162.253.55.210:2380"],"advertise-client-urls":["https://162.253.55.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.210: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-10-07T05:42:15.906846Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.854055ms"} {"level":"info","ts":"2026-10-07T05:42:15.913809Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a6d0019d52d78795","cluster-id":"c90109516379646"} {"level":"info","ts":"2026-10-07T05:42:15.913925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 switched to configuration voters=()"} {"level":"info","ts":"2026-10-07T05:42:15.913968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 became follower at term 0"} {"level":"info","ts":"2026-10-07T05:42:15.913989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a6d0019d52d78795 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-07T05:42:15.914006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 became follower at term 1"} {"level":"info","ts":"2026-10-07T05:42:15.914068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 switched to configuration voters=(12020109180663203733)"} {"level":"warn","ts":"2026-10-07T05:42:15.920586Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-07T05:42:15.922985Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-07T05:42:15.925108Z","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-10-07T05:42:15.928691Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a6d0019d52d78795","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-07T05:42:15.928854Z","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-10-07T05:42:15.928894Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a6d0019d52d78795","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-07T05:42:15.928946Z","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-10-07T05:42:15.928972Z","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-10-07T05:42:15.930023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 switched to configuration voters=(12020109180663203733)"} {"level":"info","ts":"2026-10-07T05:42:15.93021Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c90109516379646","local-member-id":"a6d0019d52d78795","added-peer-id":"a6d0019d52d78795","added-peer-peer-urls":["https://162.253.55.210:2380"]} {"level":"info","ts":"2026-10-07T05:42:15.935678Z","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-10-07T05:42:15.935715Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.210:2380"} {"level":"info","ts":"2026-10-07T05:42:15.935787Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.210:2380"} {"level":"info","ts":"2026-10-07T05:42:15.936049Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a6d0019d52d78795","initial-advertise-peer-urls":["https://162.253.55.210:2380"],"listen-peer-urls":["https://162.253.55.210:2380"],"advertise-client-urls":["https://162.253.55.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-07T05:42:15.936097Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-07T05:42:16.014678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 is starting a new election at term 1"} {"level":"info","ts":"2026-10-07T05:42:16.014728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-07T05:42:16.014746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 received MsgPreVoteResp from a6d0019d52d78795 at term 1"} {"level":"info","ts":"2026-10-07T05:42:16.014762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 became candidate at term 2"} {"level":"info","ts":"2026-10-07T05:42:16.014774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 received MsgVoteResp from a6d0019d52d78795 at term 2"} {"level":"info","ts":"2026-10-07T05:42:16.014788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6d0019d52d78795 became leader at term 2"} {"level":"info","ts":"2026-10-07T05:42:16.014809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a6d0019d52d78795 elected leader a6d0019d52d78795 at term 2"} {"level":"info","ts":"2026-10-07T05:42:16.015785Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T05:42:16.016939Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-07T05:42:16.016941Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a6d0019d52d78795","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.210:2379]}","request-path":"/0/members/a6d0019d52d78795/attributes","cluster-id":"c90109516379646","publish-timeout":"7s"} {"level":"info","ts":"2026-10-07T05:42:16.016969Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-07T05:42:16.017236Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-07T05:42:16.017354Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-07T05:42:16.02023Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-07T05:42:16.020341Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.210:2379"} {"level":"info","ts":"2026-10-07T05:42:16.021275Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c90109516379646","local-member-id":"a6d0019d52d78795","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T05:42:16.02137Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T05:42:16.021403Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-07T05:42:34.200941Z","caller":"traceutil/trace.go:171","msg":"trace[1421379896] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"126.173842ms","start":"2026-10-07T05:42:34.074717Z","end":"2026-10-07T05:42:34.20089Z","steps":["trace[1421379896] 'process raft request' (duration: 125.902446ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:42:34.40051Z","caller":"traceutil/trace.go:171","msg":"trace[650913329] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"194.517853ms","start":"2026-10-07T05:42:34.205963Z","end":"2026-10-07T05:42:34.400481Z","steps":["trace[650913329] 'process raft request' (duration: 121.93941ms)","trace[650913329] 'compare' (duration: 72.132214ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:43:05.616662Z","caller":"traceutil/trace.go:171","msg":"trace[1640207425] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"151.171421ms","start":"2026-10-07T05:43:05.465457Z","end":"2026-10-07T05:43:05.616629Z","steps":["trace[1640207425] 'process raft request' (duration: 150.600341ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:43:06.123626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.764229ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-07T05:43:06.123756Z","caller":"traceutil/trace.go:171","msg":"trace[1031350094] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"403.211966ms","start":"2026-10-07T05:43:05.720527Z","end":"2026-10-07T05:43:06.123739Z","steps":["trace[1031350094] 'read index received' (duration: 259.857876ms)","trace[1031350094] 'applied index is now lower than readState.Index' (duration: 143.35279ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:43:06.123783Z","caller":"traceutil/trace.go:171","msg":"trace[202089915] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"428.987512ms","start":"2026-10-07T05:43:05.694763Z","end":"2026-10-07T05:43:06.123751Z","steps":["trace[202089915] 'process raft request' (duration: 285.5957ms)","trace[202089915] 'compare' (duration: 142.437114ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T05:43:06.123935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.402891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ncmkg\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-07T05:43:06.12399Z","caller":"traceutil/trace.go:171","msg":"trace[866072444] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ncmkg; range_end:; response_count:1; response_revision:604; }","duration":"403.498632ms","start":"2026-10-07T05:43:05.720482Z","end":"2026-10-07T05:43:06.12398Z","steps":["trace[866072444] 'agreement among raft nodes before linearized reading' (duration: 403.300958ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:43:06.124026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T05:43:05.720468Z","time spent":"403.550174ms","remote":"127.0.0.1:52844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-ncmkg\" "} {"level":"warn","ts":"2026-10-07T05:43:06.123933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T05:43:05.694734Z","time spent":"429.132255ms","remote":"127.0.0.1:53042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-07T05:44:41.230188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.917031ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-07T05:44:41.230303Z","caller":"traceutil/trace.go:171","msg":"trace[1681756324] linearizableReadLoop","detail":"{readStateIndex:1923; appliedIndex:1922; }","duration":"235.50523ms","start":"2026-10-07T05:44:40.99478Z","end":"2026-10-07T05:44:41.230285Z","steps":["trace[1681756324] 'read index received' (duration: 40.14066ms)","trace[1681756324] 'applied index is now lower than readState.Index' (duration: 195.36342ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:44:41.230318Z","caller":"traceutil/trace.go:171","msg":"trace[909848563] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"252.572824ms","start":"2026-10-07T05:44:40.977713Z","end":"2026-10-07T05:44:41.230286Z","steps":["trace[909848563] 'process raft request' (duration: 57.270126ms)","trace[909848563] 'compare' (duration: 194.797349ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T05:44:41.230414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.614622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T05:44:41.23048Z","caller":"traceutil/trace.go:171","msg":"trace[1387364965] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1847; }","duration":"235.722005ms","start":"2026-10-07T05:44:40.994739Z","end":"2026-10-07T05:44:41.230461Z","steps":["trace[1387364965] 'agreement among raft nodes before linearized reading' (duration: 235.607983ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:44:41.230572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.024786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T05:44:41.230639Z","caller":"traceutil/trace.go:171","msg":"trace[443876051] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1847; }","duration":"155.120649ms","start":"2026-10-07T05:44:41.075501Z","end":"2026-10-07T05:44:41.230621Z","steps":["trace[443876051] 'agreement among raft nodes before linearized reading' (duration: 155.013667ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:44:41.230693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.300806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-07T05:44:41.230728Z","caller":"traceutil/trace.go:171","msg":"trace[532254582] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1847; }","duration":"151.392868ms","start":"2026-10-07T05:44:41.079324Z","end":"2026-10-07T05:44:41.230717Z","steps":["trace[532254582] 'agreement among raft nodes before linearized reading' (duration: 151.179494ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:44:41.230682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.973598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-10-07T05:44:41.230786Z","caller":"traceutil/trace.go:171","msg":"trace[1784537872] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1847; }","duration":"200.136911ms","start":"2026-10-07T05:44:41.030626Z","end":"2026-10-07T05:44:41.230762Z","steps":["trace[1784537872] 'agreement among raft nodes before linearized reading' (duration: 199.798034ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:44:41.494289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.803796ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-07T05:44:41.494589Z","caller":"traceutil/trace.go:171","msg":"trace[951241545] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"256.808505ms","start":"2026-10-07T05:44:41.237741Z","end":"2026-10-07T05:44:41.494549Z","steps":["trace[951241545] 'process raft request' (duration: 256.648062ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:44:41.494607Z","caller":"traceutil/trace.go:171","msg":"trace[838152011] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"259.835042ms","start":"2026-10-07T05:44:41.234723Z","end":"2026-10-07T05:44:41.494558Z","steps":["trace[838152011] 'process raft request' (duration: 126.657329ms)","trace[838152011] 'compare' (duration: 132.671583ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:44:41.494622Z","caller":"traceutil/trace.go:171","msg":"trace[1746902510] linearizableReadLoop","detail":"{readStateIndex:1926; appliedIndex:1923; }","duration":"250.053217ms","start":"2026-10-07T05:44:41.244532Z","end":"2026-10-07T05:44:41.494585Z","steps":["trace[1746902510] 'read index received' (duration: 2.324394ms)","trace[1746902510] 'applied index is now lower than readState.Index' (duration: 247.726023ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:44:41.49466Z","caller":"traceutil/trace.go:171","msg":"trace[511631382] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"242.054405ms","start":"2026-10-07T05:44:41.252581Z","end":"2026-10-07T05:44:41.494636Z","steps":["trace[511631382] 'process raft request' (duration: 241.932592ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:44:41.494693Z","caller":"traceutil/trace.go:171","msg":"trace[1350293022] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"247.0739ms","start":"2026-10-07T05:44:41.247577Z","end":"2026-10-07T05:44:41.494651Z","steps":["trace[1350293022] 'process raft request' (duration: 246.897136ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:44:41.494856Z","caller":"traceutil/trace.go:171","msg":"trace[1097939947] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"227.985937ms","start":"2026-10-07T05:44:41.26684Z","end":"2026-10-07T05:44:41.494826Z","steps":["trace[1097939947] 'process raft request' (duration: 227.760044ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:44:41.494939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.413022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-07T05:44:41.494975Z","caller":"traceutil/trace.go:171","msg":"trace[1672218490] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1853; }","duration":"250.471944ms","start":"2026-10-07T05:44:41.244493Z","end":"2026-10-07T05:44:41.494965Z","steps":["trace[1672218490] 'agreement among raft nodes before linearized reading' (duration: 250.24772ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:44:41.494972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.353087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5bb17382-d122-455c-ba4a-086b1f05b441\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-10-07T05:44:41.495034Z","caller":"traceutil/trace.go:171","msg":"trace[1876597361] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5bb17382-d122-455c-ba4a-086b1f05b441; range_end:; response_count:1; response_revision:1853; }","duration":"207.46677ms","start":"2026-10-07T05:44:41.287547Z","end":"2026-10-07T05:44:41.495014Z","steps":["trace[1876597361] 'agreement among raft nodes before linearized reading' (duration: 207.264096ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:44:41.608481Z","caller":"traceutil/trace.go:171","msg":"trace[1503264162] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"108.875762ms","start":"2026-10-07T05:44:41.499574Z","end":"2026-10-07T05:44:41.60845Z","steps":["trace[1503264162] 'process raft request' (duration: 95.394217ms)","trace[1503264162] 'compare' (duration: 13.326682ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:44:54.836554Z","caller":"traceutil/trace.go:171","msg":"trace[2024412271] linearizableReadLoop","detail":"{readStateIndex:2041; appliedIndex:2040; }","duration":"106.748242ms","start":"2026-10-07T05:44:54.729788Z","end":"2026-10-07T05:44:54.836536Z","steps":["trace[2024412271] 'read index received' (duration: 106.548098ms)","trace[2024412271] 'applied index is now lower than readState.Index' (duration: 199.404µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:44:54.836687Z","caller":"traceutil/trace.go:171","msg":"trace[431426847] transaction","detail":"{read_only:false; response_revision:1963; number_of_response:1; }","duration":"107.343404ms","start":"2026-10-07T05:44:54.72932Z","end":"2026-10-07T05:44:54.836664Z","steps":["trace[431426847] 'process raft request' (duration: 107.081999ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:44:54.836739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.936606ms","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-10-07T05:44:54.836771Z","caller":"traceutil/trace.go:171","msg":"trace[96728551] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1963; }","duration":"107.000916ms","start":"2026-10-07T05:44:54.729758Z","end":"2026-10-07T05:44:54.836759Z","steps":["trace[96728551] 'agreement among raft nodes before linearized reading' (duration: 106.863014ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:45:25.614337Z","caller":"traceutil/trace.go:171","msg":"trace[897638233] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"164.920433ms","start":"2026-10-07T05:45:25.449382Z","end":"2026-10-07T05:45:25.614302Z","steps":["trace[897638233] 'process raft request' (duration: 69.370424ms)","trace[897638233] 'compare' (duration: 95.372806ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:45:31.794812Z","caller":"traceutil/trace.go:171","msg":"trace[1988218615] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"104.01131ms","start":"2026-10-07T05:45:31.690775Z","end":"2026-10-07T05:45:31.794787Z","steps":["trace[1988218615] 'process raft request' (duration: 90.563755ms)","trace[1988218615] 'compare' (duration: 13.338153ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T05:45:32.195477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.332484ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-07T05:45:32.195727Z","caller":"traceutil/trace.go:171","msg":"trace[1601291124] linearizableReadLoop","detail":"{readStateIndex:2271; appliedIndex:2269; }","duration":"100.342781ms","start":"2026-10-07T05:45:32.095358Z","end":"2026-10-07T05:45:32.195701Z","steps":["trace[1601291124] 'read index received' (duration: 89.581707ms)","trace[1601291124] 'applied index is now lower than readState.Index' (duration: 10.759784ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:45:32.195769Z","caller":"traceutil/trace.go:171","msg":"trace[580038245] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"343.354833ms","start":"2026-10-07T05:45:31.852372Z","end":"2026-10-07T05:45:32.195727Z","steps":["trace[580038245] 'process raft request' (duration: 142.662342ms)","trace[580038245] 'compare' (duration: 200.045589ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:45:32.195805Z","caller":"traceutil/trace.go:171","msg":"trace[1873024607] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"189.474088ms","start":"2026-10-07T05:45:32.006308Z","end":"2026-10-07T05:45:32.195783Z","steps":["trace[1873024607] 'process raft request' (duration: 189.287345ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:45:32.195937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T05:45:31.852332Z","time spent":"343.516207ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T05:45:32.195942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.582315ms","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-10-07T05:45:32.195991Z","caller":"traceutil/trace.go:171","msg":"trace[1274470034] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2184; }","duration":"100.671737ms","start":"2026-10-07T05:45:32.095303Z","end":"2026-10-07T05:45:32.195975Z","steps":["trace[1274470034] 'agreement among raft nodes before linearized reading' (duration: 100.465573ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:46:24.215355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.977507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-07T05:46:24.215471Z","caller":"traceutil/trace.go:171","msg":"trace[1267507374] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2635; }","duration":"173.220971ms","start":"2026-10-07T05:46:24.042226Z","end":"2026-10-07T05:46:24.215447Z","steps":["trace[1267507374] 'range keys from in-memory index tree' (duration: 172.761113ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:46:58.218017Z","caller":"traceutil/trace.go:171","msg":"trace[538338948] transaction","detail":"{read_only:false; response_revision:2838; number_of_response:1; }","duration":"123.004854ms","start":"2026-10-07T05:46:58.094992Z","end":"2026-10-07T05:46:58.217996Z","steps":["trace[538338948] 'process raft request' (duration: 122.877071ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:46:58.294826Z","caller":"traceutil/trace.go:171","msg":"trace[1775817307] transaction","detail":"{read_only:false; response_revision:2839; number_of_response:1; }","duration":"198.602692ms","start":"2026-10-07T05:46:58.096206Z","end":"2026-10-07T05:46:58.294808Z","steps":["trace[1775817307] 'process raft request' (duration: 198.47596ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:46:58.295105Z","caller":"traceutil/trace.go:171","msg":"trace[342704498] transaction","detail":"{read_only:false; response_revision:2840; number_of_response:1; }","duration":"196.433372ms","start":"2026-10-07T05:46:58.09865Z","end":"2026-10-07T05:46:58.295084Z","steps":["trace[342704498] 'process raft request' (duration: 196.125266ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:46:58.607893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.454855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-07T05:46:58.608Z","caller":"traceutil/trace.go:171","msg":"trace[2117065595] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2840; }","duration":"210.602398ms","start":"2026-10-07T05:46:58.397374Z","end":"2026-10-07T05:46:58.607976Z","steps":["trace[2117065595] 'range keys from in-memory index tree' (duration: 210.316182ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:50:11.100224Z","caller":"traceutil/trace.go:171","msg":"trace[892240769] transaction","detail":"{read_only:false; response_revision:4055; number_of_response:1; }","duration":"107.695638ms","start":"2026-10-07T05:50:10.99251Z","end":"2026-10-07T05:50:11.100205Z","steps":["trace[892240769] 'process raft request' (duration: 107.562506ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:50:11.114343Z","caller":"traceutil/trace.go:171","msg":"trace[1406625042] transaction","detail":"{read_only:false; response_revision:4056; number_of_response:1; }","duration":"121.720153ms","start":"2026-10-07T05:50:10.992589Z","end":"2026-10-07T05:50:11.114309Z","steps":["trace[1406625042] 'process raft request' (duration: 121.621631ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:51:42.012863Z","caller":"traceutil/trace.go:171","msg":"trace[1237824261] transaction","detail":"{read_only:false; response_revision:5141; number_of_response:1; }","duration":"115.309355ms","start":"2026-10-07T05:51:41.897524Z","end":"2026-10-07T05:51:42.012833Z","steps":["trace[1237824261] 'process raft request' (duration: 115.118112ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:51:42.148922Z","caller":"traceutil/trace.go:171","msg":"trace[1131028417] transaction","detail":"{read_only:false; response_revision:5143; number_of_response:1; }","duration":"127.983406ms","start":"2026-10-07T05:51:42.020901Z","end":"2026-10-07T05:51:42.148884Z","steps":["trace[1131028417] 'process raft request' (duration: 127.733641ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:51:42.148968Z","caller":"traceutil/trace.go:171","msg":"trace[454209545] transaction","detail":"{read_only:false; response_revision:5144; number_of_response:1; }","duration":"125.364036ms","start":"2026-10-07T05:51:42.023559Z","end":"2026-10-07T05:51:42.148923Z","steps":["trace[454209545] 'process raft request' (duration: 125.237784ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:51:44.691952Z","caller":"traceutil/trace.go:171","msg":"trace[1246385132] transaction","detail":"{read_only:false; response_revision:5264; number_of_response:1; }","duration":"270.366756ms","start":"2026-10-07T05:51:44.42155Z","end":"2026-10-07T05:51:44.691917Z","steps":["trace[1246385132] 'process raft request' (duration: 270.06513ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:52:01.216785Z","caller":"traceutil/trace.go:171","msg":"trace[291333849] transaction","detail":"{read_only:false; response_revision:5574; number_of_response:1; }","duration":"511.099679ms","start":"2026-10-07T05:52:00.70561Z","end":"2026-10-07T05:52:01.216709Z","steps":["trace[291333849] 'process raft request' (duration: 510.752672ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:52:01.216463Z","caller":"traceutil/trace.go:171","msg":"trace[450145335] transaction","detail":"{read_only:false; response_revision:5572; number_of_response:1; }","duration":"528.280424ms","start":"2026-10-07T05:52:00.688155Z","end":"2026-10-07T05:52:01.216435Z","steps":["trace[450145335] 'process raft request' (duration: 528.10596ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:52:01.217037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T05:52:00.705599Z","time spent":"511.310493ms","remote":"127.0.0.1:33346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7599,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T05:52:01.216511Z","caller":"traceutil/trace.go:171","msg":"trace[1624740386] transaction","detail":"{read_only:false; response_revision:5573; number_of_response:1; }","duration":"528.255863ms","start":"2026-10-07T05:52:00.688243Z","end":"2026-10-07T05:52:01.216499Z","steps":["trace[1624740386] 'process raft request' (duration: 528.072489ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:52:01.217195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T05:52:00.688125Z","time spent":"528.916796ms","remote":"127.0.0.1:52946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1067,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T05:52:01.216395Z","caller":"traceutil/trace.go:171","msg":"trace[1529739938] transaction","detail":"{read_only:false; response_revision:5571; number_of_response:1; }","duration":"528.188892ms","start":"2026-10-07T05:52:00.688155Z","end":"2026-10-07T05:52:01.216344Z","steps":["trace[1529739938] 'process raft request' (duration: 491.289512ms)","trace[1529739938] 'compare' (duration: 36.594544ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T05:52:01.2173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T05:52:00.688213Z","time spent":"528.982537ms","remote":"127.0.0.1:52946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1038,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T05:52:01.217414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T05:52:00.688124Z","time spent":"529.208752ms","remote":"127.0.0.1:52822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T05:52:01.216733Z","caller":"traceutil/trace.go:171","msg":"trace[1715379290] linearizableReadLoop","detail":"{readStateIndex:5787; appliedIndex:5783; }","duration":"223.107569ms","start":"2026-10-07T05:52:00.993564Z","end":"2026-10-07T05:52:01.216672Z","steps":["trace[1715379290] 'read index received' (duration: 186.004656ms)","trace[1715379290] 'applied index is now lower than readState.Index' (duration: 37.098473ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T05:52:01.217926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.343042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225408"} {"level":"info","ts":"2026-10-07T05:52:01.218024Z","caller":"traceutil/trace.go:171","msg":"trace[440769839] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5574; }","duration":"224.488955ms","start":"2026-10-07T05:52:00.99351Z","end":"2026-10-07T05:52:01.217999Z","steps":["trace[440769839] 'agreement among raft nodes before linearized reading' (duration: 223.263082ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:52:01.305778Z","caller":"traceutil/trace.go:171","msg":"trace[1144083690] transaction","detail":"{read_only:false; response_revision:5575; number_of_response:1; }","duration":"187.062366ms","start":"2026-10-07T05:52:01.118682Z","end":"2026-10-07T05:52:01.305744Z","steps":["trace[1144083690] 'process raft request' (duration: 186.791021ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:52:01.30592Z","caller":"traceutil/trace.go:171","msg":"trace[1770853211] transaction","detail":"{read_only:false; response_revision:5576; number_of_response:1; }","duration":"146.13548ms","start":"2026-10-07T05:52:01.159756Z","end":"2026-10-07T05:52:01.305891Z","steps":["trace[1770853211] 'process raft request' (duration: 145.914866ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:52:01.306034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.452851ms","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-10-07T05:52:01.306105Z","caller":"traceutil/trace.go:171","msg":"trace[1987968963] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5576; }","duration":"238.591643ms","start":"2026-10-07T05:52:01.067501Z","end":"2026-10-07T05:52:01.306093Z","steps":["trace[1987968963] 'agreement among raft nodes before linearized reading' (duration: 238.42357ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:52:16.315116Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2938} {"level":"info","ts":"2026-10-07T05:52:16.400572Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2938,"took":"83.934571ms","hash":2309341213,"current-db-size-bytes":57438208,"current-db-size":"57 MB","current-db-size-in-use-bytes":32227328,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-07T05:52:16.400661Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2309341213,"revision":2938,"compact-revision":-1} {"level":"info","ts":"2026-10-07T05:52:19.331778Z","caller":"traceutil/trace.go:171","msg":"trace[1847193546] transaction","detail":"{read_only:false; response_revision:5858; number_of_response:1; }","duration":"117.499097ms","start":"2026-10-07T05:52:19.214254Z","end":"2026-10-07T05:52:19.331753Z","steps":["trace[1847193546] 'process raft request' (duration: 117.328214ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:52:19.33533Z","caller":"traceutil/trace.go:171","msg":"trace[139952567] transaction","detail":"{read_only:false; response_revision:5860; number_of_response:1; }","duration":"118.934545ms","start":"2026-10-07T05:52:19.216384Z","end":"2026-10-07T05:52:19.335319Z","steps":["trace[139952567] 'process raft request' (duration: 118.895034ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:52:19.335493Z","caller":"traceutil/trace.go:171","msg":"trace[2039216186] transaction","detail":"{read_only:false; response_revision:5859; number_of_response:1; }","duration":"120.876422ms","start":"2026-10-07T05:52:19.214577Z","end":"2026-10-07T05:52:19.335453Z","steps":["trace[2039216186] 'process raft request' (duration: 120.630627ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:57:16.323225Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5835} {"level":"info","ts":"2026-10-07T05:57:16.417558Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5835,"took":"92.103336ms","hash":2825822011,"current-db-size-bytes":57438208,"current-db-size":"57 MB","current-db-size-in-use-bytes":26292224,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-07T05:57:16.417635Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2825822011,"revision":5835,"compact-revision":2938} {"level":"info","ts":"2026-10-07T05:58:37.083556Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000022fc.wal"} {"level":"warn","ts":"2026-10-07T05:58:40.892633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.452034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T05:58:40.892931Z","caller":"traceutil/trace.go:171","msg":"trace[55711202] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8666; }","duration":"265.811091ms","start":"2026-10-07T05:58:40.627097Z","end":"2026-10-07T05:58:40.892908Z","steps":["trace[55711202] 'range keys from in-memory index tree' (duration: 265.285971ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:58:40.893237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.432017ms","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-10-07T05:58:40.893374Z","caller":"traceutil/trace.go:171","msg":"trace[894278494] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8666; }","duration":"253.658461ms","start":"2026-10-07T05:58:40.639692Z","end":"2026-10-07T05:58:40.89335Z","steps":["trace[894278494] 'range keys from in-memory index tree' (duration: 253.175022ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:58:40.89337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.403263ms","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-10-07T05:58:40.893463Z","caller":"traceutil/trace.go:171","msg":"trace[908131222] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8666; }","duration":"227.566846ms","start":"2026-10-07T05:58:40.665874Z","end":"2026-10-07T05:58:40.893441Z","steps":["trace[908131222] 'range keys from in-memory index tree' (duration: 227.170448ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:58:40.952396Z","caller":"traceutil/trace.go:171","msg":"trace[941448600] transaction","detail":"{read_only:false; response_revision:8667; number_of_response:1; }","duration":"243.495957ms","start":"2026-10-07T05:58:40.708875Z","end":"2026-10-07T05:58:40.952371Z","steps":["trace[941448600] 'process raft request' (duration: 242.703132ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:58:52.832324Z","caller":"traceutil/trace.go:171","msg":"trace[1650505389] linearizableReadLoop","detail":"{readStateIndex:9042; appliedIndex:9041; }","duration":"290.088201ms","start":"2026-10-07T05:58:52.542212Z","end":"2026-10-07T05:58:52.8323Z","steps":["trace[1650505389] 'read index received' (duration: 289.709404ms)","trace[1650505389] 'applied index is now lower than readState.Index' (duration: 377.677µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:58:52.832445Z","caller":"traceutil/trace.go:171","msg":"trace[2034185503] transaction","detail":"{read_only:false; response_revision:8730; number_of_response:1; }","duration":"294.288652ms","start":"2026-10-07T05:58:52.538111Z","end":"2026-10-07T05:58:52.8324Z","steps":["trace[2034185503] 'process raft request' (duration: 293.898644ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:58:52.832601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.336666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-10-07T05:58:52.832604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.644208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T05:58:52.83265Z","caller":"traceutil/trace.go:171","msg":"trace[808010600] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8730; }","duration":"290.486439ms","start":"2026-10-07T05:58:52.542149Z","end":"2026-10-07T05:58:52.832636Z","steps":["trace[808010600] 'agreement among raft nodes before linearized reading' (duration: 290.296816ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:58:52.832704Z","caller":"traceutil/trace.go:171","msg":"trace[1468304189] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8730; }","duration":"207.782221ms","start":"2026-10-07T05:58:52.624896Z","end":"2026-10-07T05:58:52.832678Z","steps":["trace[1468304189] 'agreement among raft nodes before linearized reading' (duration: 207.615128ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:58:53.510877Z","caller":"traceutil/trace.go:171","msg":"trace[2103233682] transaction","detail":"{read_only:false; response_revision:8735; number_of_response:1; }","duration":"260.523911ms","start":"2026-10-07T05:58:53.250315Z","end":"2026-10-07T05:58:53.510839Z","steps":["trace[2103233682] 'process raft request' (duration: 260.315037ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:58:53.538504Z","caller":"traceutil/trace.go:171","msg":"trace[34631803] linearizableReadLoop","detail":"{readStateIndex:9048; appliedIndex:9046; }","duration":"141.913912ms","start":"2026-10-07T05:58:53.396554Z","end":"2026-10-07T05:58:53.538468Z","steps":["trace[34631803] 'read index received' (duration: 114.117075ms)","trace[34631803] 'applied index is now lower than readState.Index' (duration: 27.795247ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T05:58:53.538611Z","caller":"traceutil/trace.go:171","msg":"trace[398407842] transaction","detail":"{read_only:false; response_revision:8736; number_of_response:1; }","duration":"265.761881ms","start":"2026-10-07T05:58:53.272794Z","end":"2026-10-07T05:58:53.538556Z","steps":["trace[398407842] 'process raft request' (duration: 249.419881ms)","trace[398407842] 'compare' (duration: 16.103055ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T05:58:53.538664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.079746ms","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:5"} {"level":"info","ts":"2026-10-07T05:58:53.538861Z","caller":"traceutil/trace.go:171","msg":"trace[864550203] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:8736; }","duration":"142.360191ms","start":"2026-10-07T05:58:53.396482Z","end":"2026-10-07T05:58:53.538842Z","steps":["trace[864550203] 'agreement among raft nodes before linearized reading' (duration: 142.100746ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:59:22.68704Z","caller":"traceutil/trace.go:171","msg":"trace[60588623] transaction","detail":"{read_only:false; response_revision:8945; number_of_response:1; }","duration":"249.225357ms","start":"2026-10-07T05:59:22.437763Z","end":"2026-10-07T05:59:22.686988Z","steps":["trace[60588623] 'process raft request' (duration: 249.022453ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T05:59:22.874114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.853019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-f52sd\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-10-07T05:59:22.874222Z","caller":"traceutil/trace.go:171","msg":"trace[833002875] range","detail":"{range_begin:/registry/pods/openstack/keepalived-f52sd; range_end:; response_count:1; response_revision:8945; }","duration":"114.025672ms","start":"2026-10-07T05:59:22.76017Z","end":"2026-10-07T05:59:22.874196Z","steps":["trace[833002875] 'range keys from in-memory index tree' (duration: 113.604953ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:59:26.857499Z","caller":"traceutil/trace.go:171","msg":"trace[587301923] transaction","detail":"{read_only:false; response_revision:8965; number_of_response:1; }","duration":"147.257408ms","start":"2026-10-07T05:59:26.710211Z","end":"2026-10-07T05:59:26.857468Z","steps":["trace[587301923] 'process raft request' (duration: 147.078454ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:59:35.281193Z","caller":"traceutil/trace.go:171","msg":"trace[665906203] transaction","detail":"{read_only:false; response_revision:9010; number_of_response:1; }","duration":"205.304498ms","start":"2026-10-07T05:59:35.075863Z","end":"2026-10-07T05:59:35.281167Z","steps":["trace[665906203] 'process raft request' (duration: 205.076524ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:59:35.331184Z","caller":"traceutil/trace.go:171","msg":"trace[701673329] transaction","detail":"{read_only:false; response_revision:9011; number_of_response:1; }","duration":"122.83166ms","start":"2026-10-07T05:59:35.20831Z","end":"2026-10-07T05:59:35.331142Z","steps":["trace[701673329] 'process raft request' (duration: 122.623486ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:59:35.33123Z","caller":"traceutil/trace.go:171","msg":"trace[1433490219] transaction","detail":"{read_only:false; response_revision:9012; number_of_response:1; }","duration":"122.800059ms","start":"2026-10-07T05:59:35.208401Z","end":"2026-10-07T05:59:35.331201Z","steps":["trace[1433490219] 'process raft request' (duration: 122.677716ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T05:59:36.097154Z","caller":"traceutil/trace.go:171","msg":"trace[1302391197] transaction","detail":"{read_only:false; response_revision:9018; number_of_response:1; }","duration":"199.629352ms","start":"2026-10-07T05:59:35.897435Z","end":"2026-10-07T05:59:36.097064Z","steps":["trace[1302391197] 'process raft request' (duration: 199.442079ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:00:38.855517Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6d0019d52d78795","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-07T06:00:38.865547Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-07T06:00:38.865681Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-07T06:02:16.330707Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7995} {"level":"info","ts":"2026-10-07T06:02:16.413244Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7995,"took":"79.760476ms","hash":1917682766,"current-db-size-bytes":57438208,"current-db-size":"57 MB","current-db-size-in-use-bytes":27779072,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-07T06:02:16.413324Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1917682766,"revision":7995,"compact-revision":5835} {"level":"warn","ts":"2026-10-07T06:06:28.420529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.548109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T06:06:28.420654Z","caller":"traceutil/trace.go:171","msg":"trace[1425876604] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12216; }","duration":"159.707811ms","start":"2026-10-07T06:06:28.260925Z","end":"2026-10-07T06:06:28.420633Z","steps":["trace[1425876604] 'range keys from in-memory index tree' (duration: 159.448936ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:06:28.420673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.323553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-07T06:06:28.420457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.112779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T06:06:28.420813Z","caller":"traceutil/trace.go:171","msg":"trace[1498544001] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12216; }","duration":"160.531207ms","start":"2026-10-07T06:06:28.260249Z","end":"2026-10-07T06:06:28.42078Z","steps":["trace[1498544001] 'range keys from in-memory index tree' (duration: 160.149489ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:06:28.420709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.239546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"} {"level":"info","ts":"2026-10-07T06:06:28.420888Z","caller":"traceutil/trace.go:171","msg":"trace[1042456846] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12216; }","duration":"160.510547ms","start":"2026-10-07T06:06:28.260309Z","end":"2026-10-07T06:06:28.42082Z","steps":["trace[1042456846] 'range keys from in-memory index tree' (duration: 159.966977ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:06:28.420862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.64892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-10-07T06:06:28.421009Z","caller":"traceutil/trace.go:171","msg":"trace[1441397334] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12216; }","duration":"156.537831ms","start":"2026-10-07T06:06:28.264413Z","end":"2026-10-07T06:06:28.420951Z","steps":["trace[1441397334] 'range keys from in-memory index tree' (duration: 155.980201ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:06:28.421019Z","caller":"traceutil/trace.go:171","msg":"trace[491215027] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:12216; }","duration":"160.822103ms","start":"2026-10-07T06:06:28.260163Z","end":"2026-10-07T06:06:28.420985Z","steps":["trace[491215027] 'range keys from in-memory index tree' (duration: 160.338963ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:06:28.421173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.167819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-07T06:06:28.421239Z","caller":"traceutil/trace.go:171","msg":"trace[1505202981] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12216; }","duration":"161.299352ms","start":"2026-10-07T06:06:28.259923Z","end":"2026-10-07T06:06:28.421223Z","steps":["trace[1505202981] 'range keys from in-memory index tree' (duration: 161.090148ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:06:28.421595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.445036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-f52sd\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-10-07T06:06:28.42162Z","caller":"traceutil/trace.go:171","msg":"trace[426278385] transaction","detail":"{read_only:false; response_revision:12217; number_of_response:1; }","duration":"121.051615ms","start":"2026-10-07T06:06:28.30052Z","end":"2026-10-07T06:06:28.421572Z","steps":["trace[426278385] 'process raft request' (duration: 68.831893ms)","trace[426278385] 'compare' (duration: 51.201793ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:06:28.421677Z","caller":"traceutil/trace.go:171","msg":"trace[1091517473] range","detail":"{range_begin:/registry/pods/openstack/keepalived-f52sd; range_end:; response_count:1; response_revision:12216; }","duration":"151.548058ms","start":"2026-10-07T06:06:28.270108Z","end":"2026-10-07T06:06:28.421656Z","steps":["trace[1091517473] 'range keys from in-memory index tree' (duration: 151.282473ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:07:16.339631Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10360} {"level":"info","ts":"2026-10-07T06:07:16.433412Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10360,"took":"90.914399ms","hash":618235110,"current-db-size-bytes":57438208,"current-db-size":"57 MB","current-db-size-in-use-bytes":25903104,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-07T06:07:16.433515Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":618235110,"revision":10360,"compact-revision":7995} {"level":"info","ts":"2026-10-07T06:12:16.348662Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12529} {"level":"info","ts":"2026-10-07T06:12:16.435222Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12529,"took":"82.933025ms","hash":2856748389,"current-db-size-bytes":57438208,"current-db-size":"57 MB","current-db-size-in-use-bytes":27549696,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-07T06:12:16.435308Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2856748389,"revision":12529,"compact-revision":10360} {"level":"info","ts":"2026-10-07T06:13:25.08876Z","caller":"traceutil/trace.go:171","msg":"trace[832310835] transaction","detail":"{read_only:false; response_revision:14965; number_of_response:1; }","duration":"102.219879ms","start":"2026-10-07T06:13:24.986499Z","end":"2026-10-07T06:13:25.088719Z","steps":["trace[832310835] 'process raft request' (duration: 102.016125ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:13:43.664501Z","caller":"traceutil/trace.go:171","msg":"trace[1799725428] transaction","detail":"{read_only:false; response_revision:15075; number_of_response:1; }","duration":"255.695268ms","start":"2026-10-07T06:13:43.408761Z","end":"2026-10-07T06:13:43.664456Z","steps":["trace[1799725428] 'process raft request' (duration: 255.411942ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:13:45.131431Z","caller":"traceutil/trace.go:171","msg":"trace[707729821] transaction","detail":"{read_only:false; response_revision:15089; number_of_response:1; }","duration":"118.065399ms","start":"2026-10-07T06:13:45.013338Z","end":"2026-10-07T06:13:45.131403Z","steps":["trace[707729821] 'process raft request' (duration: 116.961068ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:15:36.887255Z","caller":"traceutil/trace.go:171","msg":"trace[216109512] linearizableReadLoop","detail":"{readStateIndex:16787; appliedIndex:16786; }","duration":"101.14437ms","start":"2026-10-07T06:15:36.786086Z","end":"2026-10-07T06:15:36.887231Z","steps":["trace[216109512] 'read index received' (duration: 100.944066ms)","trace[216109512] 'applied index is now lower than readState.Index' (duration: 198.954µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:15:36.887321Z","caller":"traceutil/trace.go:171","msg":"trace[917828625] transaction","detail":"{read_only:false; response_revision:16220; number_of_response:1; }","duration":"101.513907ms","start":"2026-10-07T06:15:36.785767Z","end":"2026-10-07T06:15:36.887281Z","steps":["trace[917828625] 'process raft request' (duration: 101.283433ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:15:36.887626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.470215ms","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-10-07T06:15:36.888247Z","caller":"traceutil/trace.go:171","msg":"trace[1645467761] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16220; }","duration":"102.162029ms","start":"2026-10-07T06:15:36.786062Z","end":"2026-10-07T06:15:36.888224Z","steps":["trace[1645467761] 'agreement among raft nodes before linearized reading' (duration: 101.299503ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:15:37.136572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.139089ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-07T06:15:37.136802Z","caller":"traceutil/trace.go:171","msg":"trace[866118890] transaction","detail":"{read_only:false; response_revision:16222; number_of_response:1; }","duration":"243.585621ms","start":"2026-10-07T06:15:36.893199Z","end":"2026-10-07T06:15:37.136784Z","steps":["trace[866118890] 'process raft request' (duration: 243.478979ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:15:37.136803Z","caller":"traceutil/trace.go:171","msg":"trace[1254289635] transaction","detail":"{read_only:false; response_revision:16221; number_of_response:1; }","duration":"243.734774ms","start":"2026-10-07T06:15:36.893021Z","end":"2026-10-07T06:15:37.136756Z","steps":["trace[1254289635] 'process raft request' (duration: 97.311119ms)","trace[1254289635] 'compare' (duration: 145.990997ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:15:37.4041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.781193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-5zt9w\" ","response":"range_response_count:1 size:9788"} {"level":"info","ts":"2026-10-07T06:15:37.404383Z","caller":"traceutil/trace.go:171","msg":"trace[1537602960] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-5zt9w; range_end:; response_count:1; response_revision:16222; }","duration":"137.953126ms","start":"2026-10-07T06:15:37.266222Z","end":"2026-10-07T06:15:37.404175Z","steps":["trace[1537602960] 'range keys from in-memory index tree' (duration: 137.490437ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:15:37.603113Z","caller":"traceutil/trace.go:171","msg":"trace[664693744] linearizableReadLoop","detail":"{readStateIndex:16790; appliedIndex:16789; }","duration":"116.514492ms","start":"2026-10-07T06:15:37.486575Z","end":"2026-10-07T06:15:37.60309Z","steps":["trace[664693744] 'read index received' (duration: 116.293177ms)","trace[664693744] 'applied index is now lower than readState.Index' (duration: 220.265µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:15:37.60314Z","caller":"traceutil/trace.go:171","msg":"trace[689406330] transaction","detail":"{read_only:false; response_revision:16223; number_of_response:1; }","duration":"144.415058ms","start":"2026-10-07T06:15:37.4587Z","end":"2026-10-07T06:15:37.603115Z","steps":["trace[689406330] 'process raft request' (duration: 144.215844ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:15:37.603391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.776106ms","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:7"} {"level":"info","ts":"2026-10-07T06:15:37.603509Z","caller":"traceutil/trace.go:171","msg":"trace[1854285857] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:16223; }","duration":"116.94906ms","start":"2026-10-07T06:15:37.486531Z","end":"2026-10-07T06:15:37.60348Z","steps":["trace[1854285857] 'agreement among raft nodes before linearized reading' (duration: 116.678335ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:17:16.360561Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14531} {"level":"info","ts":"2026-10-07T06:17:16.449216Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14531,"took":"85.124908ms","hash":750273481,"current-db-size-bytes":57438208,"current-db-size":"57 MB","current-db-size-in-use-bytes":31379456,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-07T06:17:16.449315Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":750273481,"revision":14531,"compact-revision":12529} {"level":"info","ts":"2026-10-07T06:22:15.491403Z","caller":"traceutil/trace.go:171","msg":"trace[1171073932] linearizableReadLoop","detail":"{readStateIndex:19725; appliedIndex:19724; }","duration":"117.579293ms","start":"2026-10-07T06:22:15.373783Z","end":"2026-10-07T06:22:15.491362Z","steps":["trace[1171073932] 'read index received' (duration: 117.312168ms)","trace[1171073932] 'applied index is now lower than readState.Index' (duration: 265.175µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:22:15.49145Z","caller":"traceutil/trace.go:171","msg":"trace[524518864] transaction","detail":"{read_only:false; response_revision:19062; number_of_response:1; }","duration":"125.427961ms","start":"2026-10-07T06:22:15.36597Z","end":"2026-10-07T06:22:15.491398Z","steps":["trace[524518864] 'process raft request' (duration: 125.144445ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:22:15.491643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.824497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:22:15.491747Z","caller":"traceutil/trace.go:171","msg":"trace[1258473453] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:19062; }","duration":"117.998701ms","start":"2026-10-07T06:22:15.373725Z","end":"2026-10-07T06:22:15.491724Z","steps":["trace[1258473453] 'agreement among raft nodes before linearized reading' (duration: 117.769487ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:22:15.503408Z","caller":"traceutil/trace.go:171","msg":"trace[1674078259] transaction","detail":"{read_only:false; response_revision:19063; number_of_response:1; }","duration":"105.796549ms","start":"2026-10-07T06:22:15.397583Z","end":"2026-10-07T06:22:15.50338Z","steps":["trace[1674078259] 'process raft request' (duration: 105.557945ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:22:15.503477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.813891ms","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-10-07T06:22:15.503577Z","caller":"traceutil/trace.go:171","msg":"trace[1010612853] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:19063; }","duration":"114.992584ms","start":"2026-10-07T06:22:15.388563Z","end":"2026-10-07T06:22:15.503556Z","steps":["trace[1010612853] 'agreement among raft nodes before linearized reading' (duration: 114.740199ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:22:15.833272Z","caller":"traceutil/trace.go:171","msg":"trace[1345087846] linearizableReadLoop","detail":"{readStateIndex:19728; appliedIndex:19726; }","duration":"207.714977ms","start":"2026-10-07T06:22:15.625529Z","end":"2026-10-07T06:22:15.833244Z","steps":["trace[1345087846] 'read index received' (duration: 156.750513ms)","trace[1345087846] 'applied index is now lower than readState.Index' (duration: 50.963064ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:22:15.833313Z","caller":"traceutil/trace.go:171","msg":"trace[1846973491] transaction","detail":"{read_only:false; response_revision:19064; number_of_response:1; }","duration":"324.003545ms","start":"2026-10-07T06:22:15.509272Z","end":"2026-10-07T06:22:15.833275Z","steps":["trace[1846973491] 'process raft request' (duration: 272.95669ms)","trace[1846973491] 'compare' (duration: 50.75352ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:22:15.833383Z","caller":"traceutil/trace.go:171","msg":"trace[2075751843] transaction","detail":"{read_only:false; response_revision:19065; number_of_response:1; }","duration":"323.600697ms","start":"2026-10-07T06:22:15.509775Z","end":"2026-10-07T06:22:15.833376Z","steps":["trace[2075751843] 'process raft request' (duration: 323.408994ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:22:15.833589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.039684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:22:15.833687Z","caller":"traceutil/trace.go:171","msg":"trace[357065061] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19065; }","duration":"208.216237ms","start":"2026-10-07T06:22:15.625445Z","end":"2026-10-07T06:22:15.833661Z","steps":["trace[357065061] 'agreement among raft nodes before linearized reading' (duration: 208.052334ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:22:15.83369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:22:15.509253Z","time spent":"324.27898ms","remote":"127.0.0.1:52934","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-10-07T06:22:15.833745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:22:15.509764Z","time spent":"323.876442ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T06:22:16.003117Z","caller":"traceutil/trace.go:171","msg":"trace[1527799838] transaction","detail":"{read_only:false; response_revision:19066; number_of_response:1; }","duration":"119.308767ms","start":"2026-10-07T06:22:15.883781Z","end":"2026-10-07T06:22:16.00309Z","steps":["trace[1527799838] 'process raft request' (duration: 54.162815ms)","trace[1527799838] 'compare' (duration: 64.978938ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:22:16.36866Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16860} {"level":"info","ts":"2026-10-07T06:22:16.473938Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16860,"took":"101.072671ms","hash":3937624966,"current-db-size-bytes":57438208,"current-db-size":"57 MB","current-db-size-in-use-bytes":31592448,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-07T06:22:16.474107Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3937624966,"revision":16860,"compact-revision":14531} {"level":"info","ts":"2026-10-07T06:22:35.630846Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6d0019d52d78795","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-07T06:22:35.639935Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-07T06:22:35.640374Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-07T06:27:16.377019Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19070} {"level":"info","ts":"2026-10-07T06:27:16.489948Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19070,"took":"108.663634ms","hash":2388024893,"current-db-size-bytes":57438208,"current-db-size":"57 MB","current-db-size-in-use-bytes":34021376,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-07T06:27:16.490028Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2388024893,"revision":19070,"compact-revision":16860} {"level":"warn","ts":"2026-10-07T06:28:33.458014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.034238ms","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-10-07T06:28:33.45814Z","caller":"traceutil/trace.go:171","msg":"trace[1098012554] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21937; }","duration":"121.225822ms","start":"2026-10-07T06:28:33.336892Z","end":"2026-10-07T06:28:33.458117Z","steps":["trace[1098012554] 'range keys from in-memory index tree' (duration: 120.838714ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:28:39.317545Z","caller":"traceutil/trace.go:171","msg":"trace[1020430465] transaction","detail":"{read_only:false; response_revision:21965; number_of_response:1; }","duration":"134.547824ms","start":"2026-10-07T06:28:39.182969Z","end":"2026-10-07T06:28:39.317517Z","steps":["trace[1020430465] 'process raft request' (duration: 134.35884ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:28:39.450643Z","caller":"traceutil/trace.go:171","msg":"trace[122232151] transaction","detail":"{read_only:false; response_revision:21966; number_of_response:1; }","duration":"210.310207ms","start":"2026-10-07T06:28:39.240296Z","end":"2026-10-07T06:28:39.450606Z","steps":["trace[122232151] 'process raft request' (duration: 122.421976ms)","trace[122232151] 'compare' (duration: 87.574525ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:28:39.450995Z","caller":"traceutil/trace.go:171","msg":"trace[2021795233] transaction","detail":"{read_only:false; response_revision:21967; number_of_response:1; }","duration":"193.144071ms","start":"2026-10-07T06:28:39.257807Z","end":"2026-10-07T06:28:39.450951Z","steps":["trace[2021795233] 'process raft request' (duration: 192.742444ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:28:39.451245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.57804ms","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-10-07T06:28:39.451306Z","caller":"traceutil/trace.go:171","msg":"trace[2059979739] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21967; }","duration":"165.699903ms","start":"2026-10-07T06:28:39.285593Z","end":"2026-10-07T06:28:39.451292Z","steps":["trace[2059979739] 'agreement among raft nodes before linearized reading' (duration: 165.429708ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:28:39.450892Z","caller":"traceutil/trace.go:171","msg":"trace[434407503] linearizableReadLoop","detail":"{readStateIndex:22726; appliedIndex:22723; }","duration":"165.210743ms","start":"2026-10-07T06:28:39.285641Z","end":"2026-10-07T06:28:39.450851Z","steps":["trace[434407503] 'read index received' (duration: 31.75517ms)","trace[434407503] 'applied index is now lower than readState.Index' (duration: 133.452823ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:28:39.742303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.103436ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T06:28:39.742564Z","caller":"traceutil/trace.go:171","msg":"trace[23634379] linearizableReadLoop","detail":"{readStateIndex:22727; appliedIndex:22726; }","duration":"251.399123ms","start":"2026-10-07T06:28:39.491087Z","end":"2026-10-07T06:28:39.742486Z","steps":["trace[23634379] 'read index received' (duration: 98.985541ms)","trace[23634379] 'applied index is now lower than readState.Index' (duration: 152.411932ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:28:39.74254Z","caller":"traceutil/trace.go:171","msg":"trace[464773893] transaction","detail":"{read_only:false; response_revision:21968; number_of_response:1; }","duration":"285.657411ms","start":"2026-10-07T06:28:39.456823Z","end":"2026-10-07T06:28:39.74248Z","steps":["trace[464773893] 'process raft request' (duration: 133.246379ms)","trace[464773893] 'compare' (duration: 151.684118ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:28:39.742754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.641778ms","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-10-07T06:28:39.74284Z","caller":"traceutil/trace.go:171","msg":"trace[873204839] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21968; }","duration":"251.76285ms","start":"2026-10-07T06:28:39.491058Z","end":"2026-10-07T06:28:39.742821Z","steps":["trace[873204839] 'agreement among raft nodes before linearized reading' (duration: 251.521305ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:28:40.075631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.675027ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-10-07T06:32:16.384272Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21494} {"level":"info","ts":"2026-10-07T06:32:16.50706Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21494,"took":"117.992071ms","hash":3807413610,"current-db-size-bytes":57438208,"current-db-size":"57 MB","current-db-size-in-use-bytes":30941184,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-07T06:32:16.507144Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3807413610,"revision":21494,"compact-revision":19070} {"level":"info","ts":"2026-10-07T06:33:00.865056Z","caller":"traceutil/trace.go:171","msg":"trace[2038391888] transaction","detail":"{read_only:false; response_revision:24557; number_of_response:1; }","duration":"228.927369ms","start":"2026-10-07T06:33:00.63609Z","end":"2026-10-07T06:33:00.865017Z","steps":["trace[2038391888] 'process raft request' (duration: 228.748366ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:33:00.867155Z","caller":"traceutil/trace.go:171","msg":"trace[493496479] transaction","detail":"{read_only:false; response_revision:24558; number_of_response:1; }","duration":"230.818344ms","start":"2026-10-07T06:33:00.63632Z","end":"2026-10-07T06:33:00.867138Z","steps":["trace[493496479] 'process raft request' (duration: 230.710772ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:34:40.762765Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006764.wal"} {"level":"info","ts":"2026-10-07T06:36:41.397679Z","caller":"traceutil/trace.go:171","msg":"trace[874741439] linearizableReadLoop","detail":"{readStateIndex:27647; appliedIndex:27646; }","duration":"110.387476ms","start":"2026-10-07T06:36:41.287261Z","end":"2026-10-07T06:36:41.397648Z","steps":["trace[874741439] 'read index received' (duration: 110.213703ms)","trace[874741439] 'applied index is now lower than readState.Index' (duration: 172.103µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:36:41.397824Z","caller":"traceutil/trace.go:171","msg":"trace[1086364890] transaction","detail":"{read_only:false; response_revision:26750; number_of_response:1; }","duration":"120.698301ms","start":"2026-10-07T06:36:41.277054Z","end":"2026-10-07T06:36:41.397753Z","steps":["trace[1086364890] 'process raft request' (duration: 120.378255ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:36:41.397933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.655052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-10-07T06:36:41.397974Z","caller":"traceutil/trace.go:171","msg":"trace[1967295869] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26750; }","duration":"110.759813ms","start":"2026-10-07T06:36:41.2872Z","end":"2026-10-07T06:36:41.39796Z","steps":["trace[1967295869] 'agreement among raft nodes before linearized reading' (duration: 110.572519ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:46.045176Z","caller":"traceutil/trace.go:171","msg":"trace[858568444] transaction","detail":"{read_only:false; response_revision:26788; number_of_response:1; }","duration":"193.67234ms","start":"2026-10-07T06:36:45.851463Z","end":"2026-10-07T06:36:46.045135Z","steps":["trace[858568444] 'process raft request' (duration: 193.383484ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:46.04603Z","caller":"traceutil/trace.go:171","msg":"trace[699799853] transaction","detail":"{read_only:false; response_revision:26789; number_of_response:1; }","duration":"181.599341ms","start":"2026-10-07T06:36:45.864406Z","end":"2026-10-07T06:36:46.046006Z","steps":["trace[699799853] 'process raft request' (duration: 181.413249ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:46.046244Z","caller":"traceutil/trace.go:171","msg":"trace[396031990] transaction","detail":"{read_only:false; response_revision:26790; number_of_response:1; }","duration":"154.063581ms","start":"2026-10-07T06:36:45.892151Z","end":"2026-10-07T06:36:46.046214Z","steps":["trace[396031990] 'process raft request' (duration: 153.804866ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:36:47.00353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.544273ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T06:36:47.003755Z","caller":"traceutil/trace.go:171","msg":"trace[2048471110] transaction","detail":"{read_only:false; response_revision:26797; number_of_response:1; }","duration":"222.350131ms","start":"2026-10-07T06:36:46.781383Z","end":"2026-10-07T06:36:47.003733Z","steps":["trace[2048471110] 'process raft request' (duration: 222.28067ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:47.003951Z","caller":"traceutil/trace.go:171","msg":"trace[520640891] linearizableReadLoop","detail":"{readStateIndex:27694; appliedIndex:27693; }","duration":"265.66664ms","start":"2026-10-07T06:36:46.738235Z","end":"2026-10-07T06:36:47.003902Z","steps":["trace[520640891] 'read index received' (duration: 23.547986ms)","trace[520640891] 'applied index is now lower than readState.Index' (duration: 242.114634ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:36:47.004112Z","caller":"traceutil/trace.go:171","msg":"trace[1759853488] transaction","detail":"{read_only:false; response_revision:26796; number_of_response:1; }","duration":"267.233059ms","start":"2026-10-07T06:36:46.736855Z","end":"2026-10-07T06:36:47.004088Z","steps":["trace[1759853488] 'process raft request' (duration: 25.028703ms)","trace[1759853488] 'compare' (duration: 241.398151ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:36:47.004382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.100769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:36:47.004502Z","caller":"traceutil/trace.go:171","msg":"trace[341207987] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26797; }","duration":"266.287512ms","start":"2026-10-07T06:36:46.738185Z","end":"2026-10-07T06:36:47.004473Z","steps":["trace[341207987] 'agreement among raft nodes before linearized reading' (duration: 266.006127ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:36:47.008735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.645374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:36:47.008738Z","caller":"traceutil/trace.go:171","msg":"trace[64811154] transaction","detail":"{read_only:false; response_revision:26798; number_of_response:1; }","duration":"205.416552ms","start":"2026-10-07T06:36:46.803279Z","end":"2026-10-07T06:36:47.008695Z","steps":["trace[64811154] 'process raft request' (duration: 205.231108ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:47.008815Z","caller":"traceutil/trace.go:171","msg":"trace[2945861] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedeployments/; range_end:/registry/cluster.x-k8s.io/machinedeployments0; response_count:0; response_revision:26798; }","duration":"207.811977ms","start":"2026-10-07T06:36:46.800985Z","end":"2026-10-07T06:36:47.008797Z","steps":["trace[2945861] 'agreement among raft nodes before linearized reading' (duration: 207.681584ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:47.168445Z","caller":"traceutil/trace.go:171","msg":"trace[1537941357] linearizableReadLoop","detail":"{readStateIndex:27697; appliedIndex:27696; }","duration":"143.125635ms","start":"2026-10-07T06:36:47.025287Z","end":"2026-10-07T06:36:47.168413Z","steps":["trace[1537941357] 'read index received' (duration: 142.827199ms)","trace[1537941357] 'applied index is now lower than readState.Index' (duration: 296.096µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:36:47.168596Z","caller":"traceutil/trace.go:171","msg":"trace[1970512653] transaction","detail":"{read_only:false; response_revision:26799; number_of_response:1; }","duration":"152.48457ms","start":"2026-10-07T06:36:47.016064Z","end":"2026-10-07T06:36:47.168549Z","steps":["trace[1970512653] 'process raft request' (duration: 152.126414ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:36:47.168755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.43691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-10-07T06:36:47.169066Z","caller":"traceutil/trace.go:171","msg":"trace[62595787] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:26799; }","duration":"143.740655ms","start":"2026-10-07T06:36:47.025279Z","end":"2026-10-07T06:36:47.16902Z","steps":["trace[62595787] 'agreement among raft nodes before linearized reading' (duration: 143.302467ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:47.476946Z","caller":"traceutil/trace.go:171","msg":"trace[1169540384] transaction","detail":"{read_only:false; response_revision:26801; number_of_response:1; }","duration":"116.186445ms","start":"2026-10-07T06:36:47.360728Z","end":"2026-10-07T06:36:47.476914Z","steps":["trace[1169540384] 'process raft request' (duration: 115.96286ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:36:51.69498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.028526ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T06:36:51.695105Z","caller":"traceutil/trace.go:171","msg":"trace[1757664340] transaction","detail":"{read_only:false; response_revision:26832; number_of_response:1; }","duration":"170.728766ms","start":"2026-10-07T06:36:51.524354Z","end":"2026-10-07T06:36:51.695083Z","steps":["trace[1757664340] 'process raft request' (duration: 21.448465ms)","trace[1757664340] 'compare' (duration: 148.883784ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:36:51.909274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.964338ms","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-10-07T06:36:51.909402Z","caller":"traceutil/trace.go:171","msg":"trace[2060288195] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26832; }","duration":"110.171992ms","start":"2026-10-07T06:36:51.799201Z","end":"2026-10-07T06:36:51.909373Z","steps":["trace[2060288195] 'count revisions from in-memory index tree' (duration: 109.821216ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:36:52.246782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.899829ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T06:36:52.247126Z","caller":"traceutil/trace.go:171","msg":"trace[324506809] transaction","detail":"{read_only:false; response_revision:26836; number_of_response:1; }","duration":"173.700203ms","start":"2026-10-07T06:36:52.073399Z","end":"2026-10-07T06:36:52.247099Z","steps":["trace[324506809] 'process raft request' (duration: 173.56775ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:52.247091Z","caller":"traceutil/trace.go:171","msg":"trace[1066833546] transaction","detail":"{read_only:false; response_revision:26834; number_of_response:1; }","duration":"174.341194ms","start":"2026-10-07T06:36:52.072685Z","end":"2026-10-07T06:36:52.247027Z","steps":["trace[1066833546] 'process raft request' (duration: 39.077489ms)","trace[1066833546] 'compare' (duration: 134.723716ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:36:52.247143Z","caller":"traceutil/trace.go:171","msg":"trace[345286002] transaction","detail":"{read_only:false; response_revision:26837; number_of_response:1; }","duration":"172.851186ms","start":"2026-10-07T06:36:52.07425Z","end":"2026-10-07T06:36:52.247101Z","steps":["trace[345286002] 'process raft request' (duration: 172.797925ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:52.247144Z","caller":"traceutil/trace.go:171","msg":"trace[1779981502] transaction","detail":"{read_only:false; response_revision:26835; number_of_response:1; }","duration":"173.917976ms","start":"2026-10-07T06:36:52.073152Z","end":"2026-10-07T06:36:52.24707Z","steps":["trace[1779981502] 'process raft request' (duration: 173.751123ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:53.164034Z","caller":"traceutil/trace.go:171","msg":"trace[556875310] transaction","detail":"{read_only:false; response_revision:26841; number_of_response:1; }","duration":"169.836849ms","start":"2026-10-07T06:36:52.994162Z","end":"2026-10-07T06:36:53.163999Z","steps":["trace[556875310] 'process raft request' (duration: 169.615525ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:53.179688Z","caller":"traceutil/trace.go:171","msg":"trace[146273834] linearizableReadLoop","detail":"{readStateIndex:27741; appliedIndex:27739; }","duration":"147.609449ms","start":"2026-10-07T06:36:53.032044Z","end":"2026-10-07T06:36:53.179654Z","steps":["trace[146273834] 'read index received' (duration: 131.714039ms)","trace[146273834] 'applied index is now lower than readState.Index' (duration: 15.89039ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:36:53.179829Z","caller":"traceutil/trace.go:171","msg":"trace[1320963203] transaction","detail":"{read_only:false; response_revision:26842; number_of_response:1; }","duration":"147.803193ms","start":"2026-10-07T06:36:53.03199Z","end":"2026-10-07T06:36:53.179793Z","steps":["trace[1320963203] 'process raft request' (duration: 147.464747ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:36:53.179943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.863234ms","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-10-07T06:36:53.179991Z","caller":"traceutil/trace.go:171","msg":"trace[845514315] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26842; }","duration":"147.981736ms","start":"2026-10-07T06:36:53.031996Z","end":"2026-10-07T06:36:53.179977Z","steps":["trace[845514315] 'agreement among raft nodes before linearized reading' (duration: 147.783082ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:53.347025Z","caller":"traceutil/trace.go:171","msg":"trace[247992003] linearizableReadLoop","detail":"{readStateIndex:27742; appliedIndex:27741; }","duration":"138.700791ms","start":"2026-10-07T06:36:53.208293Z","end":"2026-10-07T06:36:53.346994Z","steps":["trace[247992003] 'read index received' (duration: 123.997153ms)","trace[247992003] 'applied index is now lower than readState.Index' (duration: 14.702378ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:36:53.347349Z","caller":"traceutil/trace.go:171","msg":"trace[349147086] transaction","detail":"{read_only:false; response_revision:26843; number_of_response:1; }","duration":"155.990537ms","start":"2026-10-07T06:36:53.191342Z","end":"2026-10-07T06:36:53.347332Z","steps":["trace[349147086] 'process raft request' (duration: 141.026365ms)","trace[349147086] 'compare' (duration: 14.490384ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:36:53.34768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.376703ms","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-10-07T06:36:53.347725Z","caller":"traceutil/trace.go:171","msg":"trace[207344894] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26843; }","duration":"139.490115ms","start":"2026-10-07T06:36:53.208222Z","end":"2026-10-07T06:36:53.347712Z","steps":["trace[207344894] 'agreement among raft nodes before linearized reading' (duration: 139.303592ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:36:53.347887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.693617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-07T06:36:53.348019Z","caller":"traceutil/trace.go:171","msg":"trace[1127844862] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26843; }","duration":"132.911132ms","start":"2026-10-07T06:36:53.215075Z","end":"2026-10-07T06:36:53.347986Z","steps":["trace[1127844862] 'agreement among raft nodes before linearized reading' (duration: 132.519604ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:53.625244Z","caller":"traceutil/trace.go:171","msg":"trace[2059074609] transaction","detail":"{read_only:false; response_revision:26846; number_of_response:1; }","duration":"223.982843ms","start":"2026-10-07T06:36:53.401226Z","end":"2026-10-07T06:36:53.625209Z","steps":["trace[2059074609] 'process raft request' (duration: 223.83563ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:53.625407Z","caller":"traceutil/trace.go:171","msg":"trace[760736122] transaction","detail":"{read_only:false; response_revision:26845; number_of_response:1; }","duration":"262.948688ms","start":"2026-10-07T06:36:53.36243Z","end":"2026-10-07T06:36:53.625379Z","steps":["trace[760736122] 'process raft request' (duration: 237.006568ms)","trace[760736122] 'compare' (duration: 25.41446ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:36:53.627322Z","caller":"traceutil/trace.go:171","msg":"trace[666543467] transaction","detail":"{read_only:false; response_revision:26847; number_of_response:1; }","duration":"103.462975ms","start":"2026-10-07T06:36:53.523807Z","end":"2026-10-07T06:36:53.62727Z","steps":["trace[666543467] 'process raft request' (duration: 103.248201ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:53.938211Z","caller":"traceutil/trace.go:171","msg":"trace[1043446698] transaction","detail":"{read_only:false; response_revision:26848; number_of_response:1; }","duration":"232.533594ms","start":"2026-10-07T06:36:53.705644Z","end":"2026-10-07T06:36:53.938178Z","steps":["trace[1043446698] 'process raft request' (duration: 231.840111ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:54.584493Z","caller":"traceutil/trace.go:171","msg":"trace[787167200] transaction","detail":"{read_only:false; response_revision:26852; number_of_response:1; }","duration":"314.568174ms","start":"2026-10-07T06:36:54.26989Z","end":"2026-10-07T06:36:54.584458Z","steps":["trace[787167200] 'process raft request' (duration: 314.490684ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:36:54.584776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:36:54.26986Z","time spent":"314.816338ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T06:36:54.584769Z","caller":"traceutil/trace.go:171","msg":"trace[899110755] transaction","detail":"{read_only:false; response_revision:26851; number_of_response:1; }","duration":"314.88039ms","start":"2026-10-07T06:36:54.269836Z","end":"2026-10-07T06:36:54.584716Z","steps":["trace[899110755] 'process raft request' (duration: 314.32264ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:36:54.585163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:36:54.269804Z","time spent":"315.210836ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T06:36:54.6009Z","caller":"traceutil/trace.go:171","msg":"trace[1889716952] transaction","detail":"{read_only:false; response_revision:26853; number_of_response:1; }","duration":"207.9608ms","start":"2026-10-07T06:36:54.392904Z","end":"2026-10-07T06:36:54.600865Z","steps":["trace[1889716952] 'process raft request' (duration: 207.780547ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:54.728634Z","caller":"traceutil/trace.go:171","msg":"trace[1350178853] transaction","detail":"{read_only:false; response_revision:26854; number_of_response:1; }","duration":"101.102ms","start":"2026-10-07T06:36:54.627489Z","end":"2026-10-07T06:36:54.728591Z","steps":["trace[1350178853] 'process raft request' (duration: 80.169874ms)","trace[1350178853] 'compare' (duration: 20.62917ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:36:54.995813Z","caller":"traceutil/trace.go:171","msg":"trace[774263621] transaction","detail":"{read_only:false; response_revision:26855; number_of_response:1; }","duration":"103.17224ms","start":"2026-10-07T06:36:54.892604Z","end":"2026-10-07T06:36:54.995776Z","steps":["trace[774263621] 'process raft request' (duration: 102.982367ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:36:55.152547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.741195ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-07T06:36:55.568117Z","caller":"traceutil/trace.go:171","msg":"trace[930723280] linearizableReadLoop","detail":"{readStateIndex:27757; appliedIndex:27756; }","duration":"158.28895ms","start":"2026-10-07T06:36:55.409798Z","end":"2026-10-07T06:36:55.568087Z","steps":["trace[930723280] 'read index received' (duration: 157.936334ms)","trace[930723280] 'applied index is now lower than readState.Index' (duration: 350.916µs)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:36:55.56819Z","caller":"traceutil/trace.go:171","msg":"trace[339251112] transaction","detail":"{read_only:false; response_revision:26857; number_of_response:1; }","duration":"211.246301ms","start":"2026-10-07T06:36:55.356913Z","end":"2026-10-07T06:36:55.56816Z","steps":["trace[339251112] 'process raft request' (duration: 210.967105ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:36:55.568435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.608666ms","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-10-07T06:36:55.568473Z","caller":"traceutil/trace.go:171","msg":"trace[1742031979] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26857; }","duration":"158.688779ms","start":"2026-10-07T06:36:55.409771Z","end":"2026-10-07T06:36:55.56846Z","steps":["trace[1742031979] 'agreement among raft nodes before linearized reading' (duration: 158.479325ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:36:55.758587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.623103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-07T06:36:55.758695Z","caller":"traceutil/trace.go:171","msg":"trace[1213613935] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26858; }","duration":"125.799217ms","start":"2026-10-07T06:36:55.632868Z","end":"2026-10-07T06:36:55.758667Z","steps":["trace[1213613935] 'range keys from in-memory index tree' (duration: 125.242627ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:36:55.758749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.074218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:36:55.758852Z","caller":"traceutil/trace.go:171","msg":"trace[713148527] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26858; }","duration":"130.250651ms","start":"2026-10-07T06:36:55.628574Z","end":"2026-10-07T06:36:55.758825Z","steps":["trace[713148527] 'range keys from in-memory index tree' (duration: 129.918065ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:55.758944Z","caller":"traceutil/trace.go:171","msg":"trace[725820465] transaction","detail":"{read_only:false; response_revision:26859; number_of_response:1; }","duration":"123.169008ms","start":"2026-10-07T06:36:55.635753Z","end":"2026-10-07T06:36:55.758922Z","steps":["trace[725820465] 'process raft request' (duration: 118.52355ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:36:55.902784Z","caller":"traceutil/trace.go:171","msg":"trace[1922104977] transaction","detail":"{read_only:false; response_revision:26860; number_of_response:1; }","duration":"137.101541ms","start":"2026-10-07T06:36:55.76564Z","end":"2026-10-07T06:36:55.902742Z","steps":["trace[1922104977] 'process raft request' (duration: 115.655755ms)","trace[1922104977] 'compare' (duration: 21.272682ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:37:10.564722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.91536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a62cb972-9479-48a3-b5c7-a33ddf4378e2\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-10-07T06:37:10.564839Z","caller":"traceutil/trace.go:171","msg":"trace[287932885] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a62cb972-9479-48a3-b5c7-a33ddf4378e2; range_end:; response_count:1; response_revision:27021; }","duration":"280.106504ms","start":"2026-10-07T06:37:10.284706Z","end":"2026-10-07T06:37:10.564812Z","steps":["trace[287932885] 'range keys from in-memory index tree' (duration: 279.693175ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:10.564983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.233242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:37:10.565125Z","caller":"traceutil/trace.go:171","msg":"trace[1503731135] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:27021; }","duration":"419.430155ms","start":"2026-10-07T06:37:10.145637Z","end":"2026-10-07T06:37:10.565067Z","steps":["trace[1503731135] 'count revisions from in-memory index tree' (duration: 419.10017ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:10.565189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:10.14561Z","time spent":"419.565168ms","remote":"127.0.0.1:52596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true "} {"level":"warn","ts":"2026-10-07T06:37:10.564693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.734254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:37:10.565518Z","caller":"traceutil/trace.go:171","msg":"trace[1456056698] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:27021; }","duration":"363.647101ms","start":"2026-10-07T06:37:10.201826Z","end":"2026-10-07T06:37:10.565473Z","steps":["trace[1456056698] 'count revisions from in-memory index tree' (duration: 362.594241ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:10.565624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:10.201795Z","time spent":"363.782154ms","remote":"127.0.0.1:40116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-10-07T06:37:10.593294Z","caller":"traceutil/trace.go:171","msg":"trace[844067511] transaction","detail":"{read_only:false; response_revision:27022; number_of_response:1; }","duration":"264.836924ms","start":"2026-10-07T06:37:10.328416Z","end":"2026-10-07T06:37:10.593253Z","steps":["trace[844067511] 'process raft request' (duration: 264.59109ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:10.935812Z","caller":"traceutil/trace.go:171","msg":"trace[824691020] linearizableReadLoop","detail":"{readStateIndex:27927; appliedIndex:27925; }","duration":"555.723902ms","start":"2026-10-07T06:37:10.380055Z","end":"2026-10-07T06:37:10.935779Z","steps":["trace[824691020] 'read index received' (duration: 213.157608ms)","trace[824691020] 'applied index is now lower than readState.Index' (duration: 342.565004ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:37:10.935967Z","caller":"traceutil/trace.go:171","msg":"trace[1004761073] transaction","detail":"{read_only:false; response_revision:27024; number_of_response:1; }","duration":"360.560493ms","start":"2026-10-07T06:37:10.575391Z","end":"2026-10-07T06:37:10.935952Z","steps":["trace[1004761073] 'process raft request' (duration: 360.235737ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:10.936121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:10.575363Z","time spent":"360.634034ms","remote":"127.0.0.1:52844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3746,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T06:37:10.936257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.16645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:37:10.936808Z","caller":"traceutil/trace.go:171","msg":"trace[1065358157] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:27024; }","duration":"556.347933ms","start":"2026-10-07T06:37:10.380009Z","end":"2026-10-07T06:37:10.936357Z","steps":["trace[1065358157] 'agreement among raft nodes before linearized reading' (duration: 556.16118ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:10.936882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:10.379988Z","time spent":"556.871913ms","remote":"127.0.0.1:58326","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true "} {"level":"info","ts":"2026-10-07T06:37:10.936088Z","caller":"traceutil/trace.go:171","msg":"trace[2121530721] transaction","detail":"{read_only:false; response_revision:27023; number_of_response:1; }","duration":"574.825672ms","start":"2026-10-07T06:37:10.361227Z","end":"2026-10-07T06:37:10.936053Z","steps":["trace[2121530721] 'process raft request' (duration: 537.072678ms)","trace[2121530721] 'compare' (duration: 37.044201ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:37:10.938725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:10.361185Z","time spent":"577.472443ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T06:37:10.994089Z","caller":"traceutil/trace.go:171","msg":"trace[200682183] transaction","detail":"{read_only:false; response_revision:27025; number_of_response:1; }","duration":"316.568912ms","start":"2026-10-07T06:37:10.677484Z","end":"2026-10-07T06:37:10.994053Z","steps":["trace[200682183] 'process raft request' (duration: 316.320987ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:10.99433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:10.677453Z","time spent":"316.732355ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T06:37:10.994631Z","caller":"traceutil/trace.go:171","msg":"trace[631034779] transaction","detail":"{read_only:false; response_revision:27026; number_of_response:1; }","duration":"309.684352ms","start":"2026-10-07T06:37:10.684914Z","end":"2026-10-07T06:37:10.994598Z","steps":["trace[631034779] 'process raft request' (duration: 309.092191ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:10.994799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:10.684883Z","time spent":"309.812184ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T06:37:10.99487Z","caller":"traceutil/trace.go:171","msg":"trace[1806872255] transaction","detail":"{read_only:false; response_revision:27027; number_of_response:1; }","duration":"309.899447ms","start":"2026-10-07T06:37:10.684928Z","end":"2026-10-07T06:37:10.994828Z","steps":["trace[1806872255] 'process raft request' (duration: 309.360827ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:10.994986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:10.684901Z","time spent":"310.014469ms","remote":"127.0.0.1:52934","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-10-07T06:37:10.995025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.496376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-07T06:37:10.995117Z","caller":"traceutil/trace.go:171","msg":"trace[325734944] transaction","detail":"{read_only:false; response_revision:27028; number_of_response:1; }","duration":"192.896796ms","start":"2026-10-07T06:37:10.802203Z","end":"2026-10-07T06:37:10.9951Z","steps":["trace[325734944] 'process raft request' (duration: 192.334645ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:10.995131Z","caller":"traceutil/trace.go:171","msg":"trace[376531981] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:27028; }","duration":"492.68097ms","start":"2026-10-07T06:37:10.502425Z","end":"2026-10-07T06:37:10.995106Z","steps":["trace[376531981] 'agreement among raft nodes before linearized reading' (duration: 492.509307ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:10.995184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:10.502394Z","time spent":"492.780012ms","remote":"127.0.0.1:33322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":1,"response size":31,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true "} {"level":"info","ts":"2026-10-07T06:37:11.323195Z","caller":"traceutil/trace.go:171","msg":"trace[199840558] transaction","detail":"{read_only:false; response_revision:27029; number_of_response:1; }","duration":"143.668044ms","start":"2026-10-07T06:37:11.17949Z","end":"2026-10-07T06:37:11.323158Z","steps":["trace[199840558] 'process raft request' (duration: 143.45928ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:11.840163Z","caller":"traceutil/trace.go:171","msg":"trace[747599326] transaction","detail":"{read_only:false; response_revision:27031; number_of_response:1; }","duration":"124.554664ms","start":"2026-10-07T06:37:11.715574Z","end":"2026-10-07T06:37:11.840129Z","steps":["trace[747599326] 'process raft request' (duration: 124.35524ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:11.848035Z","caller":"traceutil/trace.go:171","msg":"trace[1872092233] transaction","detail":"{read_only:false; response_revision:27032; number_of_response:1; }","duration":"131.774531ms","start":"2026-10-07T06:37:11.716229Z","end":"2026-10-07T06:37:11.848004Z","steps":["trace[1872092233] 'process raft request' (duration: 131.578757ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:12.35284Z","caller":"traceutil/trace.go:171","msg":"trace[823944536] transaction","detail":"{read_only:false; response_revision:27036; number_of_response:1; }","duration":"229.579358ms","start":"2026-10-07T06:37:12.12323Z","end":"2026-10-07T06:37:12.352809Z","steps":["trace[823944536] 'process raft request' (duration: 229.523507ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:12.353336Z","caller":"traceutil/trace.go:171","msg":"trace[1311177790] transaction","detail":"{read_only:false; response_revision:27035; number_of_response:1; }","duration":"247.313392ms","start":"2026-10-07T06:37:12.105982Z","end":"2026-10-07T06:37:12.353295Z","steps":["trace[1311177790] 'process raft request' (duration: 164.496388ms)","trace[1311177790] 'compare' (duration: 82.136602ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:37:12.670671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.17216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:37:12.67076Z","caller":"traceutil/trace.go:171","msg":"trace[1215045003] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:27036; }","duration":"202.361284ms","start":"2026-10-07T06:37:12.468376Z","end":"2026-10-07T06:37:12.670738Z","steps":["trace[1215045003] 'count revisions from in-memory index tree' (duration: 201.986927ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:12.671293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.476174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:37:12.671425Z","caller":"traceutil/trace.go:171","msg":"trace[1612107509] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:27036; }","duration":"122.647398ms","start":"2026-10-07T06:37:12.548751Z","end":"2026-10-07T06:37:12.671398Z","steps":["trace[1612107509] 'count revisions from in-memory index tree' (duration: 122.391712ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:12.722176Z","caller":"traceutil/trace.go:171","msg":"trace[160110703] transaction","detail":"{read_only:false; response_revision:27037; number_of_response:1; }","duration":"122.974714ms","start":"2026-10-07T06:37:12.599149Z","end":"2026-10-07T06:37:12.722124Z","steps":["trace[160110703] 'process raft request' (duration: 122.668368ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:12.909273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.148743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:37:12.909396Z","caller":"traceutil/trace.go:171","msg":"trace[297926476] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:27037; }","duration":"135.336718ms","start":"2026-10-07T06:37:12.774034Z","end":"2026-10-07T06:37:12.909371Z","steps":["trace[297926476] 'count revisions from in-memory index tree' (duration: 135.066862ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:13.099337Z","caller":"traceutil/trace.go:171","msg":"trace[1142693265] transaction","detail":"{read_only:false; response_revision:27038; number_of_response:1; }","duration":"152.689805ms","start":"2026-10-07T06:37:12.946591Z","end":"2026-10-07T06:37:13.099281Z","steps":["trace[1142693265] 'process raft request' (duration: 152.489531ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:13.373151Z","caller":"traceutil/trace.go:171","msg":"trace[1135618313] transaction","detail":"{read_only:false; response_revision:27041; number_of_response:1; }","duration":"372.226834ms","start":"2026-10-07T06:37:13.000893Z","end":"2026-10-07T06:37:13.37312Z","steps":["trace[1135618313] 'process raft request' (duration: 372.104861ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:13.373157Z","caller":"traceutil/trace.go:171","msg":"trace[442670970] transaction","detail":"{read_only:false; response_revision:27039; number_of_response:1; }","duration":"373.162701ms","start":"2026-10-07T06:37:12.999946Z","end":"2026-10-07T06:37:13.373109Z","steps":["trace[442670970] 'process raft request' (duration: 372.790774ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:13.37338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:13.000889Z","time spent":"372.358966ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T06:37:13.373435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:12.999913Z","time spent":"373.363656ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T06:37:13.373152Z","caller":"traceutil/trace.go:171","msg":"trace[148511884] transaction","detail":"{read_only:false; response_revision:27040; number_of_response:1; }","duration":"372.265914ms","start":"2026-10-07T06:37:13.000849Z","end":"2026-10-07T06:37:13.373115Z","steps":["trace[148511884] 'process raft request' (duration: 372.100101ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:13.373538Z","caller":"traceutil/trace.go:171","msg":"trace[873471629] linearizableReadLoop","detail":"{readStateIndex:27946; appliedIndex:27941; }","duration":"365.774402ms","start":"2026-10-07T06:37:13.007724Z","end":"2026-10-07T06:37:13.373498Z","steps":["trace[873471629] 'read index received' (duration: 91.425658ms)","trace[873471629] 'applied index is now lower than readState.Index' (duration: 274.346014ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:37:13.373587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:13.000842Z","time spent":"372.715463ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T06:37:13.373697Z","caller":"traceutil/trace.go:171","msg":"trace[624181774] transaction","detail":"{read_only:false; response_revision:27042; number_of_response:1; }","duration":"372.697702ms","start":"2026-10-07T06:37:13.000987Z","end":"2026-10-07T06:37:13.373685Z","steps":["trace[624181774] 'process raft request' (duration: 372.05398ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:13.373756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:13.000982Z","time spent":"372.745063ms","remote":"127.0.0.1:52934","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-10-07T06:37:13.373769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.029926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:37:13.373845Z","caller":"traceutil/trace.go:171","msg":"trace[1197287101] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:27042; }","duration":"366.154159ms","start":"2026-10-07T06:37:13.007678Z","end":"2026-10-07T06:37:13.373832Z","steps":["trace[1197287101] 'agreement among raft nodes before linearized reading' (duration: 366.003796ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:13.373886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:13.007669Z","time spent":"366.2072ms","remote":"127.0.0.1:53148","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-10-07T06:37:13.373888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.479291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/neutron-dhcp-agent-default-w9pt8.18dc2b26f3b65a30\" ","response":"range_response_count:1 size:1395"} {"level":"info","ts":"2026-10-07T06:37:13.373935Z","caller":"traceutil/trace.go:171","msg":"trace[435059364] range","detail":"{range_begin:/registry/events/openstack/neutron-dhcp-agent-default-w9pt8.18dc2b26f3b65a30; range_end:; response_count:1; response_revision:27042; }","duration":"361.549522ms","start":"2026-10-07T06:37:13.012371Z","end":"2026-10-07T06:37:13.373921Z","steps":["trace[435059364] 'agreement among raft nodes before linearized reading' (duration: 361.320968ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:13.37398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:13.012355Z","time spent":"361.616753ms","remote":"127.0.0.1:52742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":1418,"request content":"key:\"/registry/events/openstack/neutron-dhcp-agent-default-w9pt8.18dc2b26f3b65a30\" "} {"level":"warn","ts":"2026-10-07T06:37:13.373983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.373764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a62cb972-9479-48a3-b5c7-a33ddf4378e2\" ","response":"range_response_count:1 size:3764"} {"level":"info","ts":"2026-10-07T06:37:13.374033Z","caller":"traceutil/trace.go:171","msg":"trace[1929824012] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a62cb972-9479-48a3-b5c7-a33ddf4378e2; range_end:; response_count:1; response_revision:27042; }","duration":"265.467186ms","start":"2026-10-07T06:37:13.108549Z","end":"2026-10-07T06:37:13.374016Z","steps":["trace[1929824012] 'agreement among raft nodes before linearized reading' (duration: 265.289522ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:13.571955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.797623ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T06:37:13.572063Z","caller":"traceutil/trace.go:171","msg":"trace[1614582505] linearizableReadLoop","detail":"{readStateIndex:27947; appliedIndex:27946; }","duration":"193.259242ms","start":"2026-10-07T06:37:13.378787Z","end":"2026-10-07T06:37:13.572046Z","steps":["trace[1614582505] 'read index received' (duration: 91.366876ms)","trace[1614582505] 'applied index is now lower than readState.Index' (duration: 101.890826ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:37:13.572125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.355144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:37:13.572143Z","caller":"traceutil/trace.go:171","msg":"trace[628791462] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:27043; }","duration":"193.429455ms","start":"2026-10-07T06:37:13.378709Z","end":"2026-10-07T06:37:13.572138Z","steps":["trace[628791462] 'agreement among raft nodes before linearized reading' (duration: 193.374584ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:13.572287Z","caller":"traceutil/trace.go:171","msg":"trace[1444678098] transaction","detail":"{read_only:false; response_revision:27043; number_of_response:1; }","duration":"195.053765ms","start":"2026-10-07T06:37:13.377186Z","end":"2026-10-07T06:37:13.57224Z","steps":["trace[1444678098] 'process raft request' (duration: 92.873535ms)","trace[1444678098] 'compare' (duration: 101.565649ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:37:13.795157Z","caller":"traceutil/trace.go:171","msg":"trace[602732350] linearizableReadLoop","detail":"{readStateIndex:27949; appliedIndex:27947; }","duration":"217.938278ms","start":"2026-10-07T06:37:13.577193Z","end":"2026-10-07T06:37:13.795131Z","steps":["trace[602732350] 'read index received' (duration: 121.855383ms)","trace[602732350] 'applied index is now lower than readState.Index' (duration: 96.081725ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:37:13.795544Z","caller":"traceutil/trace.go:171","msg":"trace[552797574] transaction","detail":"{read_only:false; response_revision:27044; number_of_response:1; }","duration":"415.45247ms","start":"2026-10-07T06:37:13.380041Z","end":"2026-10-07T06:37:13.795493Z","steps":["trace[552797574] 'process raft request' (duration: 319.10138ms)","trace[552797574] 'compare' (duration: 95.666618ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:37:13.795663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.112717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"info","ts":"2026-10-07T06:37:13.795716Z","caller":"traceutil/trace.go:171","msg":"trace[1909223677] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:27045; }","duration":"176.240131ms","start":"2026-10-07T06:37:13.619458Z","end":"2026-10-07T06:37:13.795699Z","steps":["trace[1909223677] 'agreement among raft nodes before linearized reading' (duration: 176.020016ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:13.795791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:13.380018Z","time spent":"415.630904ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T06:37:13.795901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.636212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-10-07T06:37:13.795557Z","caller":"traceutil/trace.go:171","msg":"trace[2142171041] transaction","detail":"{read_only:false; response_revision:27045; number_of_response:1; }","duration":"374.670639ms","start":"2026-10-07T06:37:13.420861Z","end":"2026-10-07T06:37:13.795531Z","steps":["trace[2142171041] 'process raft request' (duration: 374.19047ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:13.796093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:13.420807Z","time spent":"375.23132ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T06:37:13.795932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.799988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:37:13.79621Z","caller":"traceutil/trace.go:171","msg":"trace[845750939] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27045; }","duration":"171.151984ms","start":"2026-10-07T06:37:13.62504Z","end":"2026-10-07T06:37:13.796192Z","steps":["trace[845750939] 'agreement among raft nodes before linearized reading' (duration: 170.811518ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:13.796655Z","caller":"traceutil/trace.go:171","msg":"trace[1249488227] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27045; }","duration":"218.968478ms","start":"2026-10-07T06:37:13.577042Z","end":"2026-10-07T06:37:13.796011Z","steps":["trace[1249488227] 'agreement among raft nodes before linearized reading' (duration: 218.395747ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:13.980829Z","caller":"traceutil/trace.go:171","msg":"trace[2116645808] transaction","detail":"{read_only:false; response_revision:27046; number_of_response:1; }","duration":"132.066685ms","start":"2026-10-07T06:37:13.848728Z","end":"2026-10-07T06:37:13.980795Z","steps":["trace[2116645808] 'process raft request' (duration: 128.341955ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:13.980947Z","caller":"traceutil/trace.go:171","msg":"trace[251482678] transaction","detail":"{read_only:false; response_revision:27047; number_of_response:1; }","duration":"126.289027ms","start":"2026-10-07T06:37:13.854628Z","end":"2026-10-07T06:37:13.980917Z","steps":["trace[251482678] 'process raft request' (duration: 126.163644ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:13.980987Z","caller":"traceutil/trace.go:171","msg":"trace[228763994] linearizableReadLoop","detail":"{readStateIndex:27950; appliedIndex:27949; }","duration":"128.801604ms","start":"2026-10-07T06:37:13.852136Z","end":"2026-10-07T06:37:13.980937Z","steps":["trace[228763994] 'read index received' (duration: 124.89761ms)","trace[228763994] 'applied index is now lower than readState.Index' (duration: 3.897954ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:37:13.981478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.308704ms","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-10-07T06:37:13.981554Z","caller":"traceutil/trace.go:171","msg":"trace[2026364384] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27047; }","duration":"129.423546ms","start":"2026-10-07T06:37:13.852109Z","end":"2026-10-07T06:37:13.981533Z","steps":["trace[2026364384] 'agreement among raft nodes before linearized reading' (duration: 129.14934ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:16.391328Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23692} {"level":"info","ts":"2026-10-07T06:37:16.520615Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23692,"took":"124.182236ms","hash":4132552395,"current-db-size-bytes":57438208,"current-db-size":"57 MB","current-db-size-in-use-bytes":44687360,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-10-07T06:37:16.520695Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4132552395,"revision":23692,"compact-revision":21494} {"level":"info","ts":"2026-10-07T06:37:21.524793Z","caller":"traceutil/trace.go:171","msg":"trace[1632477749] transaction","detail":"{read_only:false; response_revision:27128; number_of_response:1; }","duration":"117.749425ms","start":"2026-10-07T06:37:21.407013Z","end":"2026-10-07T06:37:21.524763Z","steps":["trace[1632477749] 'process raft request' (duration: 65.406056ms)","trace[1632477749] 'compare' (duration: 52.218326ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:37:21.823655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.775859ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T06:37:21.823893Z","caller":"traceutil/trace.go:171","msg":"trace[925786184] transaction","detail":"{read_only:false; response_revision:27129; number_of_response:1; }","duration":"411.790391ms","start":"2026-10-07T06:37:21.412069Z","end":"2026-10-07T06:37:21.823859Z","steps":["trace[925786184] 'process raft request' (duration: 213.683277ms)","trace[925786184] 'compare' (duration: 196.780089ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:37:21.823969Z","caller":"traceutil/trace.go:171","msg":"trace[1210247274] linearizableReadLoop","detail":"{readStateIndex:28039; appliedIndex:28036; }","duration":"296.185496ms","start":"2026-10-07T06:37:21.527768Z","end":"2026-10-07T06:37:21.823953Z","steps":["trace[1210247274] 'read index received' (duration: 97.92606ms)","trace[1210247274] 'applied index is now lower than readState.Index' (duration: 198.257856ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:37:21.824007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:21.412031Z","time spent":"411.922833ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T06:37:21.824047Z","caller":"traceutil/trace.go:171","msg":"trace[1429204468] transaction","detail":"{read_only:false; response_revision:27130; number_of_response:1; }","duration":"407.132033ms","start":"2026-10-07T06:37:21.416857Z","end":"2026-10-07T06:37:21.823989Z","steps":["trace[1429204468] 'process raft request' (duration: 406.93196ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:21.824119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.35085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:37:21.824087Z","caller":"traceutil/trace.go:171","msg":"trace[1713285816] transaction","detail":"{read_only:false; response_revision:27131; number_of_response:1; }","duration":"405.589654ms","start":"2026-10-07T06:37:21.418447Z","end":"2026-10-07T06:37:21.824037Z","steps":["trace[1713285816] 'process raft request' (duration: 405.453592ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:21.824161Z","caller":"traceutil/trace.go:171","msg":"trace[709056746] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:27131; }","duration":"296.455952ms","start":"2026-10-07T06:37:21.52769Z","end":"2026-10-07T06:37:21.824146Z","steps":["trace[709056746] 'agreement among raft nodes before linearized reading' (duration: 296.36082ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:21.824288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:21.41682Z","time spent":"407.335207ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T06:37:21.824297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:21.418414Z","time spent":"405.778268ms","remote":"127.0.0.1:52934","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-10-07T06:37:21.824412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.269926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:37:21.824505Z","caller":"traceutil/trace.go:171","msg":"trace[457843585] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27131; }","duration":"198.436739ms","start":"2026-10-07T06:37:21.626046Z","end":"2026-10-07T06:37:21.824482Z","steps":["trace[457843585] 'agreement among raft nodes before linearized reading' (duration: 198.217835ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:21.824484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.267155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-10-07T06:37:21.824592Z","caller":"traceutil/trace.go:171","msg":"trace[1921797768] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:27131; }","duration":"208.389138ms","start":"2026-10-07T06:37:21.61617Z","end":"2026-10-07T06:37:21.824559Z","steps":["trace[1921797768] 'agreement among raft nodes before linearized reading' (duration: 208.067362ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:41.716557Z","caller":"traceutil/trace.go:171","msg":"trace[1187841798] transaction","detail":"{read_only:false; response_revision:27296; number_of_response:1; }","duration":"101.359596ms","start":"2026-10-07T06:37:41.615168Z","end":"2026-10-07T06:37:41.716528Z","steps":["trace[1187841798] 'process raft request' (duration: 100.673413ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:42.017976Z","caller":"traceutil/trace.go:171","msg":"trace[80602640] transaction","detail":"{read_only:false; response_revision:27298; number_of_response:1; }","duration":"109.377757ms","start":"2026-10-07T06:37:41.908567Z","end":"2026-10-07T06:37:42.017945Z","steps":["trace[80602640] 'process raft request' (duration: 108.713185ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:42.018074Z","caller":"traceutil/trace.go:171","msg":"trace[1321508387] transaction","detail":"{read_only:false; response_revision:27299; number_of_response:1; }","duration":"108.961049ms","start":"2026-10-07T06:37:41.909051Z","end":"2026-10-07T06:37:42.018012Z","steps":["trace[1321508387] 'process raft request' (duration: 108.53159ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:42.380445Z","caller":"traceutil/trace.go:171","msg":"trace[1388177310] transaction","detail":"{read_only:false; response_revision:27303; number_of_response:1; }","duration":"194.761221ms","start":"2026-10-07T06:37:42.185646Z","end":"2026-10-07T06:37:42.380408Z","steps":["trace[1388177310] 'process raft request' (duration: 143.030423ms)","trace[1388177310] 'compare' (duration: 51.498274ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:37:42.380861Z","caller":"traceutil/trace.go:171","msg":"trace[1008848066] transaction","detail":"{read_only:false; response_revision:27304; number_of_response:1; }","duration":"195.085058ms","start":"2026-10-07T06:37:42.185725Z","end":"2026-10-07T06:37:42.38081Z","steps":["trace[1008848066] 'process raft request' (duration: 194.627509ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:46.706783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.206823ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T06:37:46.706899Z","caller":"traceutil/trace.go:171","msg":"trace[1191415844] linearizableReadLoop","detail":"{readStateIndex:28246; appliedIndex:28245; }","duration":"225.304887ms","start":"2026-10-07T06:37:46.481575Z","end":"2026-10-07T06:37:46.70688Z","steps":["trace[1191415844] 'read index received' (duration: 33.941292ms)","trace[1191415844] 'applied index is now lower than readState.Index' (duration: 191.362635ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:37:46.70697Z","caller":"traceutil/trace.go:171","msg":"trace[2098863031] transaction","detail":"{read_only:false; response_revision:27333; number_of_response:1; }","duration":"302.919734ms","start":"2026-10-07T06:37:46.404039Z","end":"2026-10-07T06:37:46.706959Z","steps":["trace[2098863031] 'process raft request' (duration: 111.426897ms)","trace[2098863031] 'compare' (duration: 191.068279ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:37:46.70703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:46.404011Z","time spent":"302.989805ms","remote":"127.0.0.1:52934","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-10-07T06:37:46.707263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.653053ms","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-10-07T06:37:46.707393Z","caller":"traceutil/trace.go:171","msg":"trace[1608880071] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27333; }","duration":"225.819397ms","start":"2026-10-07T06:37:46.481545Z","end":"2026-10-07T06:37:46.707364Z","steps":["trace[1608880071] 'agreement among raft nodes before linearized reading' (duration: 225.509781ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:46.71861Z","caller":"traceutil/trace.go:171","msg":"trace[1189124898] transaction","detail":"{read_only:false; response_revision:27334; number_of_response:1; }","duration":"142.091605ms","start":"2026-10-07T06:37:46.57649Z","end":"2026-10-07T06:37:46.718582Z","steps":["trace[1189124898] 'process raft request' (duration: 141.462243ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:37:47.055137Z","caller":"traceutil/trace.go:171","msg":"trace[1971496309] transaction","detail":"{read_only:false; response_revision:27336; number_of_response:1; }","duration":"329.407504ms","start":"2026-10-07T06:37:46.725695Z","end":"2026-10-07T06:37:47.055102Z","steps":["trace[1971496309] 'process raft request' (duration: 329.17548ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:37:47.05537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:37:46.72567Z","time spent":"329.565417ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T06:37:47.186601Z","caller":"traceutil/trace.go:171","msg":"trace[349746718] transaction","detail":"{read_only:false; response_revision:27337; number_of_response:1; }","duration":"210.395986ms","start":"2026-10-07T06:37:46.976143Z","end":"2026-10-07T06:37:47.186539Z","steps":["trace[349746718] 'process raft request' (duration: 191.308195ms)","trace[349746718] 'compare' (duration: 18.708934ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:38:02.70677Z","caller":"traceutil/trace.go:171","msg":"trace[1593885185] linearizableReadLoop","detail":"{readStateIndex:28367; appliedIndex:28366; }","duration":"141.569805ms","start":"2026-10-07T06:38:02.565169Z","end":"2026-10-07T06:38:02.706739Z","steps":["trace[1593885185] 'read index received' (duration: 141.357851ms)","trace[1593885185] 'applied index is now lower than readState.Index' (duration: 210.144µs)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:38:02.706988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.770829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-07T06:38:02.707105Z","caller":"traceutil/trace.go:171","msg":"trace[1059396917] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:27451; }","duration":"141.965993ms","start":"2026-10-07T06:38:02.565114Z","end":"2026-10-07T06:38:02.70708Z","steps":["trace[1059396917] 'agreement among raft nodes before linearized reading' (duration: 141.707918ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:38:02.707781Z","caller":"traceutil/trace.go:171","msg":"trace[25051703] transaction","detail":"{read_only:false; response_revision:27451; number_of_response:1; }","duration":"185.23444ms","start":"2026-10-07T06:38:02.521548Z","end":"2026-10-07T06:38:02.706783Z","steps":["trace[25051703] 'process raft request' (duration: 184.933724ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:38:02.728144Z","caller":"traceutil/trace.go:171","msg":"trace[1731945286] transaction","detail":"{read_only:false; response_revision:27452; number_of_response:1; }","duration":"153.095612ms","start":"2026-10-07T06:38:02.575012Z","end":"2026-10-07T06:38:02.728107Z","steps":["trace[1731945286] 'process raft request' (duration: 152.91048ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:38:02.973679Z","caller":"traceutil/trace.go:171","msg":"trace[623868861] transaction","detail":"{read_only:false; response_revision:27453; number_of_response:1; }","duration":"135.558602ms","start":"2026-10-07T06:38:02.838087Z","end":"2026-10-07T06:38:02.973645Z","steps":["trace[623868861] 'process raft request' (duration: 135.324948ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:38:03.415361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.353103ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T06:38:03.415715Z","caller":"traceutil/trace.go:171","msg":"trace[430306152] linearizableReadLoop","detail":"{readStateIndex:28370; appliedIndex:28369; }","duration":"277.440313ms","start":"2026-10-07T06:38:03.13824Z","end":"2026-10-07T06:38:03.41568Z","steps":["trace[430306152] 'read index received' (duration: 39.831µs)","trace[430306152] 'applied index is now lower than readState.Index' (duration: 277.398962ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:38:03.415761Z","caller":"traceutil/trace.go:171","msg":"trace[1649347771] transaction","detail":"{read_only:false; response_revision:27454; number_of_response:1; }","duration":"577.231397ms","start":"2026-10-07T06:38:02.838483Z","end":"2026-10-07T06:38:03.415714Z","steps":["trace[1649347771] 'process raft request' (duration: 238.362724ms)","trace[1649347771] 'compare' (duration: 337.882434ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:38:03.415949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:38:02.838459Z","time spent":"577.389721ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T06:38:03.416045Z","caller":"traceutil/trace.go:171","msg":"trace[129401615] transaction","detail":"{read_only:false; response_revision:27455; number_of_response:1; }","duration":"163.812226ms","start":"2026-10-07T06:38:03.252193Z","end":"2026-10-07T06:38:03.416005Z","steps":["trace[129401615] 'process raft request' (duration: 163.346977ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:38:03.416277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.031104ms","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-10-07T06:38:03.416365Z","caller":"traceutil/trace.go:171","msg":"trace[814372277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27455; }","duration":"278.163587ms","start":"2026-10-07T06:38:03.138185Z","end":"2026-10-07T06:38:03.416348Z","steps":["trace[814372277] 'agreement among raft nodes before linearized reading' (duration: 277.934632ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:38:03.416683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.593965ms","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:6"} {"level":"info","ts":"2026-10-07T06:38:03.417191Z","caller":"traceutil/trace.go:171","msg":"trace[405267055] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:27455; }","duration":"260.96129ms","start":"2026-10-07T06:38:03.155996Z","end":"2026-10-07T06:38:03.416958Z","steps":["trace[405267055] 'agreement among raft nodes before linearized reading' (duration: 260.515073ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:38:03.722457Z","caller":"traceutil/trace.go:171","msg":"trace[1015897420] transaction","detail":"{read_only:false; response_revision:27456; number_of_response:1; }","duration":"301.166821ms","start":"2026-10-07T06:38:03.421258Z","end":"2026-10-07T06:38:03.722425Z","steps":["trace[1015897420] 'process raft request' (duration: 271.001211ms)","trace[1015897420] 'compare' (duration: 29.68556ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:38:03.72263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:38:03.421231Z","time spent":"301.311924ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T06:38:03.72822Z","caller":"traceutil/trace.go:171","msg":"trace[1179239876] linearizableReadLoop","detail":"{readStateIndex:28373; appliedIndex:28371; }","duration":"102.982246ms","start":"2026-10-07T06:38:03.625196Z","end":"2026-10-07T06:38:03.728178Z","steps":["trace[1179239876] 'read index received' (duration: 66.972636ms)","trace[1179239876] 'applied index is now lower than readState.Index' (duration: 36.00802ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:38:03.728411Z","caller":"traceutil/trace.go:171","msg":"trace[80002380] transaction","detail":"{read_only:false; response_revision:27457; number_of_response:1; }","duration":"254.625942ms","start":"2026-10-07T06:38:03.47377Z","end":"2026-10-07T06:38:03.728396Z","steps":["trace[80002380] 'process raft request' (duration: 254.240144ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:38:03.728857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.641289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:38:03.728901Z","caller":"traceutil/trace.go:171","msg":"trace[1656935937] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27457; }","duration":"103.754471ms","start":"2026-10-07T06:38:03.625134Z","end":"2026-10-07T06:38:03.728888Z","steps":["trace[1656935937] 'agreement among raft nodes before linearized reading' (duration: 103.654629ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:38:03.998147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.606507ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T06:38:03.998302Z","caller":"traceutil/trace.go:171","msg":"trace[201908345] transaction","detail":"{read_only:false; response_revision:27458; number_of_response:1; }","duration":"190.448319ms","start":"2026-10-07T06:38:03.80783Z","end":"2026-10-07T06:38:03.998278Z","steps":["trace[201908345] 'process raft request' (duration: 49.410583ms)","trace[201908345] 'compare' (duration: 140.436374ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:38:09.924939Z","caller":"traceutil/trace.go:171","msg":"trace[1954301017] transaction","detail":"{read_only:false; response_revision:27503; number_of_response:1; }","duration":"166.009007ms","start":"2026-10-07T06:38:09.758875Z","end":"2026-10-07T06:38:09.924884Z","steps":["trace[1954301017] 'process raft request' (duration: 136.711853ms)","trace[1954301017] 'compare' (duration: 28.947607ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:38:10.264264Z","caller":"traceutil/trace.go:171","msg":"trace[730901410] transaction","detail":"{read_only:false; response_revision:27506; number_of_response:1; }","duration":"154.668813ms","start":"2026-10-07T06:38:10.109558Z","end":"2026-10-07T06:38:10.264227Z","steps":["trace[730901410] 'process raft request' (duration: 79.398479ms)","trace[730901410] 'compare' (duration: 75.0721ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:38:10.32025Z","caller":"traceutil/trace.go:171","msg":"trace[511762962] transaction","detail":"{read_only:false; response_revision:27507; number_of_response:1; }","duration":"146.846635ms","start":"2026-10-07T06:38:10.173367Z","end":"2026-10-07T06:38:10.320213Z","steps":["trace[511762962] 'process raft request' (duration: 146.401377ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:38:10.320614Z","caller":"traceutil/trace.go:171","msg":"trace[863884893] transaction","detail":"{read_only:false; response_revision:27508; number_of_response:1; }","duration":"144.9777ms","start":"2026-10-07T06:38:10.175611Z","end":"2026-10-07T06:38:10.320589Z","steps":["trace[863884893] 'process raft request' (duration: 144.4296ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:38:10.321174Z","caller":"traceutil/trace.go:171","msg":"trace[69787170] linearizableReadLoop","detail":"{readStateIndex:28427; appliedIndex:28424; }","duration":"102.478596ms","start":"2026-10-07T06:38:10.218678Z","end":"2026-10-07T06:38:10.321156Z","steps":["trace[69787170] 'read index received' (duration: 101.167091ms)","trace[69787170] 'applied index is now lower than readState.Index' (duration: 1.310525ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:38:10.321368Z","caller":"traceutil/trace.go:171","msg":"trace[1132515351] transaction","detail":"{read_only:false; response_revision:27509; number_of_response:1; }","duration":"145.301065ms","start":"2026-10-07T06:38:10.176002Z","end":"2026-10-07T06:38:10.321303Z","steps":["trace[1132515351] 'process raft request' (duration: 144.447299ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:38:10.321554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.827643ms","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-10-07T06:38:10.321653Z","caller":"traceutil/trace.go:171","msg":"trace[773557986] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27509; }","duration":"103.026637ms","start":"2026-10-07T06:38:10.218613Z","end":"2026-10-07T06:38:10.32164Z","steps":["trace[773557986] 'agreement among raft nodes before linearized reading' (duration: 102.778452ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:38:33.833114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.332857ms","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":"warn","ts":"2026-10-07T06:38:33.833131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.283723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/roles/\" range_end:\"/registry/openstack.k-orc.cloud/roles0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-07T06:38:33.833264Z","caller":"traceutil/trace.go:171","msg":"trace[1417421317] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/roles/; range_end:/registry/openstack.k-orc.cloud/roles0; response_count:0; response_revision:27832; }","duration":"166.538347ms","start":"2026-10-07T06:38:33.666695Z","end":"2026-10-07T06:38:33.833233Z","steps":["trace[1417421317] 'count revisions from in-memory index tree' (duration: 166.16486ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:38:33.833362Z","caller":"traceutil/trace.go:171","msg":"trace[1113171540] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27832; }","duration":"117.555081ms","start":"2026-10-07T06:38:33.71566Z","end":"2026-10-07T06:38:33.833216Z","steps":["trace[1113171540] 'range keys from in-memory index tree' (duration: 117.125153ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:38:34.084141Z","caller":"traceutil/trace.go:171","msg":"trace[1670003244] transaction","detail":"{read_only:false; response_revision:27834; number_of_response:1; }","duration":"213.470134ms","start":"2026-10-07T06:38:33.870623Z","end":"2026-10-07T06:38:34.084093Z","steps":["trace[1670003244] 'process raft request' (duration: 123.108057ms)","trace[1670003244] 'compare' (duration: 90.011851ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:38:34.340528Z","caller":"traceutil/trace.go:171","msg":"trace[1044440036] transaction","detail":"{read_only:false; response_revision:27836; number_of_response:1; }","duration":"179.136605ms","start":"2026-10-07T06:38:34.161354Z","end":"2026-10-07T06:38:34.340491Z","steps":["trace[1044440036] 'process raft request' (duration: 178.401522ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:38:34.659836Z","caller":"traceutil/trace.go:171","msg":"trace[1536249804] transaction","detail":"{read_only:false; response_revision:27838; number_of_response:1; }","duration":"219.917045ms","start":"2026-10-07T06:38:34.439875Z","end":"2026-10-07T06:38:34.659792Z","steps":["trace[1536249804] 'process raft request' (duration: 219.66947ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:38:34.888613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.462759ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-07T06:38:34.888927Z","caller":"traceutil/trace.go:171","msg":"trace[1588916712] transaction","detail":"{read_only:false; response_revision:27840; number_of_response:1; }","duration":"441.962792ms","start":"2026-10-07T06:38:34.446942Z","end":"2026-10-07T06:38:34.888904Z","steps":["trace[1588916712] 'process raft request' (duration: 441.793469ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:38:34.888935Z","caller":"traceutil/trace.go:171","msg":"trace[1801892079] transaction","detail":"{read_only:false; response_revision:27839; number_of_response:1; }","duration":"443.888529ms","start":"2026-10-07T06:38:34.444992Z","end":"2026-10-07T06:38:34.88888Z","steps":["trace[1801892079] 'process raft request' (duration: 334.041163ms)","trace[1801892079] 'compare' (duration: 109.120612ms)"],"step_count":2} {"level":"warn","ts":"2026-10-07T06:38:34.889007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:38:34.446928Z","time spent":"442.043474ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T06:38:34.889474Z","caller":"traceutil/trace.go:171","msg":"trace[265107634] linearizableReadLoop","detail":"{readStateIndex:28765; appliedIndex:28761; }","duration":"430.130047ms","start":"2026-10-07T06:38:34.459311Z","end":"2026-10-07T06:38:34.889441Z","steps":["trace[265107634] 'read index received' (duration: 200.306324ms)","trace[265107634] 'applied index is now lower than readState.Index' (duration: 229.822493ms)"],"step_count":2} {"level":"info","ts":"2026-10-07T06:38:34.889514Z","caller":"traceutil/trace.go:171","msg":"trace[137335357] transaction","detail":"{read_only:false; response_revision:27842; number_of_response:1; }","duration":"402.19637ms","start":"2026-10-07T06:38:34.487304Z","end":"2026-10-07T06:38:34.8895Z","steps":["trace[137335357] 'process raft request' (duration: 401.997566ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:38:34.889593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:38:34.48727Z","time spent":"402.283732ms","remote":"127.0.0.1:52934","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-10-07T06:38:34.889658Z","caller":"traceutil/trace.go:171","msg":"trace[1443086341] transaction","detail":"{read_only:false; response_revision:27841; number_of_response:1; }","duration":"438.423774ms","start":"2026-10-07T06:38:34.451147Z","end":"2026-10-07T06:38:34.889571Z","steps":["trace[1443086341] 'process raft request' (duration: 437.705751ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:38:34.889802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.478304ms","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-10-07T06:38:34.889868Z","caller":"traceutil/trace.go:171","msg":"trace[1669521194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27842; }","duration":"430.578516ms","start":"2026-10-07T06:38:34.459267Z","end":"2026-10-07T06:38:34.889846Z","steps":["trace[1669521194] 'agreement among raft nodes before linearized reading' (duration: 430.28123ms)"],"step_count":1} {"level":"warn","ts":"2026-10-07T06:38:34.889911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:38:34.459252Z","time spent":"430.650647ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-07T06:38:34.889949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:38:34.451116Z","time spent":"438.678659ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-07T06:38:34.890143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-07T06:38:34.444962Z","time spent":"444.074591ms","remote":"127.0.0.1:52934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-07T06:40:50.713584Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6d0019d52d78795","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-07T06:40:50.720717Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-07T06:40:50.720841Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-07T06:41:55.63942Z","caller":"traceutil/trace.go:171","msg":"trace[955641453] transaction","detail":"{read_only:false; response_revision:29716; number_of_response:1; }","duration":"107.462341ms","start":"2026-10-07T06:41:55.531899Z","end":"2026-10-07T06:41:55.639362Z","steps":["trace[955641453] 'process raft request' (duration: 106.993582ms)"],"step_count":1} {"level":"info","ts":"2026-10-07T06:42:16.401454Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27068} {"level":"info","ts":"2026-10-07T06:42:16.580295Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27068,"took":"173.731833ms","hash":1807632399,"current-db-size-bytes":57860096,"current-db-size":"58 MB","current-db-size-in-use-bytes":36237312,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-07T06:42:16.580408Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1807632399,"revision":27068,"compact-revision":23692} {"level":"info","ts":"2026-10-07T06:47:16.411013Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":29972} {"level":"info","ts":"2026-10-07T06:47:16.563891Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":29972,"took":"146.892515ms","hash":3664928068,"current-db-size-bytes":57860096,"current-db-size":"58 MB","current-db-size-in-use-bytes":31576064,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-07T06:47:16.563978Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3664928068,"revision":29972,"compact-revision":27068} {"level":"info","ts":"2026-10-07T06:52:16.417779Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32253} {"level":"info","ts":"2026-10-07T06:52:16.583188Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32253,"took":"160.128776ms","hash":1026842086,"current-db-size-bytes":57860096,"current-db-size":"58 MB","current-db-size-in-use-bytes":30302208,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-07T06:52:16.583276Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1026842086,"revision":32253,"compact-revision":29972} {"level":"info","ts":"2026-10-07T06:57:16.425414Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34479} {"level":"info","ts":"2026-10-07T06:57:16.572921Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34479,"took":"140.093317ms","hash":3905793317,"current-db-size-bytes":57860096,"current-db-size":"58 MB","current-db-size-in-use-bytes":30355456,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-07T06:57:16.57301Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3905793317,"revision":34479,"compact-revision":32253} {"level":"info","ts":"2026-10-07T07:01:30.436048Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6d0019d52d78795","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-07T07:01:30.446428Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-07T07:01:30.446695Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-07T07:02:16.443935Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":36709} {"level":"info","ts":"2026-10-07T07:02:16.600233Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":36709,"took":"148.6414ms","hash":2669849808,"current-db-size-bytes":57860096,"current-db-size":"58 MB","current-db-size-in-use-bytes":31956992,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-07T07:02:16.600327Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2669849808,"revision":36709,"compact-revision":34479} {"level":"info","ts":"2026-10-07T07:07:16.452322Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39109} {"level":"info","ts":"2026-10-07T07:07:16.601746Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39109,"took":"143.726287ms","hash":3003396845,"current-db-size-bytes":58712064,"current-db-size":"59 MB","current-db-size-in-use-bytes":31338496,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-07T07:07:16.601835Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3003396845,"revision":39109,"compact-revision":36709} {"level":"info","ts":"2026-10-07T07:12:16.460894Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":41375} {"level":"info","ts":"2026-10-07T07:12:16.592547Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":41375,"took":"125.241228ms","hash":262690929,"current-db-size-bytes":58712064,"current-db-size":"59 MB","current-db-size-in-use-bytes":29065216,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-07T07:12:16.59265Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":262690929,"revision":41375,"compact-revision":39109} {"level":"info","ts":"2026-10-07T07:17:16.471933Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":43599} {"level":"info","ts":"2026-10-07T07:17:16.601474Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":43599,"took":"124.383081ms","hash":1537776645,"current-db-size-bytes":58712064,"current-db-size":"59 MB","current-db-size-in-use-bytes":28852224,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-07T07:17:16.601664Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1537776645,"revision":43599,"compact-revision":41375} {"level":"info","ts":"2026-10-07T07:22:16.481043Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":45875} {"level":"info","ts":"2026-10-07T07:22:16.611795Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":45875,"took":"125.819999ms","hash":574180299,"current-db-size-bytes":58712064,"current-db-size":"59 MB","current-db-size-in-use-bytes":28753920,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-07T07:22:16.611871Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":574180299,"revision":45875,"compact-revision":43599} {"level":"info","ts":"2026-10-07T07:23:10.006035Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6d0019d52d78795","local-member-applied-index":50005,"local-member-snapshot-index":40004,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-07T07:23:10.01418Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":50005} {"level":"info","ts":"2026-10-07T07:23:10.014328Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":45005}