{"level":"warn","ts":"2026-10-14T17:36:50.663323Z","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-14T17:36:50.663437Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.129: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.129:2380","--initial-cluster=instance=https://162.253.55.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.129: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-14T17:36:50.663512Z","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-14T17:36:50.663524Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.129:2380"]} {"level":"info","ts":"2026-10-14T17:36:50.663552Z","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-14T17:36:50.664265Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.129:2379"]} {"level":"info","ts":"2026-10-14T17:36:50.664377Z","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.129:2380"],"listen-peer-urls":["https://162.253.55.129:2380"],"advertise-client-urls":["https://162.253.55.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.129: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-14T17:36:50.668885Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.179957ms"} {"level":"info","ts":"2026-10-14T17:36:50.684557Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d232699cb6c87299","cluster-id":"f2b9115890c3fc7f"} {"level":"info","ts":"2026-10-14T17:36:50.684702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 switched to configuration voters=()"} {"level":"info","ts":"2026-10-14T17:36:50.684745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became follower at term 0"} {"level":"info","ts":"2026-10-14T17:36:50.684773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d232699cb6c87299 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-14T17:36:50.684788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became follower at term 1"} {"level":"info","ts":"2026-10-14T17:36:50.684862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 switched to configuration voters=(15146284618602803865)"} {"level":"warn","ts":"2026-10-14T17:36:50.691268Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-14T17:36:50.694385Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-14T17:36:50.697727Z","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-14T17:36:50.700214Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d232699cb6c87299","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-14T17:36:50.70041Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d232699cb6c87299","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-14T17:36:50.700589Z","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-14T17:36:50.700734Z","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-14T17:36:50.700756Z","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-14T17:36:50.701857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 switched to configuration voters=(15146284618602803865)"} {"level":"info","ts":"2026-10-14T17:36:50.7022Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f2b9115890c3fc7f","local-member-id":"d232699cb6c87299","added-peer-id":"d232699cb6c87299","added-peer-peer-urls":["https://162.253.55.129:2380"]} {"level":"info","ts":"2026-10-14T17:36:50.703281Z","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-14T17:36:50.703434Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.129:2380"} {"level":"info","ts":"2026-10-14T17:36:50.703474Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.129:2380"} {"level":"info","ts":"2026-10-14T17:36:50.703569Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d232699cb6c87299","initial-advertise-peer-urls":["https://162.253.55.129:2380"],"listen-peer-urls":["https://162.253.55.129:2380"],"advertise-client-urls":["https://162.253.55.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-14T17:36:50.703599Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-14T17:36:50.78551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 is starting a new election at term 1"} {"level":"info","ts":"2026-10-14T17:36:50.785582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-14T17:36:50.78563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 received MsgPreVoteResp from d232699cb6c87299 at term 1"} {"level":"info","ts":"2026-10-14T17:36:50.785674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became candidate at term 2"} {"level":"info","ts":"2026-10-14T17:36:50.785691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 received MsgVoteResp from d232699cb6c87299 at term 2"} {"level":"info","ts":"2026-10-14T17:36:50.785725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d232699cb6c87299 became leader at term 2"} {"level":"info","ts":"2026-10-14T17:36:50.785746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d232699cb6c87299 elected leader d232699cb6c87299 at term 2"} {"level":"info","ts":"2026-10-14T17:36:50.787022Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d232699cb6c87299","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.129:2379]}","request-path":"/0/members/d232699cb6c87299/attributes","cluster-id":"f2b9115890c3fc7f","publish-timeout":"7s"} {"level":"info","ts":"2026-10-14T17:36:50.787044Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T17:36:50.787101Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T17:36:50.787045Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T17:36:50.787421Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-14T17:36:50.787543Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-14T17:36:50.78832Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f2b9115890c3fc7f","local-member-id":"d232699cb6c87299","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T17:36:50.788441Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T17:36:50.788482Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T17:36:50.790664Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-14T17:36:50.790929Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.129:2379"} {"level":"info","ts":"2026-10-14T17:36:52.949106Z","caller":"traceutil/trace.go:171","msg":"trace[756120271] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"106.704646ms","start":"2026-10-14T17:36:52.842372Z","end":"2026-10-14T17:36:52.949077Z","steps":["trace[756120271] 'process raft request' (duration: 106.646924ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:36:52.949147Z","caller":"traceutil/trace.go:171","msg":"trace[487091000] linearizableReadLoop","detail":"{readStateIndex:41; appliedIndex:39; }","duration":"112.324556ms","start":"2026-10-14T17:36:52.83678Z","end":"2026-10-14T17:36:52.949105Z","steps":["trace[487091000] 'read index received' (duration: 2.369605ms)","trace[487091000] 'applied index is now lower than readState.Index' (duration: 109.953141ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:36:52.949207Z","caller":"traceutil/trace.go:171","msg":"trace[515958228] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"113.506953ms","start":"2026-10-14T17:36:52.835655Z","end":"2026-10-14T17:36:52.949162Z","steps":["trace[515958228] 'process raft request' (duration: 106.826479ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:36:52.949464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.654813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-14T17:36:52.949567Z","caller":"traceutil/trace.go:171","msg":"trace[42169437] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:38; }","duration":"112.818758ms","start":"2026-10-14T17:36:52.836733Z","end":"2026-10-14T17:36:52.949552Z","steps":["trace[42169437] 'agreement among raft nodes before linearized reading' (duration: 112.536191ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:36:58.419586Z","caller":"traceutil/trace.go:171","msg":"trace[1731634420] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"144.588194ms","start":"2026-10-14T17:36:58.274976Z","end":"2026-10-14T17:36:58.419564Z","steps":["trace[1731634420] 'process raft request' (duration: 144.480641ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:36:58.768906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.656413ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-14T17:36:58.769012Z","caller":"traceutil/trace.go:171","msg":"trace[524764192] linearizableReadLoop","detail":"{readStateIndex:330; appliedIndex:329; }","duration":"303.382868ms","start":"2026-10-14T17:36:58.465614Z","end":"2026-10-14T17:36:58.768997Z","steps":["trace[524764192] 'read index received' (duration: 159.140592ms)","trace[524764192] 'applied index is now lower than readState.Index' (duration: 144.241196ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:36:58.769132Z","caller":"traceutil/trace.go:171","msg":"trace[361694725] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"339.398814ms","start":"2026-10-14T17:36:58.42972Z","end":"2026-10-14T17:36:58.769119Z","steps":["trace[361694725] 'process raft request' (duration: 195.018045ms)","trace[361694725] 'compare' (duration: 143.517179ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T17:36:58.769222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:36:58.429687Z","time spent":"339.476785ms","remote":"127.0.0.1:38234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":219,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T17:36:58.769551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.938191ms","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-14T17:36:58.769592Z","caller":"traceutil/trace.go:171","msg":"trace[1812132302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:320; }","duration":"303.983852ms","start":"2026-10-14T17:36:58.465598Z","end":"2026-10-14T17:36:58.769582Z","steps":["trace[1812132302] 'agreement among raft nodes before linearized reading' (duration: 303.877329ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:36:58.769653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:36:58.465512Z","time spent":"304.131285ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-14T17:36:58.769925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.586128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-14T17:36:58.770043Z","caller":"traceutil/trace.go:171","msg":"trace[2107206376] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:320; }","duration":"136.784333ms","start":"2026-10-14T17:36:58.633232Z","end":"2026-10-14T17:36:58.770016Z","steps":["trace[2107206376] 'agreement among raft nodes before linearized reading' (duration: 136.555547ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:36:59.050923Z","caller":"traceutil/trace.go:171","msg":"trace[1850452056] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"276.261658ms","start":"2026-10-14T17:36:58.774635Z","end":"2026-10-14T17:36:59.050897Z","steps":["trace[1850452056] 'process raft request' (duration: 276.016113ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:36:59.050896Z","caller":"traceutil/trace.go:171","msg":"trace[158936293] linearizableReadLoop","detail":"{readStateIndex:332; appliedIndex:330; }","duration":"274.211401ms","start":"2026-10-14T17:36:58.776644Z","end":"2026-10-14T17:36:59.050855Z","steps":["trace[158936293] 'read index received' (duration: 56.673015ms)","trace[158936293] 'applied index is now lower than readState.Index' (duration: 217.537046ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T17:36:59.051157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.093449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-10-14T17:36:59.05114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.455217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-10-14T17:36:59.051204Z","caller":"traceutil/trace.go:171","msg":"trace[279579073] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:322; }","duration":"243.211292ms","start":"2026-10-14T17:36:58.80798Z","end":"2026-10-14T17:36:59.051191Z","steps":["trace[279579073] 'agreement among raft nodes before linearized reading' (duration: 243.10094ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:36:59.051242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.370282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-14T17:36:59.051277Z","caller":"traceutil/trace.go:171","msg":"trace[2019105268] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:322; }","duration":"201.458993ms","start":"2026-10-14T17:36:58.849808Z","end":"2026-10-14T17:36:59.051267Z","steps":["trace[2019105268] 'agreement among raft nodes before linearized reading' (duration: 201.33236ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:36:59.051247Z","caller":"traceutil/trace.go:171","msg":"trace[344631775] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:322; }","duration":"274.60387ms","start":"2026-10-14T17:36:58.776618Z","end":"2026-10-14T17:36:59.051222Z","steps":["trace[344631775] 'agreement among raft nodes before linearized reading' (duration: 274.414686ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:37:34.031802Z","caller":"traceutil/trace.go:171","msg":"trace[554534187] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"315.558959ms","start":"2026-10-14T17:37:33.716216Z","end":"2026-10-14T17:37:34.031775Z","steps":["trace[554534187] 'process raft request' (duration: 315.421316ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:37:34.031969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:37:33.716184Z","time spent":"315.710103ms","remote":"127.0.0.1:38074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T17:37:34.038999Z","caller":"traceutil/trace.go:171","msg":"trace[1517017068] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"322.370087ms","start":"2026-10-14T17:37:33.716599Z","end":"2026-10-14T17:37:34.038969Z","steps":["trace[1517017068] 'process raft request' (duration: 322.247484ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:37:34.039132Z","caller":"traceutil/trace.go:171","msg":"trace[1281248825] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"321.283492ms","start":"2026-10-14T17:37:33.717829Z","end":"2026-10-14T17:37:34.039113Z","steps":["trace[1281248825] 'process raft request' (duration: 321.083017ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:37:34.039154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:37:33.716586Z","time spent":"322.49417ms","remote":"127.0.0.1:38074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T17:37:34.039239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:37:33.717795Z","time spent":"321.402805ms","remote":"127.0.0.1:38074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T17:37:34.039272Z","caller":"traceutil/trace.go:171","msg":"trace[283345365] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"308.377472ms","start":"2026-10-14T17:37:33.730824Z","end":"2026-10-14T17:37:34.039202Z","steps":["trace[283345365] 'process raft request' (duration: 308.207348ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:37:34.039344Z","caller":"traceutil/trace.go:171","msg":"trace[844190578] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"296.60678ms","start":"2026-10-14T17:37:33.742724Z","end":"2026-10-14T17:37:34.039331Z","steps":["trace[844190578] 'process raft request' (duration: 296.387425ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:37:34.039374Z","caller":"traceutil/trace.go:171","msg":"trace[560547901] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"255.686261ms","start":"2026-10-14T17:37:33.783663Z","end":"2026-10-14T17:37:34.03935Z","steps":["trace[560547901] 'process raft request' (duration: 255.485156ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:37:34.039312Z","caller":"traceutil/trace.go:171","msg":"trace[1791104311] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"304.198275ms","start":"2026-10-14T17:37:33.735093Z","end":"2026-10-14T17:37:34.039291Z","steps":["trace[1791104311] 'process raft request' (duration: 303.97951ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:37:34.039474Z","caller":"traceutil/trace.go:171","msg":"trace[1568857436] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"251.79031ms","start":"2026-10-14T17:37:33.787675Z","end":"2026-10-14T17:37:34.039466Z","steps":["trace[1568857436] 'process raft request' (duration: 251.516674ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:37:34.039461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:37:33.735083Z","time spent":"304.347119ms","remote":"127.0.0.1:38074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T17:37:34.039474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:37:33.730813Z","time spent":"308.569917ms","remote":"127.0.0.1:38074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T17:37:34.03944Z","caller":"traceutil/trace.go:171","msg":"trace[898095398] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"311.28062ms","start":"2026-10-14T17:37:33.728079Z","end":"2026-10-14T17:37:34.039359Z","steps":["trace[898095398] 'process raft request' (duration: 310.896891ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:37:34.039656Z","caller":"traceutil/trace.go:171","msg":"trace[475511236] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"247.50776ms","start":"2026-10-14T17:37:33.792138Z","end":"2026-10-14T17:37:34.039646Z","steps":["trace[475511236] 'process raft request' (duration: 247.241014ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:37:34.03972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:37:33.728056Z","time spent":"311.540216ms","remote":"127.0.0.1:38074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T17:37:34.03981Z","caller":"traceutil/trace.go:171","msg":"trace[612466697] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"225.999032ms","start":"2026-10-14T17:37:33.813798Z","end":"2026-10-14T17:37:34.039797Z","steps":["trace[612466697] 'process raft request' (duration: 225.703885ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:37:34.039861Z","caller":"traceutil/trace.go:171","msg":"trace[1131609667] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"126.593517ms","start":"2026-10-14T17:37:33.913251Z","end":"2026-10-14T17:37:34.039844Z","steps":["trace[1131609667] 'process raft request' (duration: 126.465314ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:37:40.217796Z","caller":"traceutil/trace.go:171","msg":"trace[654637174] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"163.549538ms","start":"2026-10-14T17:37:40.054209Z","end":"2026-10-14T17:37:40.217759Z","steps":["trace[654637174] 'process raft request' (duration: 162.972432ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:37:40.82502Z","caller":"traceutil/trace.go:171","msg":"trace[65173012] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:669; }","duration":"351.935729ms","start":"2026-10-14T17:37:40.473049Z","end":"2026-10-14T17:37:40.824985Z","steps":["trace[65173012] 'read index received' (duration: 351.669842ms)","trace[65173012] 'applied index is now lower than readState.Index' (duration: 264.667µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:37:40.8251Z","caller":"traceutil/trace.go:171","msg":"trace[1917664454] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"535.341491ms","start":"2026-10-14T17:37:40.289733Z","end":"2026-10-14T17:37:40.825075Z","steps":["trace[1917664454] 'process raft request' (duration: 535.055563ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:37:40.825253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:37:40.289704Z","time spent":"535.457593ms","remote":"127.0.0.1:38402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T17:37:40.825401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.342871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tl4cn\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-14T17:37:40.825453Z","caller":"traceutil/trace.go:171","msg":"trace[158465821] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tl4cn; range_end:; response_count:1; response_revision:646; }","duration":"352.452153ms","start":"2026-10-14T17:37:40.472988Z","end":"2026-10-14T17:37:40.82544Z","steps":["trace[158465821] 'agreement among raft nodes before linearized reading' (duration: 352.134385ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:37:40.825485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:37:40.47296Z","time spent":"352.517175ms","remote":"127.0.0.1:38216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-tl4cn\" "} {"level":"info","ts":"2026-10-14T17:37:54.30773Z","caller":"traceutil/trace.go:171","msg":"trace[372771859] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"104.343038ms","start":"2026-10-14T17:37:54.203359Z","end":"2026-10-14T17:37:54.307702Z","steps":["trace[372771859] 'process raft request' (duration: 104.176134ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:37:57.077279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.021602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T17:37:57.077427Z","caller":"traceutil/trace.go:171","msg":"trace[682389939] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:815; }","duration":"150.175556ms","start":"2026-10-14T17:37:56.927212Z","end":"2026-10-14T17:37:57.077388Z","steps":["trace[682389939] 'range keys from in-memory index tree' (duration: 149.922718ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:38:46.861306Z","caller":"traceutil/trace.go:171","msg":"trace[1370215366] transaction","detail":"{read_only:false; response_revision:1463; number_of_response:1; }","duration":"144.635846ms","start":"2026-10-14T17:38:46.71662Z","end":"2026-10-14T17:38:46.861256Z","steps":["trace[1370215366] 'process raft request' (duration: 91.765645ms)","trace[1370215366] 'compare' (duration: 52.629776ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T17:38:49.047208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.176045ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T17:38:49.047339Z","caller":"traceutil/trace.go:171","msg":"trace[1012869943] transaction","detail":"{read_only:false; response_revision:1474; number_of_response:1; }","duration":"178.835153ms","start":"2026-10-14T17:38:48.86848Z","end":"2026-10-14T17:38:49.047315Z","steps":["trace[1012869943] 'process raft request' (duration: 49.245728ms)","trace[1012869943] 'compare' (duration: 128.898069ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:39:15.375823Z","caller":"traceutil/trace.go:171","msg":"trace[1165958089] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"399.21868ms","start":"2026-10-14T17:39:14.976567Z","end":"2026-10-14T17:39:15.375785Z","steps":["trace[1165958089] 'process raft request' (duration: 398.936913ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:39:15.376082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:39:14.976546Z","time spent":"399.403945ms","remote":"127.0.0.1:38216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T17:39:15.379139Z","caller":"traceutil/trace.go:171","msg":"trace[1648601615] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"174.888724ms","start":"2026-10-14T17:39:15.204226Z","end":"2026-10-14T17:39:15.379114Z","steps":["trace[1648601615] 'process raft request' (duration: 174.829542ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:39:15.379296Z","caller":"traceutil/trace.go:171","msg":"trace[246972766] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"222.402553ms","start":"2026-10-14T17:39:15.15686Z","end":"2026-10-14T17:39:15.379262Z","steps":["trace[246972766] 'process raft request' (duration: 221.958403ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:40:09.806092Z","caller":"traceutil/trace.go:171","msg":"trace[809605127] transaction","detail":"{read_only:false; response_revision:2234; number_of_response:1; }","duration":"170.502299ms","start":"2026-10-14T17:40:09.635563Z","end":"2026-10-14T17:40:09.806065Z","steps":["trace[809605127] 'process raft request' (duration: 170.366896ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:40:10.126564Z","caller":"traceutil/trace.go:171","msg":"trace[1918613860] transaction","detail":"{read_only:false; response_revision:2235; number_of_response:1; }","duration":"484.505432ms","start":"2026-10-14T17:40:09.642024Z","end":"2026-10-14T17:40:10.12653Z","steps":["trace[1918613860] 'process raft request' (duration: 425.939025ms)","trace[1918613860] 'compare' (duration: 58.196668ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T17:40:10.12678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:40:09.641997Z","time spent":"484.666436ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T17:40:10.12689Z","caller":"traceutil/trace.go:171","msg":"trace[2099071654] linearizableReadLoop","detail":"{readStateIndex:2318; appliedIndex:2316; }","duration":"476.490399ms","start":"2026-10-14T17:40:09.650324Z","end":"2026-10-14T17:40:10.126814Z","steps":["trace[2099071654] 'read index received' (duration: 155.707111ms)","trace[2099071654] 'applied index is now lower than readState.Index' (duration: 320.782348ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:40:10.12691Z","caller":"traceutil/trace.go:171","msg":"trace[585929771] transaction","detail":"{read_only:false; response_revision:2237; number_of_response:1; }","duration":"401.758255ms","start":"2026-10-14T17:40:09.725098Z","end":"2026-10-14T17:40:10.126857Z","steps":["trace[585929771] 'process raft request' (duration: 401.617062ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:40:10.127108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:40:09.725087Z","time spent":"401.921458ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T17:40:10.127404Z","caller":"traceutil/trace.go:171","msg":"trace[1143789484] transaction","detail":"{read_only:false; response_revision:2236; number_of_response:1; }","duration":"421.188248ms","start":"2026-10-14T17:40:09.706154Z","end":"2026-10-14T17:40:10.127342Z","steps":["trace[1143789484] 'process raft request' (duration: 420.293338ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:40:10.127588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:40:09.706126Z","time spent":"421.365242ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T17:40:10.127079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.738694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T17:40:10.127729Z","caller":"traceutil/trace.go:171","msg":"trace[902301752] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2237; }","duration":"477.400359ms","start":"2026-10-14T17:40:09.650308Z","end":"2026-10-14T17:40:10.127708Z","steps":["trace[902301752] 'agreement among raft nodes before linearized reading' (duration: 476.603901ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:40:10.127783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:40:09.650241Z","time spent":"477.520633ms","remote":"127.0.0.1:38342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":31,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-10-14T17:40:10.129204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.70305ms","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-14T17:40:10.12927Z","caller":"traceutil/trace.go:171","msg":"trace[1319905057] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2237; }","duration":"247.797272ms","start":"2026-10-14T17:40:09.881453Z","end":"2026-10-14T17:40:10.129251Z","steps":["trace[1319905057] 'agreement among raft nodes before linearized reading' (duration: 247.624569ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:40:10.129287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.074822ms","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-14T17:40:10.129353Z","caller":"traceutil/trace.go:171","msg":"trace[1494393602] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2237; }","duration":"203.161644ms","start":"2026-10-14T17:40:09.926173Z","end":"2026-10-14T17:40:10.129335Z","steps":["trace[1494393602] 'agreement among raft nodes before linearized reading' (duration: 202.98175ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:40:10.129444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.481959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-10-14T17:40:10.129508Z","caller":"traceutil/trace.go:171","msg":"trace[1020345794] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2237; }","duration":"238.592762ms","start":"2026-10-14T17:40:09.890899Z","end":"2026-10-14T17:40:10.129492Z","steps":["trace[1020345794] 'agreement among raft nodes before linearized reading' (duration: 238.396388ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:41:17.866527Z","caller":"traceutil/trace.go:171","msg":"trace[1276893808] transaction","detail":"{read_only:false; response_revision:2800; number_of_response:1; }","duration":"105.970993ms","start":"2026-10-14T17:41:17.760527Z","end":"2026-10-14T17:41:17.866498Z","steps":["trace[1276893808] 'process raft request' (duration: 105.490742ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:41:18.511267Z","caller":"traceutil/trace.go:171","msg":"trace[1471344373] transaction","detail":"{read_only:false; response_revision:2803; number_of_response:1; }","duration":"116.724067ms","start":"2026-10-14T17:41:18.394508Z","end":"2026-10-14T17:41:18.511232Z","steps":["trace[1471344373] 'process raft request' (duration: 115.600842ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:43:52.549793Z","caller":"traceutil/trace.go:171","msg":"trace[14524227] transaction","detail":"{read_only:false; response_revision:3771; number_of_response:1; }","duration":"107.842858ms","start":"2026-10-14T17:43:52.441926Z","end":"2026-10-14T17:43:52.549769Z","steps":["trace[14524227] 'process raft request' (duration: 97.511037ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:43:52.552045Z","caller":"traceutil/trace.go:171","msg":"trace[792294172] transaction","detail":"{read_only:false; response_revision:3772; number_of_response:1; }","duration":"108.693938ms","start":"2026-10-14T17:43:52.443276Z","end":"2026-10-14T17:43:52.55197Z","steps":["trace[792294172] 'process raft request' (duration: 108.455442ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:43:52.552079Z","caller":"traceutil/trace.go:171","msg":"trace[813039163] transaction","detail":"{read_only:false; response_revision:3773; number_of_response:1; }","duration":"108.107864ms","start":"2026-10-14T17:43:52.443941Z","end":"2026-10-14T17:43:52.552049Z","steps":["trace[813039163] 'process raft request' (duration: 107.912369ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:43:52.552028Z","caller":"traceutil/trace.go:171","msg":"trace[1059852298] linearizableReadLoop","detail":"{readStateIndex:3916; appliedIndex:3913; }","duration":"105.390131ms","start":"2026-10-14T17:43:52.446617Z","end":"2026-10-14T17:43:52.552008Z","steps":["trace[1059852298] 'read index received' (duration: 92.878589ms)","trace[1059852298] 'applied index is now lower than readState.Index' (duration: 12.510062ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:43:52.552225Z","caller":"traceutil/trace.go:171","msg":"trace[1183196290] transaction","detail":"{read_only:false; response_revision:3774; number_of_response:1; }","duration":"104.486199ms","start":"2026-10-14T17:43:52.447713Z","end":"2026-10-14T17:43:52.552199Z","steps":["trace[1183196290] 'process raft request' (duration: 104.202932ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:43:52.552332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.666317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/secretgen-controller/secretgen-controller-5cf976ccc7-728b6\" ","response":"range_response_count:1 size:2097"} {"level":"info","ts":"2026-10-14T17:43:52.552411Z","caller":"traceutil/trace.go:171","msg":"trace[1544184338] range","detail":"{range_begin:/registry/pods/secretgen-controller/secretgen-controller-5cf976ccc7-728b6; range_end:; response_count:1; response_revision:3774; }","duration":"105.77852ms","start":"2026-10-14T17:43:52.446612Z","end":"2026-10-14T17:43:52.552391Z","steps":["trace[1544184338] 'agreement among raft nodes before linearized reading' (duration: 105.476632ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:44:25.761136Z","caller":"traceutil/trace.go:171","msg":"trace[1073071795] transaction","detail":"{read_only:false; response_revision:3997; number_of_response:1; }","duration":"117.894058ms","start":"2026-10-14T17:44:25.643216Z","end":"2026-10-14T17:44:25.76111Z","steps":["trace[1073071795] 'process raft request' (duration: 117.754745ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:44:25.76212Z","caller":"traceutil/trace.go:171","msg":"trace[1713531887] transaction","detail":"{read_only:false; response_revision:3998; number_of_response:1; }","duration":"118.211925ms","start":"2026-10-14T17:44:25.643884Z","end":"2026-10-14T17:44:25.762096Z","steps":["trace[1713531887] 'process raft request' (duration: 118.041661ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:44:25.762378Z","caller":"traceutil/trace.go:171","msg":"trace[937260965] transaction","detail":"{read_only:false; response_revision:3999; number_of_response:1; }","duration":"118.41737ms","start":"2026-10-14T17:44:25.643938Z","end":"2026-10-14T17:44:25.762355Z","steps":["trace[937260965] 'process raft request' (duration: 118.115013ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:44:25.762389Z","caller":"traceutil/trace.go:171","msg":"trace[2046744217] linearizableReadLoop","detail":"{readStateIndex:4149; appliedIndex:4146; }","duration":"118.38177ms","start":"2026-10-14T17:44:25.643987Z","end":"2026-10-14T17:44:25.762369Z","steps":["trace[2046744217] 'read index received' (duration: 117.004528ms)","trace[2046744217] 'applied index is now lower than readState.Index' (duration: 1.376172ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:44:25.762522Z","caller":"traceutil/trace.go:171","msg":"trace[2062052766] transaction","detail":"{read_only:false; response_revision:4000; number_of_response:1; }","duration":"118.535723ms","start":"2026-10-14T17:44:25.643977Z","end":"2026-10-14T17:44:25.762513Z","steps":["trace[2062052766] 'process raft request' (duration: 118.263927ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:44:25.762654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.639046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:62914"} {"level":"info","ts":"2026-10-14T17:44:25.762713Z","caller":"traceutil/trace.go:171","msg":"trace[1504093463] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:4000; }","duration":"118.738007ms","start":"2026-10-14T17:44:25.64396Z","end":"2026-10-14T17:44:25.762698Z","steps":["trace[1504093463] 'agreement among raft nodes before linearized reading' (duration: 118.503082ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:45:54.339413Z","caller":"traceutil/trace.go:171","msg":"trace[1598913896] transaction","detail":"{read_only:false; response_revision:5086; number_of_response:1; }","duration":"107.997867ms","start":"2026-10-14T17:45:54.23137Z","end":"2026-10-14T17:45:54.339367Z","steps":["trace[1598913896] 'process raft request' (duration: 89.546005ms)","trace[1598913896] 'compare' (duration: 18.139414ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:45:54.387596Z","caller":"traceutil/trace.go:171","msg":"trace[1206412189] linearizableReadLoop","detail":"{readStateIndex:5280; appliedIndex:5278; }","duration":"153.87973ms","start":"2026-10-14T17:45:54.233697Z","end":"2026-10-14T17:45:54.387576Z","steps":["trace[1206412189] 'read index received' (duration: 87.253682ms)","trace[1206412189] 'applied index is now lower than readState.Index' (duration: 66.625108ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T17:45:54.387788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.075094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-14T17:45:54.387747Z","caller":"traceutil/trace.go:171","msg":"trace[16773054] transaction","detail":"{read_only:false; response_revision:5087; number_of_response:1; }","duration":"154.75267ms","start":"2026-10-14T17:45:54.232943Z","end":"2026-10-14T17:45:54.387696Z","steps":["trace[16773054] 'process raft request' (duration: 154.511564ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:45:54.387881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.76289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-10-14T17:45:54.387907Z","caller":"traceutil/trace.go:171","msg":"trace[1664954819] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5087; }","duration":"142.798791ms","start":"2026-10-14T17:45:54.245099Z","end":"2026-10-14T17:45:54.387897Z","steps":["trace[1664954819] 'agreement among raft nodes before linearized reading' (duration: 142.733089ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:45:54.387901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.774467ms","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-14T17:45:54.387975Z","caller":"traceutil/trace.go:171","msg":"trace[1687697509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5087; }","duration":"153.89517ms","start":"2026-10-14T17:45:54.234062Z","end":"2026-10-14T17:45:54.387957Z","steps":["trace[1687697509] 'agreement among raft nodes before linearized reading' (duration: 153.673955ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:45:54.387975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.137325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hfggw\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-10-14T17:45:54.388032Z","caller":"traceutil/trace.go:171","msg":"trace[828776302] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hfggw; range_end:; response_count:1; response_revision:5087; }","duration":"139.221716ms","start":"2026-10-14T17:45:54.248798Z","end":"2026-10-14T17:45:54.38802Z","steps":["trace[828776302] 'agreement among raft nodes before linearized reading' (duration: 139.019752ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:45:54.388183Z","caller":"traceutil/trace.go:171","msg":"trace[466796499] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5087; }","duration":"154.507894ms","start":"2026-10-14T17:45:54.23367Z","end":"2026-10-14T17:45:54.388178Z","steps":["trace[466796499] 'agreement among raft nodes before linearized reading' (duration: 154.009282ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:45:54.389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.162562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:50 size:2210296"} {"level":"info","ts":"2026-10-14T17:45:54.38907Z","caller":"traceutil/trace.go:171","msg":"trace[1210468779] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:50; response_revision:5087; }","duration":"141.277385ms","start":"2026-10-14T17:45:54.247777Z","end":"2026-10-14T17:45:54.389054Z","steps":["trace[1210468779] 'agreement among raft nodes before linearized reading' (duration: 140.007735ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:45:55.61584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.492023ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-14T17:45:55.615984Z","caller":"traceutil/trace.go:171","msg":"trace[1515509944] transaction","detail":"{read_only:false; response_revision:5139; number_of_response:1; }","duration":"180.760868ms","start":"2026-10-14T17:45:55.435199Z","end":"2026-10-14T17:45:55.61596Z","steps":["trace[1515509944] 'process raft request' (duration: 29.06952ms)","trace[1515509944] 'compare' (duration: 151.32417ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:45:55.616407Z","caller":"traceutil/trace.go:171","msg":"trace[941865078] transaction","detail":"{read_only:false; response_revision:5141; number_of_response:1; }","duration":"177.702267ms","start":"2026-10-14T17:45:55.438677Z","end":"2026-10-14T17:45:55.61638Z","steps":["trace[941865078] 'process raft request' (duration: 177.653656ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:45:55.61644Z","caller":"traceutil/trace.go:171","msg":"trace[1147741194] transaction","detail":"{read_only:false; response_revision:5140; number_of_response:1; }","duration":"180.572414ms","start":"2026-10-14T17:45:55.435832Z","end":"2026-10-14T17:45:55.616405Z","steps":["trace[1147741194] 'process raft request' (duration: 180.346248ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:45:55.622267Z","caller":"traceutil/trace.go:171","msg":"trace[1150685716] transaction","detail":"{read_only:false; response_revision:5142; number_of_response:1; }","duration":"105.310853ms","start":"2026-10-14T17:45:55.516917Z","end":"2026-10-14T17:45:55.622228Z","steps":["trace[1150685716] 'process raft request' (duration: 105.101478ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:45:58.561751Z","caller":"traceutil/trace.go:171","msg":"trace[1207025329] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5221; }","duration":"199.990168ms","start":"2026-10-14T17:45:58.361731Z","end":"2026-10-14T17:45:58.561722Z","steps":["trace[1207025329] 'process raft request' (duration: 199.870405ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:45:58.588794Z","caller":"traceutil/trace.go:171","msg":"trace[2107896729] linearizableReadLoop","detail":"{readStateIndex:5420; appliedIndex:5419; }","duration":"173.108238ms","start":"2026-10-14T17:45:58.415649Z","end":"2026-10-14T17:45:58.588757Z","steps":["trace[2107896729] 'read index received' (duration: 146.161019ms)","trace[2107896729] 'applied index is now lower than readState.Index' (duration: 26.945459ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:45:58.588927Z","caller":"traceutil/trace.go:171","msg":"trace[1334163746] transaction","detail":"{read_only:false; response_revision:5222; number_of_response:1; }","duration":"225.535925ms","start":"2026-10-14T17:45:58.363349Z","end":"2026-10-14T17:45:58.588885Z","steps":["trace[1334163746] 'process raft request' (duration: 225.133046ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:45:58.58915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.446947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-14T17:45:58.589202Z","caller":"traceutil/trace.go:171","msg":"trace[2034685065] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5222; }","duration":"173.59035ms","start":"2026-10-14T17:45:58.415593Z","end":"2026-10-14T17:45:58.589184Z","steps":["trace[2034685065] 'agreement among raft nodes before linearized reading' (duration: 173.340764ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:45:58.58919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.647863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-14T17:45:58.589432Z","caller":"traceutil/trace.go:171","msg":"trace[2077070676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5222; }","duration":"153.95886ms","start":"2026-10-14T17:45:58.435459Z","end":"2026-10-14T17:45:58.589418Z","steps":["trace[2077070676] 'agreement among raft nodes before linearized reading' (duration: 153.555211ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:45:58.589672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.67228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-10-14T17:45:58.589681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.208416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hfggw\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-10-14T17:45:58.589768Z","caller":"traceutil/trace.go:171","msg":"trace[1441198934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5222; }","duration":"149.856294ms","start":"2026-10-14T17:45:58.439889Z","end":"2026-10-14T17:45:58.589746Z","steps":["trace[1441198934] 'agreement among raft nodes before linearized reading' (duration: 149.547447ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:45:58.589793Z","caller":"traceutil/trace.go:171","msg":"trace[222585042] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hfggw; range_end:; response_count:1; response_revision:5222; }","duration":"148.35933ms","start":"2026-10-14T17:45:58.441405Z","end":"2026-10-14T17:45:58.589765Z","steps":["trace[222585042] 'agreement among raft nodes before linearized reading' (duration: 147.759016ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:46:00.301928Z","caller":"traceutil/trace.go:171","msg":"trace[961800833] transaction","detail":"{read_only:false; response_revision:5252; number_of_response:1; }","duration":"155.290332ms","start":"2026-10-14T17:46:00.146609Z","end":"2026-10-14T17:46:00.3019Z","steps":["trace[961800833] 'process raft request' (duration: 155.048037ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:46:00.301914Z","caller":"traceutil/trace.go:171","msg":"trace[112914812] linearizableReadLoop","detail":"{readStateIndex:5451; appliedIndex:5450; }","duration":"151.916304ms","start":"2026-10-14T17:46:00.149962Z","end":"2026-10-14T17:46:00.301878Z","steps":["trace[112914812] 'read index received' (duration: 151.562976ms)","trace[112914812] 'applied index is now lower than readState.Index' (duration: 351.758µs)"],"step_count":2} {"level":"warn","ts":"2026-10-14T17:46:00.302246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.267642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-14T17:46:00.302359Z","caller":"traceutil/trace.go:171","msg":"trace[404705680] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5252; }","duration":"152.417985ms","start":"2026-10-14T17:46:00.149899Z","end":"2026-10-14T17:46:00.302317Z","steps":["trace[404705680] 'agreement among raft nodes before linearized reading' (duration: 152.092628ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:46:13.321227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.841447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-hpc5c\" ","response":"range_response_count:1 size:7818"} {"level":"warn","ts":"2026-10-14T17:46:13.321259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.840685ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T17:46:13.321331Z","caller":"traceutil/trace.go:171","msg":"trace[1730084417] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-hpc5c; range_end:; response_count:1; response_revision:5479; }","duration":"121.003421ms","start":"2026-10-14T17:46:13.200307Z","end":"2026-10-14T17:46:13.321311Z","steps":["trace[1730084417] 'range keys from in-memory index tree' (duration: 120.660803ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:46:13.32137Z","caller":"traceutil/trace.go:171","msg":"trace[2087267295] transaction","detail":"{read_only:false; response_revision:5480; number_of_response:1; }","duration":"118.621915ms","start":"2026-10-14T17:46:13.202725Z","end":"2026-10-14T17:46:13.321347Z","steps":["trace[2087267295] 'process raft request' (duration: 15.601095ms)","trace[2087267295] 'compare' (duration: 102.704312ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:46:13.458485Z","caller":"traceutil/trace.go:171","msg":"trace[683618790] transaction","detail":"{read_only:false; response_revision:5482; number_of_response:1; }","duration":"125.6963ms","start":"2026-10-14T17:46:13.332769Z","end":"2026-10-14T17:46:13.458465Z","steps":["trace[683618790] 'process raft request' (duration: 93.517087ms)","trace[683618790] 'compare' (duration: 32.093771ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T17:46:21.084125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.26511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T17:46:21.08423Z","caller":"traceutil/trace.go:171","msg":"trace[105757604] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5614; }","duration":"157.427994ms","start":"2026-10-14T17:46:20.926782Z","end":"2026-10-14T17:46:21.08421Z","steps":["trace[105757604] 'range keys from in-memory index tree' (duration: 157.171398ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:46:23.567018Z","caller":"traceutil/trace.go:171","msg":"trace[1993543712] linearizableReadLoop","detail":"{readStateIndex:5834; appliedIndex:5833; }","duration":"178.434305ms","start":"2026-10-14T17:46:23.388559Z","end":"2026-10-14T17:46:23.566993Z","steps":["trace[1993543712] 'read index received' (duration: 178.19706ms)","trace[1993543712] 'applied index is now lower than readState.Index' (duration: 236.305µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:46:23.567147Z","caller":"traceutil/trace.go:171","msg":"trace[189705645] transaction","detail":"{read_only:false; response_revision:5627; number_of_response:1; }","duration":"182.009309ms","start":"2026-10-14T17:46:23.3851Z","end":"2026-10-14T17:46:23.56711Z","steps":["trace[189705645] 'process raft request' (duration: 181.743493ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:46:23.567262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.690101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-14T17:46:23.567339Z","caller":"traceutil/trace.go:171","msg":"trace[40034848] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5627; }","duration":"178.785673ms","start":"2026-10-14T17:46:23.388542Z","end":"2026-10-14T17:46:23.567328Z","steps":["trace[40034848] 'agreement among raft nodes before linearized reading' (duration: 178.546208ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:46:23.731484Z","caller":"traceutil/trace.go:171","msg":"trace[374346152] transaction","detail":"{read_only:false; response_revision:5628; number_of_response:1; }","duration":"163.945665ms","start":"2026-10-14T17:46:23.56752Z","end":"2026-10-14T17:46:23.731465Z","steps":["trace[374346152] 'process raft request' (duration: 163.829852ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:46:23.734385Z","caller":"traceutil/trace.go:171","msg":"trace[86842339] transaction","detail":"{read_only:false; response_revision:5629; number_of_response:1; }","duration":"162.577424ms","start":"2026-10-14T17:46:23.57178Z","end":"2026-10-14T17:46:23.734358Z","steps":["trace[86842339] 'process raft request' (duration: 162.40732ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:46:51.123825Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2988} {"level":"info","ts":"2026-10-14T17:46:51.211578Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2988,"took":"86.122916ms","hash":3384829180,"current-db-size-bytes":57212928,"current-db-size":"57 MB","current-db-size-in-use-bytes":32202752,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-14T17:46:51.211678Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3384829180,"revision":2988,"compact-revision":-1} {"level":"info","ts":"2026-10-14T17:51:51.132275Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5925} {"level":"info","ts":"2026-10-14T17:51:51.233053Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5925,"took":"97.637608ms","hash":3235257214,"current-db-size-bytes":57212928,"current-db-size":"57 MB","current-db-size-in-use-bytes":25923584,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-14T17:51:51.233152Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3235257214,"revision":5925,"compact-revision":2988} {"level":"info","ts":"2026-10-14T17:52:45.936982Z","caller":"traceutil/trace.go:171","msg":"trace[1307005482] transaction","detail":"{read_only:false; response_revision:8579; number_of_response:1; }","duration":"154.090412ms","start":"2026-10-14T17:52:45.782868Z","end":"2026-10-14T17:52:45.936958Z","steps":["trace[1307005482] 'process raft request' (duration: 153.925208ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:52:57.169434Z","caller":"traceutil/trace.go:171","msg":"trace[1281189566] linearizableReadLoop","detail":"{readStateIndex:8943; appliedIndex:8942; }","duration":"243.375348ms","start":"2026-10-14T17:52:56.926035Z","end":"2026-10-14T17:52:57.16941Z","steps":["trace[1281189566] 'read index received' (duration: 243.191694ms)","trace[1281189566] 'applied index is now lower than readState.Index' (duration: 182.644µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:52:57.169575Z","caller":"traceutil/trace.go:171","msg":"trace[1025440445] transaction","detail":"{read_only:false; response_revision:8636; number_of_response:1; }","duration":"287.34801ms","start":"2026-10-14T17:52:56.882168Z","end":"2026-10-14T17:52:57.169516Z","steps":["trace[1025440445] 'process raft request' (duration: 287.066814ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:52:57.169611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.546262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T17:52:57.169807Z","caller":"traceutil/trace.go:171","msg":"trace[19011722] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8636; }","duration":"243.770528ms","start":"2026-10-14T17:52:56.926011Z","end":"2026-10-14T17:52:57.169781Z","steps":["trace[19011722] 'agreement among raft nodes before linearized reading' (duration: 243.510661ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:52:57.182301Z","caller":"traceutil/trace.go:171","msg":"trace[203998436] transaction","detail":"{read_only:false; response_revision:8637; number_of_response:1; }","duration":"118.617958ms","start":"2026-10-14T17:52:57.063666Z","end":"2026-10-14T17:52:57.182283Z","steps":["trace[203998436] 'process raft request' (duration: 118.532346ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:52:58.764672Z","caller":"traceutil/trace.go:171","msg":"trace[1352776158] transaction","detail":"{read_only:false; response_revision:8645; number_of_response:1; }","duration":"174.60852ms","start":"2026-10-14T17:52:58.590037Z","end":"2026-10-14T17:52:58.764646Z","steps":["trace[1352776158] 'process raft request' (duration: 168.716973ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:53:27.776573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.327117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-14T17:53:27.776686Z","caller":"traceutil/trace.go:171","msg":"trace[1120300561] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8852; }","duration":"403.469541ms","start":"2026-10-14T17:53:27.373196Z","end":"2026-10-14T17:53:27.776665Z","steps":["trace[1120300561] 'range keys from in-memory index tree' (duration: 403.097982ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:53:27.776731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:53:27.373128Z","time spent":"403.591473ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-10-14T17:53:27.847166Z","caller":"traceutil/trace.go:171","msg":"trace[1769046190] transaction","detail":"{read_only:false; response_revision:8853; number_of_response:1; }","duration":"454.332404ms","start":"2026-10-14T17:53:27.392796Z","end":"2026-10-14T17:53:27.847129Z","steps":["trace[1769046190] 'process raft request' (duration: 454.120309ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:53:27.847221Z","caller":"traceutil/trace.go:171","msg":"trace[135626805] linearizableReadLoop","detail":"{readStateIndex:9168; appliedIndex:9168; }","duration":"420.069797ms","start":"2026-10-14T17:53:27.427117Z","end":"2026-10-14T17:53:27.847187Z","steps":["trace[135626805] 'read index received' (duration: 420.047126ms)","trace[135626805] 'applied index is now lower than readState.Index' (duration: 17.371µs)"],"step_count":2} {"level":"warn","ts":"2026-10-14T17:53:27.847405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:53:27.392751Z","time spent":"454.519168ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T17:53:27.847567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.437655ms","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-14T17:53:27.847615Z","caller":"traceutil/trace.go:171","msg":"trace[1700570870] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8853; }","duration":"420.558998ms","start":"2026-10-14T17:53:27.427043Z","end":"2026-10-14T17:53:27.847602Z","steps":["trace[1700570870] 'agreement among raft nodes before linearized reading' (duration: 420.288971ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:53:27.847655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:53:27.427009Z","time spent":"420.63726ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-14T17:53:27.95317Z","caller":"traceutil/trace.go:171","msg":"trace[184762226] linearizableReadLoop","detail":"{readStateIndex:9169; appliedIndex:9168; }","duration":"105.84029ms","start":"2026-10-14T17:53:27.847301Z","end":"2026-10-14T17:53:27.953141Z","steps":["trace[184762226] 'read index received' (duration: 54.417294ms)","trace[184762226] 'applied index is now lower than readState.Index' (duration: 51.421516ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:53:27.953502Z","caller":"traceutil/trace.go:171","msg":"trace[536180490] transaction","detail":"{read_only:false; response_revision:8854; number_of_response:1; }","duration":"171.922277ms","start":"2026-10-14T17:53:27.781553Z","end":"2026-10-14T17:53:27.953475Z","steps":["trace[536180490] 'process raft request' (duration: 120.00074ms)","trace[536180490] 'compare' (duration: 51.456756ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T17:53:27.953575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.98175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-14T17:53:27.953618Z","caller":"traceutil/trace.go:171","msg":"trace[1482772227] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8854; }","duration":"520.066571ms","start":"2026-10-14T17:53:27.433541Z","end":"2026-10-14T17:53:27.953608Z","steps":["trace[1482772227] 'agreement among raft nodes before linearized reading' (duration: 519.905177ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:53:27.953647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:53:27.433531Z","time spent":"520.108393ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-14T17:53:27.953723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.225237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hfggw\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-10-14T17:53:27.953855Z","caller":"traceutil/trace.go:171","msg":"trace[764946783] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hfggw; range_end:; response_count:1; response_revision:8854; }","duration":"465.453612ms","start":"2026-10-14T17:53:27.48837Z","end":"2026-10-14T17:53:27.953824Z","steps":["trace[764946783] 'agreement among raft nodes before linearized reading' (duration: 465.028082ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:53:27.953917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:53:27.488329Z","time spent":"465.578515ms","remote":"127.0.0.1:38216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6555,"request content":"key:\"/registry/pods/openstack/keepalived-hfggw\" "} {"level":"info","ts":"2026-10-14T17:53:27.965097Z","caller":"traceutil/trace.go:171","msg":"trace[834107210] transaction","detail":"{read_only:false; response_revision:8855; number_of_response:1; }","duration":"107.317325ms","start":"2026-10-14T17:53:27.857757Z","end":"2026-10-14T17:53:27.965074Z","steps":["trace[834107210] 'process raft request' (duration: 107.046088ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:53:29.547911Z","caller":"traceutil/trace.go:171","msg":"trace[1631798290] transaction","detail":"{read_only:false; response_revision:8862; number_of_response:1; }","duration":"173.888613ms","start":"2026-10-14T17:53:29.373991Z","end":"2026-10-14T17:53:29.54788Z","steps":["trace[1631798290] 'process raft request' (duration: 118.913324ms)","trace[1631798290] 'compare' (duration: 54.757954ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:53:30.085846Z","caller":"traceutil/trace.go:171","msg":"trace[1376342025] transaction","detail":"{read_only:false; response_revision:8863; number_of_response:1; }","duration":"228.885972ms","start":"2026-10-14T17:53:29.856935Z","end":"2026-10-14T17:53:30.085821Z","steps":["trace[1376342025] 'process raft request' (duration: 228.697037ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:53:30.108954Z","caller":"traceutil/trace.go:171","msg":"trace[284187176] linearizableReadLoop","detail":"{readStateIndex:9180; appliedIndex:9178; }","duration":"182.870342ms","start":"2026-10-14T17:53:29.926064Z","end":"2026-10-14T17:53:30.108935Z","steps":["trace[284187176] 'read index received' (duration: 159.661962ms)","trace[284187176] 'applied index is now lower than readState.Index' (duration: 23.20708ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T17:53:30.109124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.044875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-14T17:53:30.109166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.633162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-14T17:53:30.109207Z","caller":"traceutil/trace.go:171","msg":"trace[532137712] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8863; }","duration":"150.709284ms","start":"2026-10-14T17:53:29.958485Z","end":"2026-10-14T17:53:30.109194Z","steps":["trace[532137712] 'agreement among raft nodes before linearized reading' (duration: 150.566081ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:53:30.109202Z","caller":"traceutil/trace.go:171","msg":"trace[1846732616] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8863; }","duration":"183.182779ms","start":"2026-10-14T17:53:29.926001Z","end":"2026-10-14T17:53:30.109184Z","steps":["trace[1846732616] 'agreement among raft nodes before linearized reading' (duration: 183.038545ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:53:30.109211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.313863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hfggw\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-10-14T17:53:30.109503Z","caller":"traceutil/trace.go:171","msg":"trace[342438787] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hfggw; range_end:; response_count:1; response_revision:8863; }","duration":"125.619821ms","start":"2026-10-14T17:53:29.983865Z","end":"2026-10-14T17:53:30.109485Z","steps":["trace[342438787] 'agreement among raft nodes before linearized reading' (duration: 125.202131ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:53:30.109247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.221915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-14T17:53:30.109611Z","caller":"traceutil/trace.go:171","msg":"trace[1478420521] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8863; }","duration":"129.600813ms","start":"2026-10-14T17:53:29.979993Z","end":"2026-10-14T17:53:30.109594Z","steps":["trace[1478420521] 'agreement among raft nodes before linearized reading' (duration: 129.098081ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:53:30.109579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.386594ms","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-14T17:53:30.109753Z","caller":"traceutil/trace.go:171","msg":"trace[1364795131] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8863; }","duration":"140.628849ms","start":"2026-10-14T17:53:29.969105Z","end":"2026-10-14T17:53:30.109734Z","steps":["trace[1364795131] 'agreement among raft nodes before linearized reading' (duration: 140.117378ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:53:38.276245Z","caller":"traceutil/trace.go:171","msg":"trace[1502412743] linearizableReadLoop","detail":"{readStateIndex:9227; appliedIndex:9226; }","duration":"122.711253ms","start":"2026-10-14T17:53:38.153511Z","end":"2026-10-14T17:53:38.276222Z","steps":["trace[1502412743] 'read index received' (duration: 122.492348ms)","trace[1502412743] 'applied index is now lower than readState.Index' (duration: 217.875µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:53:38.276339Z","caller":"traceutil/trace.go:171","msg":"trace[562867672] transaction","detail":"{read_only:false; response_revision:8909; number_of_response:1; }","duration":"154.689616ms","start":"2026-10-14T17:53:38.121603Z","end":"2026-10-14T17:53:38.276293Z","steps":["trace[562867672] 'process raft request' (duration: 154.463141ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:53:38.276455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.903727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T17:53:38.276552Z","caller":"traceutil/trace.go:171","msg":"trace[838990725] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:8909; }","duration":"123.087792ms","start":"2026-10-14T17:53:38.153443Z","end":"2026-10-14T17:53:38.276531Z","steps":["trace[838990725] 'agreement among raft nodes before linearized reading' (duration: 122.911237ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:53:38.27658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.353987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-14T17:53:38.276611Z","caller":"traceutil/trace.go:171","msg":"trace[162752363] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8909; }","duration":"104.434878ms","start":"2026-10-14T17:53:38.172166Z","end":"2026-10-14T17:53:38.276601Z","steps":["trace[162752363] 'agreement among raft nodes before linearized reading' (duration: 104.352376ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:53:38.276495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.078119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-10-14T17:53:38.276774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.777466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-10-14T17:53:38.276791Z","caller":"traceutil/trace.go:171","msg":"trace[695073812] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8909; }","duration":"116.444237ms","start":"2026-10-14T17:53:38.160332Z","end":"2026-10-14T17:53:38.276776Z","steps":["trace[695073812] 'agreement among raft nodes before linearized reading' (duration: 116.036048ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:53:38.276804Z","caller":"traceutil/trace.go:171","msg":"trace[8798647] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8909; }","duration":"107.822047ms","start":"2026-10-14T17:53:38.16897Z","end":"2026-10-14T17:53:38.276792Z","steps":["trace[8798647] 'agreement among raft nodes before linearized reading' (duration: 107.751855ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:53:38.276756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.085704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hfggw\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-10-14T17:53:38.276866Z","caller":"traceutil/trace.go:171","msg":"trace[1657196014] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hfggw; range_end:; response_count:1; response_revision:8909; }","duration":"105.240967ms","start":"2026-10-14T17:53:38.171599Z","end":"2026-10-14T17:53:38.27684Z","steps":["trace[1657196014] 'agreement among raft nodes before linearized reading' (duration: 104.93622ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:53:41.03333Z","caller":"traceutil/trace.go:171","msg":"trace[237632409] linearizableReadLoop","detail":"{readStateIndex:9252; appliedIndex:9251; }","duration":"267.223883ms","start":"2026-10-14T17:53:40.766083Z","end":"2026-10-14T17:53:41.033307Z","steps":["trace[237632409] 'read index received' (duration: 266.929296ms)","trace[237632409] 'applied index is now lower than readState.Index' (duration: 293.877µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:53:41.033667Z","caller":"traceutil/trace.go:171","msg":"trace[2135153242] transaction","detail":"{read_only:false; response_revision:8933; number_of_response:1; }","duration":"267.97323ms","start":"2026-10-14T17:53:40.765678Z","end":"2026-10-14T17:53:41.033651Z","steps":["trace[2135153242] 'process raft request' (duration: 267.477768ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:53:41.034001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.906628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-jbg9p\" ","response":"range_response_count:1 size:2802"} {"level":"info","ts":"2026-10-14T17:53:41.034063Z","caller":"traceutil/trace.go:171","msg":"trace[1639965168] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-jbg9p; range_end:; response_count:1; response_revision:8933; }","duration":"267.998851ms","start":"2026-10-14T17:53:40.766034Z","end":"2026-10-14T17:53:41.034033Z","steps":["trace[1639965168] 'agreement among raft nodes before linearized reading' (duration: 267.827847ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:53:41.034277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.770387ms","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-14T17:53:41.034312Z","caller":"traceutil/trace.go:171","msg":"trace[1576098909] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8933; }","duration":"126.864499ms","start":"2026-10-14T17:53:40.907439Z","end":"2026-10-14T17:53:41.034304Z","steps":["trace[1576098909] 'agreement among raft nodes before linearized reading' (duration: 126.770557ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:53:41.034594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.825197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T17:53:41.034631Z","caller":"traceutil/trace.go:171","msg":"trace[1173185175] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8933; }","duration":"107.93283ms","start":"2026-10-14T17:53:40.92669Z","end":"2026-10-14T17:53:41.034623Z","steps":["trace[1173185175] 'agreement among raft nodes before linearized reading' (duration: 107.855908ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:53:42.419367Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002439.wal"} {"level":"info","ts":"2026-10-14T17:54:47.657693Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d232699cb6c87299","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-14T17:54:47.665036Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-14T17:54:47.665109Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-14T17:56:51.15534Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8091} {"level":"info","ts":"2026-10-14T17:56:51.226649Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8091,"took":"69.18073ms","hash":2405153640,"current-db-size-bytes":57212928,"current-db-size":"57 MB","current-db-size-in-use-bytes":28733440,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-14T17:56:51.226722Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2405153640,"revision":8091,"compact-revision":5925} {"level":"warn","ts":"2026-10-14T17:58:52.480084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.022712ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T17:58:52.480342Z","caller":"traceutil/trace.go:171","msg":"trace[659323918] transaction","detail":"{read_only:false; response_revision:11624; number_of_response:1; }","duration":"317.503806ms","start":"2026-10-14T17:58:52.162795Z","end":"2026-10-14T17:58:52.480298Z","steps":["trace[659323918] 'process raft request' (duration: 101.140896ms)","trace[659323918] 'compare' (duration: 215.866878ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:58:52.480384Z","caller":"traceutil/trace.go:171","msg":"trace[2011638584] linearizableReadLoop","detail":"{readStateIndex:12026; appliedIndex:12024; }","duration":"256.858524ms","start":"2026-10-14T17:58:52.223474Z","end":"2026-10-14T17:58:52.480333Z","steps":["trace[2011638584] 'read index received' (duration: 40.361621ms)","trace[2011638584] 'applied index is now lower than readState.Index' (duration: 216.495283ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:58:52.480455Z","caller":"traceutil/trace.go:171","msg":"trace[941506723] transaction","detail":"{read_only:false; response_revision:11625; number_of_response:1; }","duration":"317.164848ms","start":"2026-10-14T17:58:52.163241Z","end":"2026-10-14T17:58:52.480406Z","steps":["trace[941506723] 'process raft request' (duration: 317.001764ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T17:58:52.480504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:58:52.162772Z","time spent":"317.644919ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":538,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T17:58:52.480573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.058188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-14T17:58:52.480651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T17:58:52.163228Z","time spent":"317.319342ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T17:58:52.480705Z","caller":"traceutil/trace.go:171","msg":"trace[1168308620] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:11625; }","duration":"257.221182ms","start":"2026-10-14T17:58:52.223459Z","end":"2026-10-14T17:58:52.480681Z","steps":["trace[1168308620] 'agreement among raft nodes before linearized reading' (duration: 256.967516ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:58:54.316649Z","caller":"traceutil/trace.go:171","msg":"trace[1603134115] transaction","detail":"{read_only:false; response_revision:11634; number_of_response:1; }","duration":"103.704316ms","start":"2026-10-14T17:58:54.212918Z","end":"2026-10-14T17:58:54.316623Z","steps":["trace[1603134115] 'process raft request' (duration: 45.606782ms)","trace[1603134115] 'compare' (duration: 57.799987ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T17:58:54.594549Z","caller":"traceutil/trace.go:171","msg":"trace[2114306882] transaction","detail":"{read_only:false; response_revision:11635; number_of_response:1; }","duration":"104.371372ms","start":"2026-10-14T17:58:54.490139Z","end":"2026-10-14T17:58:54.59451Z","steps":["trace[2114306882] 'process raft request' (duration: 104.074895ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T17:58:54.605962Z","caller":"traceutil/trace.go:171","msg":"trace[800631865] transaction","detail":"{read_only:false; response_revision:11636; number_of_response:1; }","duration":"115.667635ms","start":"2026-10-14T17:58:54.490265Z","end":"2026-10-14T17:58:54.605932Z","steps":["trace[800631865] 'process raft request' (duration: 115.261145ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:01:51.168579Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10526} {"level":"info","ts":"2026-10-14T18:01:51.263669Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10526,"took":"92.558462ms","hash":2124839405,"current-db-size-bytes":57212928,"current-db-size":"57 MB","current-db-size-in-use-bytes":27713536,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-14T18:01:51.263738Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2124839405,"revision":10526,"compact-revision":8091} {"level":"warn","ts":"2026-10-14T18:04:39.102213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.918365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T18:04:39.102316Z","caller":"traceutil/trace.go:171","msg":"trace[1316040506] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:14000; }","duration":"141.078079ms","start":"2026-10-14T18:04:38.961226Z","end":"2026-10-14T18:04:39.102304Z","steps":["trace[1316040506] 'count revisions from in-memory index tree' (duration: 140.860495ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:05:02.55078Z","caller":"traceutil/trace.go:171","msg":"trace[1493967625] linearizableReadLoop","detail":"{readStateIndex:14628; appliedIndex:14627; }","duration":"367.697415ms","start":"2026-10-14T18:05:02.183062Z","end":"2026-10-14T18:05:02.55076Z","steps":["trace[1493967625] 'read index received' (duration: 367.50816ms)","trace[1493967625] 'applied index is now lower than readState.Index' (duration: 188.375µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T18:05:02.551044Z","caller":"traceutil/trace.go:171","msg":"trace[1224100120] transaction","detail":"{read_only:false; response_revision:14140; number_of_response:1; }","duration":"447.291374ms","start":"2026-10-14T18:05:02.103741Z","end":"2026-10-14T18:05:02.551032Z","steps":["trace[1224100120] 'process raft request' (duration: 446.883784ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:05:02.551146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:05:02.103724Z","time spent":"447.351695ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T18:05:02.551383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.32757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-14T18:05:02.551419Z","caller":"traceutil/trace.go:171","msg":"trace[2005947712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14140; }","duration":"368.402512ms","start":"2026-10-14T18:05:02.183007Z","end":"2026-10-14T18:05:02.551409Z","steps":["trace[2005947712] 'agreement among raft nodes before linearized reading' (duration: 368.293359ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:05:02.551444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:05:02.182988Z","time spent":"368.449482ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-14T18:05:02.551593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.608198ms","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:5"} {"level":"info","ts":"2026-10-14T18:05:02.551626Z","caller":"traceutil/trace.go:171","msg":"trace[1134624028] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:14140; }","duration":"214.644198ms","start":"2026-10-14T18:05:02.336972Z","end":"2026-10-14T18:05:02.551617Z","steps":["trace[1134624028] 'agreement among raft nodes before linearized reading' (duration: 214.589947ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:05:02.552173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.222707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-10-14T18:05:02.552252Z","caller":"traceutil/trace.go:171","msg":"trace[1101309372] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14140; }","duration":"168.34255ms","start":"2026-10-14T18:05:02.383889Z","end":"2026-10-14T18:05:02.552231Z","steps":["trace[1101309372] 'agreement among raft nodes before linearized reading' (duration: 167.91921ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:05:18.959606Z","caller":"traceutil/trace.go:171","msg":"trace[703634881] transaction","detail":"{read_only:false; response_revision:14258; number_of_response:1; }","duration":"162.579146ms","start":"2026-10-14T18:05:18.796996Z","end":"2026-10-14T18:05:18.959575Z","steps":["trace[703634881] 'process raft request' (duration: 162.357281ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:05:19.08087Z","caller":"traceutil/trace.go:171","msg":"trace[1786746115] transaction","detail":"{read_only:false; response_revision:14259; number_of_response:1; }","duration":"116.727297ms","start":"2026-10-14T18:05:18.964111Z","end":"2026-10-14T18:05:19.080838Z","steps":["trace[1786746115] 'process raft request' (duration: 89.116039ms)","trace[1786746115] 'compare' (duration: 27.445034ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T18:05:19.346051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.747997ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T18:05:19.346161Z","caller":"traceutil/trace.go:171","msg":"trace[168797535] transaction","detail":"{read_only:false; response_revision:14260; number_of_response:1; }","duration":"216.652565ms","start":"2026-10-14T18:05:19.129487Z","end":"2026-10-14T18:05:19.34614Z","steps":["trace[168797535] 'process raft request' (duration: 70.734064ms)","trace[168797535] 'compare' (duration: 145.191194ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T18:05:20.272527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.973096ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-14T18:05:20.272989Z","caller":"traceutil/trace.go:171","msg":"trace[2022948928] linearizableReadLoop","detail":"{readStateIndex:14756; appliedIndex:14755; }","duration":"347.214971ms","start":"2026-10-14T18:05:19.925744Z","end":"2026-10-14T18:05:20.272959Z","steps":["trace[2022948928] 'read index received' (duration: 216.01976ms)","trace[2022948928] 'applied index is now lower than readState.Index' (duration: 131.191091ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T18:05:20.273297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.525989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hfggw\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-10-14T18:05:20.273408Z","caller":"traceutil/trace.go:171","msg":"trace[2036014257] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hfggw; range_end:; response_count:1; response_revision:14262; }","duration":"347.711803ms","start":"2026-10-14T18:05:19.925674Z","end":"2026-10-14T18:05:20.273386Z","steps":["trace[2036014257] 'agreement among raft nodes before linearized reading' (duration: 347.424626ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:05:20.273468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:05:19.925648Z","time spent":"347.805555ms","remote":"127.0.0.1:38216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6555,"request content":"key:\"/registry/pods/openstack/keepalived-hfggw\" "} {"level":"info","ts":"2026-10-14T18:05:20.273645Z","caller":"traceutil/trace.go:171","msg":"trace[513832697] transaction","detail":"{read_only:false; response_revision:14263; number_of_response:1; }","duration":"163.995028ms","start":"2026-10-14T18:05:20.109628Z","end":"2026-10-14T18:05:20.273623Z","steps":["trace[513832697] 'process raft request' (duration: 163.412145ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:05:20.273731Z","caller":"traceutil/trace.go:171","msg":"trace[1588211063] transaction","detail":"{read_only:false; response_revision:14264; number_of_response:1; }","duration":"160.682162ms","start":"2026-10-14T18:05:20.112989Z","end":"2026-10-14T18:05:20.273671Z","steps":["trace[1588211063] 'process raft request' (duration: 160.340474ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:05:20.273779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.427303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T18:05:20.273845Z","caller":"traceutil/trace.go:171","msg":"trace[637525411] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:14264; }","duration":"272.542346ms","start":"2026-10-14T18:05:20.001286Z","end":"2026-10-14T18:05:20.273828Z","steps":["trace[637525411] 'agreement among raft nodes before linearized reading' (duration: 272.433123ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:05:20.27369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.904816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-14T18:05:20.273966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.506213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-10-14T18:05:20.273993Z","caller":"traceutil/trace.go:171","msg":"trace[354303751] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:14264; }","duration":"138.257694ms","start":"2026-10-14T18:05:20.135716Z","end":"2026-10-14T18:05:20.273974Z","steps":["trace[354303751] 'agreement among raft nodes before linearized reading' (duration: 137.798594ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:05:20.27402Z","caller":"traceutil/trace.go:171","msg":"trace[1719078466] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:14264; }","duration":"297.611046ms","start":"2026-10-14T18:05:19.97639Z","end":"2026-10-14T18:05:20.274002Z","steps":["trace[1719078466] 'agreement among raft nodes before linearized reading' (duration: 297.35396ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:05:20.27418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.516598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T18:05:20.274315Z","caller":"traceutil/trace.go:171","msg":"trace[5241561] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14264; }","duration":"348.233155ms","start":"2026-10-14T18:05:19.926067Z","end":"2026-10-14T18:05:20.2743Z","steps":["trace[5241561] 'agreement among raft nodes before linearized reading' (duration: 347.431376ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:05:20.274407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:05:19.926059Z","time spent":"348.334767ms","remote":"127.0.0.1:38052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-14T18:05:21.639781Z","caller":"traceutil/trace.go:171","msg":"trace[1210415743] transaction","detail":"{read_only:false; response_revision:14276; number_of_response:1; }","duration":"224.792833ms","start":"2026-10-14T18:05:21.414928Z","end":"2026-10-14T18:05:21.639721Z","steps":["trace[1210415743] 'process raft request' (duration: 224.546068ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:05:43.108568Z","caller":"traceutil/trace.go:171","msg":"trace[64305221] transaction","detail":"{read_only:false; response_revision:14572; number_of_response:1; }","duration":"323.025121ms","start":"2026-10-14T18:05:42.785517Z","end":"2026-10-14T18:05:43.108542Z","steps":["trace[64305221] 'process raft request' (duration: 322.862357ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:05:43.108749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:05:42.785485Z","time spent":"323.160324ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T18:05:43.289289Z","caller":"traceutil/trace.go:171","msg":"trace[122111131] transaction","detail":"{read_only:false; response_revision:14573; number_of_response:1; }","duration":"502.886667ms","start":"2026-10-14T18:05:42.786375Z","end":"2026-10-14T18:05:43.289262Z","steps":["trace[122111131] 'process raft request' (duration: 410.091902ms)","trace[122111131] 'compare' (duration: 92.598911ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T18:05:43.289468Z","caller":"traceutil/trace.go:171","msg":"trace[1383863646] linearizableReadLoop","detail":"{readStateIndex:15081; appliedIndex:15078; }","duration":"499.323874ms","start":"2026-10-14T18:05:42.79012Z","end":"2026-10-14T18:05:43.289444Z","steps":["trace[1383863646] 'read index received' (duration: 318.24239ms)","trace[1383863646] 'applied index is now lower than readState.Index' (duration: 181.080234ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T18:05:43.289504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:05:42.786356Z","time spent":"503.02433ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T18:05:43.289563Z","caller":"traceutil/trace.go:171","msg":"trace[1428530647] transaction","detail":"{read_only:false; response_revision:14574; number_of_response:1; }","duration":"501.426313ms","start":"2026-10-14T18:05:42.788109Z","end":"2026-10-14T18:05:43.289535Z","steps":["trace[1428530647] 'process raft request' (duration: 501.104516ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:05:43.28968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:05:42.788088Z","time spent":"501.531945ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T18:05:43.289735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.58501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-14T18:05:43.289793Z","caller":"traceutil/trace.go:171","msg":"trace[783109770] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14574; }","duration":"499.696533ms","start":"2026-10-14T18:05:42.790077Z","end":"2026-10-14T18:05:43.289774Z","steps":["trace[783109770] 'agreement among raft nodes before linearized reading' (duration: 499.478718ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:05:43.289787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.550487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-10-14T18:05:43.289835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:05:42.79006Z","time spent":"499.766054ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-10-14T18:05:43.289849Z","caller":"traceutil/trace.go:171","msg":"trace[1638178979] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14574; }","duration":"495.660899ms","start":"2026-10-14T18:05:42.794173Z","end":"2026-10-14T18:05:43.289834Z","steps":["trace[1638178979] 'agreement among raft nodes before linearized reading' (duration: 495.425834ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:05:43.289897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:05:42.794155Z","time spent":"495.72799ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-14T18:05:43.289892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.109725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d8e9019b-846c-42be-bcad-5272ad517754\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-10-14T18:05:43.289981Z","caller":"traceutil/trace.go:171","msg":"trace[626247891] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d8e9019b-846c-42be-bcad-5272ad517754; range_end:; response_count:1; response_revision:14574; }","duration":"448.216807ms","start":"2026-10-14T18:05:42.841744Z","end":"2026-10-14T18:05:43.289961Z","steps":["trace[626247891] 'agreement among raft nodes before linearized reading' (duration: 447.90606ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:05:43.290029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:05:42.841667Z","time spent":"448.352801ms","remote":"127.0.0.1:38216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3661,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d8e9019b-846c-42be-bcad-5272ad517754\" "} {"level":"info","ts":"2026-10-14T18:05:43.428885Z","caller":"traceutil/trace.go:171","msg":"trace[398649201] transaction","detail":"{read_only:false; response_revision:14576; number_of_response:1; }","duration":"133.815987ms","start":"2026-10-14T18:05:43.295037Z","end":"2026-10-14T18:05:43.428853Z","steps":["trace[398649201] 'process raft request' (duration: 124.038311ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:05:43.429141Z","caller":"traceutil/trace.go:171","msg":"trace[213040945] transaction","detail":"{read_only:false; response_revision:14577; number_of_response:1; }","duration":"131.589555ms","start":"2026-10-14T18:05:43.297512Z","end":"2026-10-14T18:05:43.429102Z","steps":["trace[213040945] 'process raft request' (duration: 131.269728ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:06:35.689078Z","caller":"traceutil/trace.go:171","msg":"trace[817520478] transaction","detail":"{read_only:false; response_revision:15213; number_of_response:1; }","duration":"107.771802ms","start":"2026-10-14T18:06:35.581276Z","end":"2026-10-14T18:06:35.689048Z","steps":["trace[817520478] 'process raft request' (duration: 107.534567ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:06:35.689098Z","caller":"traceutil/trace.go:171","msg":"trace[391940555] transaction","detail":"{read_only:false; response_revision:15214; number_of_response:1; }","duration":"107.64736ms","start":"2026-10-14T18:06:35.581419Z","end":"2026-10-14T18:06:35.689066Z","steps":["trace[391940555] 'process raft request' (duration: 107.532637ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:06:51.174909Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12803} {"level":"info","ts":"2026-10-14T18:06:51.265683Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12803,"took":"87.798909ms","hash":1347413092,"current-db-size-bytes":57212928,"current-db-size":"57 MB","current-db-size-in-use-bytes":31109120,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-14T18:06:51.265783Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1347413092,"revision":12803,"compact-revision":10526} {"level":"info","ts":"2026-10-14T18:07:09.730166Z","caller":"traceutil/trace.go:171","msg":"trace[601580766] transaction","detail":"{read_only:false; response_revision:15392; number_of_response:1; }","duration":"175.642648ms","start":"2026-10-14T18:07:09.554496Z","end":"2026-10-14T18:07:09.730139Z","steps":["trace[601580766] 'process raft request' (duration: 175.488585ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:11:51.183013Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15297} {"level":"info","ts":"2026-10-14T18:11:51.292262Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15297,"took":"105.85036ms","hash":495240068,"current-db-size-bytes":57212928,"current-db-size":"57 MB","current-db-size-in-use-bytes":32288768,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-14T18:11:51.292327Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":495240068,"revision":15297,"compact-revision":12803} {"level":"warn","ts":"2026-10-14T18:12:51.030896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.520392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T18:12:51.030982Z","caller":"traceutil/trace.go:171","msg":"trace[2132633584] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17934; }","duration":"105.653875ms","start":"2026-10-14T18:12:50.925311Z","end":"2026-10-14T18:12:51.030965Z","steps":["trace[2132633584] 'range keys from in-memory index tree' (duration: 105.43333ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:12:57.91817Z","caller":"traceutil/trace.go:171","msg":"trace[1256577928] linearizableReadLoop","detail":"{readStateIndex:18594; appliedIndex:18593; }","duration":"169.652598ms","start":"2026-10-14T18:12:57.748495Z","end":"2026-10-14T18:12:57.918147Z","steps":["trace[1256577928] 'read index received' (duration: 169.480064ms)","trace[1256577928] 'applied index is now lower than readState.Index' (duration: 171.694µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T18:12:57.918289Z","caller":"traceutil/trace.go:171","msg":"trace[1938701343] transaction","detail":"{read_only:false; response_revision:17977; number_of_response:1; }","duration":"213.448792ms","start":"2026-10-14T18:12:57.70482Z","end":"2026-10-14T18:12:57.918268Z","steps":["trace[1938701343] 'process raft request' (duration: 213.169136ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:12:57.918511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.450644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-14T18:12:57.918528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.682087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-10-14T18:12:57.918543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.026708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-14T18:12:57.918593Z","caller":"traceutil/trace.go:171","msg":"trace[666335752] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17977; }","duration":"169.620888ms","start":"2026-10-14T18:12:57.748954Z","end":"2026-10-14T18:12:57.918575Z","steps":["trace[666335752] 'agreement among raft nodes before linearized reading' (duration: 169.358051ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:12:57.918612Z","caller":"traceutil/trace.go:171","msg":"trace[545711841] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17977; }","duration":"170.148231ms","start":"2026-10-14T18:12:57.748448Z","end":"2026-10-14T18:12:57.918596Z","steps":["trace[545711841] 'agreement among raft nodes before linearized reading' (duration: 169.819173ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:12:57.918619Z","caller":"traceutil/trace.go:171","msg":"trace[1189524923] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17977; }","duration":"103.80989ms","start":"2026-10-14T18:12:57.814774Z","end":"2026-10-14T18:12:57.918584Z","steps":["trace[1189524923] 'agreement among raft nodes before linearized reading' (duration: 103.614265ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:12:57.918611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.700872ms","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-14T18:12:57.918697Z","caller":"traceutil/trace.go:171","msg":"trace[1294160323] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:17977; }","duration":"132.879686ms","start":"2026-10-14T18:12:57.785798Z","end":"2026-10-14T18:12:57.918677Z","steps":["trace[1294160323] 'agreement among raft nodes before linearized reading' (duration: 132.6083ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:12:58.495925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.961562ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-14T18:12:58.496212Z","caller":"traceutil/trace.go:171","msg":"trace[775205243] transaction","detail":"{read_only:false; response_revision:17979; number_of_response:1; }","duration":"572.355826ms","start":"2026-10-14T18:12:57.923835Z","end":"2026-10-14T18:12:58.496191Z","steps":["trace[775205243] 'process raft request' (duration: 572.209132ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:12:58.496201Z","caller":"traceutil/trace.go:171","msg":"trace[1295431983] transaction","detail":"{read_only:false; response_revision:17978; number_of_response:1; }","duration":"572.540541ms","start":"2026-10-14T18:12:57.923623Z","end":"2026-10-14T18:12:58.496164Z","steps":["trace[1295431983] 'process raft request' (duration: 97.141319ms)","trace[1295431983] 'compare' (duration: 474.725646ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T18:12:58.496315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:12:57.923719Z","time spent":"572.544811ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T18:12:58.496326Z","caller":"traceutil/trace.go:171","msg":"trace[1941192118] linearizableReadLoop","detail":"{readStateIndex:18598; appliedIndex:18594; }","duration":"571.398943ms","start":"2026-10-14T18:12:57.924914Z","end":"2026-10-14T18:12:58.496313Z","steps":["trace[1941192118] 'read index received' (duration: 95.866167ms)","trace[1941192118] 'applied index is now lower than readState.Index' (duration: 475.531846ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T18:12:58.496377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:12:57.923606Z","time spent":"572.675744ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T18:12:58.496388Z","caller":"traceutil/trace.go:171","msg":"trace[1557182977] transaction","detail":"{read_only:false; response_revision:17980; number_of_response:1; }","duration":"572.452659ms","start":"2026-10-14T18:12:57.92391Z","end":"2026-10-14T18:12:58.496363Z","steps":["trace[1557182977] 'process raft request' (duration: 572.237624ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:12:58.496413Z","caller":"traceutil/trace.go:171","msg":"trace[2097695171] transaction","detail":"{read_only:false; response_revision:17981; number_of_response:1; }","duration":"571.527526ms","start":"2026-10-14T18:12:57.924848Z","end":"2026-10-14T18:12:58.496376Z","steps":["trace[2097695171] 'process raft request' (duration: 571.407184ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:12:58.496504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.584397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"warn","ts":"2026-10-14T18:12:58.496511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:12:57.923791Z","time spent":"572.652863ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T18:12:58.496541Z","caller":"traceutil/trace.go:171","msg":"trace[11292671] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:17981; }","duration":"571.649519ms","start":"2026-10-14T18:12:57.924881Z","end":"2026-10-14T18:12:58.496531Z","steps":["trace[11292671] 'agreement among raft nodes before linearized reading' (duration: 571.514286ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:12:58.496566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:12:57.924829Z","time spent":"571.659699ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T18:12:58.496577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:12:57.924867Z","time spent":"571.70106ms","remote":"127.0.0.1:38216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12241,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-10-14T18:12:58.592535Z","caller":"traceutil/trace.go:171","msg":"trace[2034549743] transaction","detail":"{read_only:false; response_revision:17982; number_of_response:1; }","duration":"517.140656ms","start":"2026-10-14T18:12:58.075373Z","end":"2026-10-14T18:12:58.592513Z","steps":["trace[2034549743] 'process raft request' (duration: 516.957301ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:12:58.592668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:12:58.075349Z","time spent":"517.250869ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T18:12:58.592752Z","caller":"traceutil/trace.go:171","msg":"trace[2019681104] transaction","detail":"{read_only:false; response_revision:17983; number_of_response:1; }","duration":"516.867169ms","start":"2026-10-14T18:12:58.075836Z","end":"2026-10-14T18:12:58.592704Z","steps":["trace[2019681104] 'process raft request' (duration: 516.633123ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:12:58.592822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.109782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-14T18:12:58.592896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.645897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-14T18:12:58.592933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:12:58.07581Z","time spent":"517.055484ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T18:12:58.592959Z","caller":"traceutil/trace.go:171","msg":"trace[917672760] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:17983; }","duration":"580.7571ms","start":"2026-10-14T18:12:58.012187Z","end":"2026-10-14T18:12:58.592944Z","steps":["trace[917672760] 'agreement among raft nodes before linearized reading' (duration: 580.528284ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:12:58.592994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:12:58.012164Z","time spent":"580.821962ms","remote":"127.0.0.1:38166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":30,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"info","ts":"2026-10-14T18:12:58.592904Z","caller":"traceutil/trace.go:171","msg":"trace[1285865490] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17983; }","duration":"666.225686ms","start":"2026-10-14T18:12:57.92666Z","end":"2026-10-14T18:12:58.592886Z","steps":["trace[1285865490] 'agreement among raft nodes before linearized reading' (duration: 666.084472ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:12:58.593046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:12:57.926621Z","time spent":"666.40606ms","remote":"127.0.0.1:38052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-14T18:12:58.593933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.878718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:95 size:953802"} {"level":"info","ts":"2026-10-14T18:12:58.594004Z","caller":"traceutil/trace.go:171","msg":"trace[215334950] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:95; response_revision:17983; }","duration":"665.971409ms","start":"2026-10-14T18:12:57.928015Z","end":"2026-10-14T18:12:58.593986Z","steps":["trace[215334950] 'agreement among raft nodes before linearized reading' (duration: 664.75974ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:12:58.594053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:12:57.928005Z","time spent":"666.031111ms","remote":"127.0.0.1:38216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":95,"response size":953826,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-10-14T18:15:31.287639Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d232699cb6c87299","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-14T18:15:31.295875Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-14T18:15:31.296027Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-14T18:16:51.198124Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17521} {"level":"info","ts":"2026-10-14T18:16:51.30431Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17521,"took":"102.813813ms","hash":415623453,"current-db-size-bytes":57212928,"current-db-size":"57 MB","current-db-size-in-use-bytes":33984512,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-14T18:16:51.304403Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":415623453,"revision":17521,"compact-revision":15297} {"level":"warn","ts":"2026-10-14T18:18:27.533336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.274767ms","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-14T18:18:27.533484Z","caller":"traceutil/trace.go:171","msg":"trace[434713019] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20571; }","duration":"174.482602ms","start":"2026-10-14T18:18:27.358973Z","end":"2026-10-14T18:18:27.533456Z","steps":["trace[434713019] 'range keys from in-memory index tree' (duration: 173.98895ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:18:43.801056Z","caller":"traceutil/trace.go:171","msg":"trace[76025039] linearizableReadLoop","detail":"{readStateIndex:21356; appliedIndex:21355; }","duration":"155.479441ms","start":"2026-10-14T18:18:43.645553Z","end":"2026-10-14T18:18:43.801032Z","steps":["trace[76025039] 'read index received' (duration: 155.279007ms)","trace[76025039] 'applied index is now lower than readState.Index' (duration: 199.564µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T18:18:43.801199Z","caller":"traceutil/trace.go:171","msg":"trace[1334994905] transaction","detail":"{read_only:false; response_revision:20651; number_of_response:1; }","duration":"297.06469ms","start":"2026-10-14T18:18:43.504026Z","end":"2026-10-14T18:18:43.801091Z","steps":["trace[1334994905] 'process raft request' (duration: 296.861675ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:18:43.801321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.737147ms","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-14T18:18:43.801409Z","caller":"traceutil/trace.go:171","msg":"trace[570287112] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20651; }","duration":"155.87875ms","start":"2026-10-14T18:18:43.645508Z","end":"2026-10-14T18:18:43.801387Z","steps":["trace[570287112] 'agreement among raft nodes before linearized reading' (duration: 155.621664ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:18:43.929586Z","caller":"traceutil/trace.go:171","msg":"trace[1554407268] transaction","detail":"{read_only:false; response_revision:20652; number_of_response:1; }","duration":"123.613913ms","start":"2026-10-14T18:18:43.805948Z","end":"2026-10-14T18:18:43.929562Z","steps":["trace[1554407268] 'process raft request' (duration: 114.525033ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:18:43.929847Z","caller":"traceutil/trace.go:171","msg":"trace[373861153] transaction","detail":"{read_only:false; response_revision:20653; number_of_response:1; }","duration":"123.86262ms","start":"2026-10-14T18:18:43.80597Z","end":"2026-10-14T18:18:43.929833Z","steps":["trace[373861153] 'process raft request' (duration: 123.553153ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:18:44.095051Z","caller":"traceutil/trace.go:171","msg":"trace[1957393633] transaction","detail":"{read_only:false; response_revision:20654; number_of_response:1; }","duration":"120.43991ms","start":"2026-10-14T18:18:43.97458Z","end":"2026-10-14T18:18:44.09502Z","steps":["trace[1957393633] 'process raft request' (duration: 101.836039ms)","trace[1957393633] 'compare' (duration: 18.455118ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T18:18:44.168103Z","caller":"traceutil/trace.go:171","msg":"trace[361545833] linearizableReadLoop","detail":"{readStateIndex:21360; appliedIndex:21358; }","duration":"143.644517ms","start":"2026-10-14T18:18:44.024435Z","end":"2026-10-14T18:18:44.16808Z","steps":["trace[361545833] 'read index received' (duration: 51.985324ms)","trace[361545833] 'applied index is now lower than readState.Index' (duration: 91.658083ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T18:18:44.168192Z","caller":"traceutil/trace.go:171","msg":"trace[870284973] transaction","detail":"{read_only:false; response_revision:20655; number_of_response:1; }","duration":"182.18672ms","start":"2026-10-14T18:18:43.985984Z","end":"2026-10-14T18:18:44.168171Z","steps":["trace[870284973] 'process raft request' (duration: 181.977065ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:18:44.168239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.785891ms","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-14T18:18:44.168265Z","caller":"traceutil/trace.go:171","msg":"trace[124118323] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:20655; }","duration":"143.870292ms","start":"2026-10-14T18:18:44.024385Z","end":"2026-10-14T18:18:44.168256Z","steps":["trace[124118323] 'agreement among raft nodes before linearized reading' (duration: 143.800361ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:18:44.441868Z","caller":"traceutil/trace.go:171","msg":"trace[1892106758] linearizableReadLoop","detail":"{readStateIndex:21361; appliedIndex:21360; }","duration":"123.965651ms","start":"2026-10-14T18:18:44.317866Z","end":"2026-10-14T18:18:44.441832Z","steps":["trace[1892106758] 'read index received' (duration: 123.649364ms)","trace[1892106758] 'applied index is now lower than readState.Index' (duration: 314.877µs)"],"step_count":2} {"level":"warn","ts":"2026-10-14T18:18:44.442066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.169816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T18:18:44.442141Z","caller":"traceutil/trace.go:171","msg":"trace[235138232] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:20656; }","duration":"124.294199ms","start":"2026-10-14T18:18:44.317831Z","end":"2026-10-14T18:18:44.442125Z","steps":["trace[235138232] 'agreement among raft nodes before linearized reading' (duration: 124.144106ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:18:44.442673Z","caller":"traceutil/trace.go:171","msg":"trace[1139047024] transaction","detail":"{read_only:false; response_revision:20656; number_of_response:1; }","duration":"158.038061ms","start":"2026-10-14T18:18:44.283881Z","end":"2026-10-14T18:18:44.441919Z","steps":["trace[1139047024] 'process raft request' (duration: 157.743634ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:18:44.652056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.45654ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T18:18:44.652289Z","caller":"traceutil/trace.go:171","msg":"trace[530497732] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:20656; }","duration":"120.736136ms","start":"2026-10-14T18:18:44.53153Z","end":"2026-10-14T18:18:44.652266Z","steps":["trace[530497732] 'range keys from in-memory index tree' (duration: 120.43816ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:18:44.747555Z","caller":"traceutil/trace.go:171","msg":"trace[1758715195] transaction","detail":"{read_only:false; response_revision:20657; number_of_response:1; }","duration":"299.732813ms","start":"2026-10-14T18:18:44.447787Z","end":"2026-10-14T18:18:44.74752Z","steps":["trace[1758715195] 'process raft request' (duration: 299.355154ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:18:44.888508Z","caller":"traceutil/trace.go:171","msg":"trace[108793862] linearizableReadLoop","detail":"{readStateIndex:21365; appliedIndex:21361; }","duration":"248.987657ms","start":"2026-10-14T18:18:44.639497Z","end":"2026-10-14T18:18:44.888484Z","steps":["trace[108793862] 'read index received' (duration: 107.675374ms)","trace[108793862] 'applied index is now lower than readState.Index' (duration: 141.311063ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T18:18:44.888519Z","caller":"traceutil/trace.go:171","msg":"trace[1153079344] transaction","detail":"{read_only:false; response_revision:20658; number_of_response:1; }","duration":"439.149882ms","start":"2026-10-14T18:18:44.449343Z","end":"2026-10-14T18:18:44.888492Z","steps":["trace[1153079344] 'process raft request' (duration: 436.535742ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:18:44.888559Z","caller":"traceutil/trace.go:171","msg":"trace[588878908] transaction","detail":"{read_only:false; response_revision:20659; number_of_response:1; }","duration":"439.151382ms","start":"2026-10-14T18:18:44.449379Z","end":"2026-10-14T18:18:44.88853Z","steps":["trace[588878908] 'process raft request' (duration: 438.971728ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:18:44.888659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.135351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.129\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-10-14T18:18:44.888694Z","caller":"traceutil/trace.go:171","msg":"trace[737768949] range","detail":"{range_begin:/registry/masterleases/162.253.55.129; range_end:; response_count:1; response_revision:20660; }","duration":"249.254974ms","start":"2026-10-14T18:18:44.639428Z","end":"2026-10-14T18:18:44.888683Z","steps":["trace[737768949] 'agreement among raft nodes before linearized reading' (duration: 249.151481ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:18:44.888714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:18:44.449317Z","time spent":"439.278496ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T18:18:44.888682Z","caller":"traceutil/trace.go:171","msg":"trace[90535611] transaction","detail":"{read_only:false; response_revision:20660; number_of_response:1; }","duration":"307.617645ms","start":"2026-10-14T18:18:44.580993Z","end":"2026-10-14T18:18:44.88861Z","steps":["trace[90535611] 'process raft request' (duration: 307.450471ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:18:44.888756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:18:44.449353Z","time spent":"439.272825ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T18:18:44.888935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:18:44.580958Z","time spent":"307.83489ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T18:21:51.206311Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19891} {"level":"info","ts":"2026-10-14T18:21:51.330911Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19891,"took":"118.749885ms","hash":2350585279,"current-db-size-bytes":57212928,"current-db-size":"57 MB","current-db-size-in-use-bytes":30306304,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-14T18:21:51.330978Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2350585279,"revision":19891,"compact-revision":17521} {"level":"info","ts":"2026-10-14T18:22:36.692896Z","caller":"traceutil/trace.go:171","msg":"trace[539008726] transaction","detail":"{read_only:false; response_revision:23094; number_of_response:1; }","duration":"307.450954ms","start":"2026-10-14T18:22:36.385394Z","end":"2026-10-14T18:22:36.692845Z","steps":["trace[539008726] 'process raft request' (duration: 307.208809ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:22:36.693145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:22:36.385361Z","time spent":"307.654598ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T18:26:11.082356Z","caller":"traceutil/trace.go:171","msg":"trace[709863905] linearizableReadLoop","detail":"{readStateIndex:26040; appliedIndex:26039; }","duration":"156.143087ms","start":"2026-10-14T18:26:10.926148Z","end":"2026-10-14T18:26:11.082291Z","steps":["trace[709863905] 'read index received' (duration: 155.914191ms)","trace[709863905] 'applied index is now lower than readState.Index' (duration: 227.286µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T18:26:11.082458Z","caller":"traceutil/trace.go:171","msg":"trace[799653484] transaction","detail":"{read_only:false; response_revision:25209; number_of_response:1; }","duration":"174.696878ms","start":"2026-10-14T18:26:10.907691Z","end":"2026-10-14T18:26:11.082388Z","steps":["trace[799653484] 'process raft request' (duration: 174.325049ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:26:11.082532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.379622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T18:26:11.082712Z","caller":"traceutil/trace.go:171","msg":"trace[361865346] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25209; }","duration":"156.507685ms","start":"2026-10-14T18:26:10.926088Z","end":"2026-10-14T18:26:11.082596Z","steps":["trace[361865346] 'agreement among raft nodes before linearized reading' (duration: 156.378122ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:26:11.467473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.532886ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-14T18:26:11.46786Z","caller":"traceutil/trace.go:171","msg":"trace[158453137] linearizableReadLoop","detail":"{readStateIndex:26042; appliedIndex:26040; }","duration":"251.801755ms","start":"2026-10-14T18:26:11.216036Z","end":"2026-10-14T18:26:11.467838Z","steps":["trace[158453137] 'read index received' (duration: 91.643884ms)","trace[158453137] 'applied index is now lower than readState.Index' (duration: 160.156591ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T18:26:11.467844Z","caller":"traceutil/trace.go:171","msg":"trace[337475695] transaction","detail":"{read_only:false; response_revision:25210; number_of_response:1; }","duration":"338.765191ms","start":"2026-10-14T18:26:11.129023Z","end":"2026-10-14T18:26:11.467789Z","steps":["trace[337475695] 'process raft request' (duration: 178.636971ms)","trace[337475695] 'compare' (duration: 159.25971ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T18:26:11.468035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.008749ms","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:6"} {"level":"info","ts":"2026-10-14T18:26:11.467949Z","caller":"traceutil/trace.go:171","msg":"trace[59169971] transaction","detail":"{read_only:false; response_revision:25211; number_of_response:1; }","duration":"271.321409ms","start":"2026-10-14T18:26:11.196581Z","end":"2026-10-14T18:26:11.467902Z","steps":["trace[59169971] 'process raft request' (duration: 271.170366ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:26:11.468075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:26:11.129Z","time spent":"338.949646ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T18:26:11.468101Z","caller":"traceutil/trace.go:171","msg":"trace[99455409] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:25211; }","duration":"197.113622ms","start":"2026-10-14T18:26:11.270968Z","end":"2026-10-14T18:26:11.468082Z","steps":["trace[99455409] 'agreement among raft nodes before linearized reading' (duration: 197.005899ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:26:11.468215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.160734ms","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-14T18:26:11.468337Z","caller":"traceutil/trace.go:171","msg":"trace[767618841] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25211; }","duration":"252.331827ms","start":"2026-10-14T18:26:11.215983Z","end":"2026-10-14T18:26:11.468315Z","steps":["trace[767618841] 'agreement among raft nodes before linearized reading' (duration: 251.919497ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:26:11.468336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.658348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-14T18:26:11.468379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.299549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-10-14T18:26:11.46845Z","caller":"traceutil/trace.go:171","msg":"trace[1799310029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25211; }","duration":"177.806172ms","start":"2026-10-14T18:26:11.290621Z","end":"2026-10-14T18:26:11.468427Z","steps":["trace[1799310029] 'agreement among raft nodes before linearized reading' (duration: 177.551756ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:26:11.468514Z","caller":"traceutil/trace.go:171","msg":"trace[184887843] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25211; }","duration":"113.527474ms","start":"2026-10-14T18:26:11.35496Z","end":"2026-10-14T18:26:11.468487Z","steps":["trace[184887843] 'agreement among raft nodes before linearized reading' (duration: 113.054613ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:26:11.732022Z","caller":"traceutil/trace.go:171","msg":"trace[530527207] transaction","detail":"{read_only:false; response_revision:25213; number_of_response:1; }","duration":"258.232265ms","start":"2026-10-14T18:26:11.473761Z","end":"2026-10-14T18:26:11.731994Z","steps":["trace[530527207] 'process raft request' (duration: 250.198307ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:26:11.732184Z","caller":"traceutil/trace.go:171","msg":"trace[702181596] transaction","detail":"{read_only:false; response_revision:25214; number_of_response:1; }","duration":"258.376758ms","start":"2026-10-14T18:26:11.473781Z","end":"2026-10-14T18:26:11.732158Z","steps":["trace[702181596] 'process raft request' (duration: 258.166154ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:26:12.111359Z","caller":"traceutil/trace.go:171","msg":"trace[1450883552] transaction","detail":"{read_only:false; response_revision:25216; number_of_response:1; }","duration":"134.219176ms","start":"2026-10-14T18:26:11.977117Z","end":"2026-10-14T18:26:12.111336Z","steps":["trace[1450883552] 'process raft request' (duration: 132.006695ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:26:26.67601Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000664d.wal"} {"level":"info","ts":"2026-10-14T18:26:51.213695Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22223} {"level":"info","ts":"2026-10-14T18:26:51.333027Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22223,"took":"114.125238ms","hash":2880691085,"current-db-size-bytes":57212928,"current-db-size":"57 MB","current-db-size-in-use-bytes":44949504,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-10-14T18:26:51.333109Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2880691085,"revision":22223,"compact-revision":19891} {"level":"info","ts":"2026-10-14T18:26:58.837713Z","caller":"traceutil/trace.go:171","msg":"trace[112544887] transaction","detail":"{read_only:false; response_revision:25660; number_of_response:1; }","duration":"387.24522ms","start":"2026-10-14T18:26:58.450446Z","end":"2026-10-14T18:26:58.837691Z","steps":["trace[112544887] 'process raft request' (duration: 387.102867ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:26:58.837768Z","caller":"traceutil/trace.go:171","msg":"trace[1890619032] linearizableReadLoop","detail":"{readStateIndex:26502; appliedIndex:26502; }","duration":"330.634801ms","start":"2026-10-14T18:26:58.5071Z","end":"2026-10-14T18:26:58.837735Z","steps":["trace[1890619032] 'read index received' (duration: 330.622861ms)","trace[1890619032] 'applied index is now lower than readState.Index' (duration: 9.47µs)"],"step_count":2} {"level":"warn","ts":"2026-10-14T18:26:58.837873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:26:58.450422Z","time spent":"387.350652ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T18:26:58.837998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.856267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T18:26:58.838091Z","caller":"traceutil/trace.go:171","msg":"trace[552618656] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:25660; }","duration":"331.018921ms","start":"2026-10-14T18:26:58.507052Z","end":"2026-10-14T18:26:58.838071Z","steps":["trace[552618656] 'agreement among raft nodes before linearized reading' (duration: 330.795275ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:26:58.838142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:26:58.50703Z","time spent":"331.101502ms","remote":"127.0.0.1:38264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":30,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-10-14T18:26:58.848073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.057408ms","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-14T18:26:58.848129Z","caller":"traceutil/trace.go:171","msg":"trace[1463644981] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25661; }","duration":"315.136101ms","start":"2026-10-14T18:26:58.532978Z","end":"2026-10-14T18:26:58.848114Z","steps":["trace[1463644981] 'agreement among raft nodes before linearized reading' (duration: 314.969207ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:26:58.84816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:26:58.532967Z","time spent":"315.186242ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-14T18:26:58.848424Z","caller":"traceutil/trace.go:171","msg":"trace[1607069510] transaction","detail":"{read_only:false; response_revision:25661; number_of_response:1; }","duration":"193.065927ms","start":"2026-10-14T18:26:58.655346Z","end":"2026-10-14T18:26:58.848412Z","steps":["trace[1607069510] 'process raft request' (duration: 192.484923ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:26:58.848637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.159108ms","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-14T18:26:58.848668Z","caller":"traceutil/trace.go:171","msg":"trace[1870892275] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25661; }","duration":"235.231219ms","start":"2026-10-14T18:26:58.613425Z","end":"2026-10-14T18:26:58.848656Z","steps":["trace[1870892275] 'agreement among raft nodes before linearized reading' (duration: 235.125107ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:27:07.431799Z","caller":"traceutil/trace.go:171","msg":"trace[1798289365] transaction","detail":"{read_only:false; response_revision:25726; number_of_response:1; }","duration":"107.615857ms","start":"2026-10-14T18:27:07.324154Z","end":"2026-10-14T18:27:07.43177Z","steps":["trace[1798289365] 'process raft request' (duration: 107.359481ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:27:13.279207Z","caller":"traceutil/trace.go:171","msg":"trace[1718329640] transaction","detail":"{read_only:false; response_revision:25761; number_of_response:1; }","duration":"384.877324ms","start":"2026-10-14T18:27:12.894304Z","end":"2026-10-14T18:27:13.279181Z","steps":["trace[1718329640] 'process raft request' (duration: 384.712961ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:27:13.279359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:27:12.894278Z","time spent":"385.002647ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T18:27:13.618457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.550705ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-14T18:27:13.618732Z","caller":"traceutil/trace.go:171","msg":"trace[714030385] transaction","detail":"{read_only:false; response_revision:25764; number_of_response:1; }","duration":"169.17159ms","start":"2026-10-14T18:27:13.449542Z","end":"2026-10-14T18:27:13.618714Z","steps":["trace[714030385] 'process raft request' (duration: 169.130539ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:27:13.618932Z","caller":"traceutil/trace.go:171","msg":"trace[1987708613] transaction","detail":"{read_only:false; response_revision:25762; number_of_response:1; }","duration":"723.736787ms","start":"2026-10-14T18:27:12.895184Z","end":"2026-10-14T18:27:13.618921Z","steps":["trace[1987708613] 'process raft request' (duration: 539.586278ms)","trace[1987708613] 'compare' (duration: 183.180446ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T18:27:13.618993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:27:12.895157Z","time spent":"723.803309ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T18:27:13.619082Z","caller":"traceutil/trace.go:171","msg":"trace[1145838503] linearizableReadLoop","detail":"{readStateIndex:26607; appliedIndex:26605; }","duration":"679.057826ms","start":"2026-10-14T18:27:12.940014Z","end":"2026-10-14T18:27:13.619072Z","steps":["trace[1145838503] 'read index received' (duration: 338.985535ms)","trace[1145838503] 'applied index is now lower than readState.Index' (duration: 340.071231ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T18:27:13.619436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.391195ms","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-14T18:27:13.61952Z","caller":"traceutil/trace.go:171","msg":"trace[1178266739] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25764; }","duration":"679.539068ms","start":"2026-10-14T18:27:12.939962Z","end":"2026-10-14T18:27:13.619501Z","steps":["trace[1178266739] 'agreement among raft nodes before linearized reading' (duration: 679.290993ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:27:13.619439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.474092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-14T18:27:13.619592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.908205ms","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":"warn","ts":"2026-10-14T18:27:13.619494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.601432ms","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-14T18:27:13.619682Z","caller":"traceutil/trace.go:171","msg":"trace[1125988430] transaction","detail":"{read_only:false; response_revision:25763; number_of_response:1; }","duration":"641.808829ms","start":"2026-10-14T18:27:12.977828Z","end":"2026-10-14T18:27:13.619637Z","steps":["trace[1125988430] 'process raft request' (duration: 640.768124ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:27:13.619704Z","caller":"traceutil/trace.go:171","msg":"trace[1721804504] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25764; }","duration":"628.089329ms","start":"2026-10-14T18:27:12.991585Z","end":"2026-10-14T18:27:13.619674Z","steps":["trace[1721804504] 'agreement among raft nodes before linearized reading' (duration: 627.762262ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:27:13.619728Z","caller":"traceutil/trace.go:171","msg":"trace[1735245088] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25764; }","duration":"115.838778ms","start":"2026-10-14T18:27:13.50384Z","end":"2026-10-14T18:27:13.619679Z","steps":["trace[1735245088] 'agreement among raft nodes before linearized reading' (duration: 115.51313ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:27:13.619767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:27:12.991542Z","time spent":"628.211562ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-14T18:27:13.619793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:27:12.977808Z","time spent":"641.931772ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T18:27:13.619755Z","caller":"traceutil/trace.go:171","msg":"trace[598187101] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:25764; }","duration":"362.702447ms","start":"2026-10-14T18:27:13.25693Z","end":"2026-10-14T18:27:13.619632Z","steps":["trace[598187101] 'agreement among raft nodes before linearized reading' (duration: 362.414681ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:27:13.619585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:27:12.939942Z","time spent":"679.63432ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-14T18:27:13.619937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:27:13.256884Z","time spent":"363.000835ms","remote":"127.0.0.1:48158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":30,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true "} {"level":"warn","ts":"2026-10-14T18:27:13.620149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.427286ms","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-14T18:27:13.620227Z","caller":"traceutil/trace.go:171","msg":"trace[462736136] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25764; }","duration":"424.550499ms","start":"2026-10-14T18:27:13.195655Z","end":"2026-10-14T18:27:13.620205Z","steps":["trace[462736136] 'agreement among raft nodes before linearized reading' (duration: 423.815512ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:27:13.62027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:27:13.195633Z","time spent":"424.62796ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-14T18:27:13.816184Z","caller":"traceutil/trace.go:171","msg":"trace[1799383472] transaction","detail":"{read_only:false; response_revision:25765; number_of_response:1; }","duration":"191.168933ms","start":"2026-10-14T18:27:13.624987Z","end":"2026-10-14T18:27:13.816156Z","steps":["trace[1799383472] 'process raft request' (duration: 174.934945ms)","trace[1799383472] 'compare' (duration: 16.121355ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T18:27:14.051818Z","caller":"traceutil/trace.go:171","msg":"trace[1470380581] transaction","detail":"{read_only:false; response_revision:25766; number_of_response:1; }","duration":"426.668108ms","start":"2026-10-14T18:27:13.625093Z","end":"2026-10-14T18:27:14.051761Z","steps":["trace[1470380581] 'process raft request' (duration: 399.136127ms)","trace[1470380581] 'compare' (duration: 27.08385ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T18:27:14.051991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:27:13.625071Z","time spent":"426.830662ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T18:27:14.052095Z","caller":"traceutil/trace.go:171","msg":"trace[822952741] transaction","detail":"{read_only:false; response_revision:25768; number_of_response:1; }","duration":"338.430123ms","start":"2026-10-14T18:27:13.713643Z","end":"2026-10-14T18:27:14.052073Z","steps":["trace[822952741] 'process raft request' (duration: 338.074305ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:27:14.051818Z","caller":"traceutil/trace.go:171","msg":"trace[315542527] linearizableReadLoop","detail":"{readStateIndex:26612; appliedIndex:26609; }","duration":"426.482533ms","start":"2026-10-14T18:27:13.625306Z","end":"2026-10-14T18:27:14.051789Z","steps":["trace[315542527] 'read index received' (duration: 174.707009ms)","trace[315542527] 'applied index is now lower than readState.Index' (duration: 251.774074ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T18:27:14.052227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:27:13.713611Z","time spent":"338.531986ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T18:27:14.052362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.977221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-14T18:27:14.052372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.972275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T18:27:14.052413Z","caller":"traceutil/trace.go:171","msg":"trace[1219887497] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:25768; }","duration":"198.031413ms","start":"2026-10-14T18:27:13.854366Z","end":"2026-10-14T18:27:14.052397Z","steps":["trace[1219887497] 'agreement among raft nodes before linearized reading' (duration: 197.949651ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:27:14.052422Z","caller":"traceutil/trace.go:171","msg":"trace[569059696] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25768; }","duration":"126.040036ms","start":"2026-10-14T18:27:13.926364Z","end":"2026-10-14T18:27:14.052404Z","steps":["trace[569059696] 'agreement among raft nodes before linearized reading' (duration: 125.933563ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:27:14.052225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.903864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"warn","ts":"2026-10-14T18:27:14.052526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.057639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-14T18:27:14.052552Z","caller":"traceutil/trace.go:171","msg":"trace[1208668935] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25768; }","duration":"427.239452ms","start":"2026-10-14T18:27:13.625252Z","end":"2026-10-14T18:27:14.052491Z","steps":["trace[1208668935] 'agreement among raft nodes before linearized reading' (duration: 426.625937ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:27:14.052005Z","caller":"traceutil/trace.go:171","msg":"trace[519229914] transaction","detail":"{read_only:false; response_revision:25767; number_of_response:1; }","duration":"426.820192ms","start":"2026-10-14T18:27:13.625153Z","end":"2026-10-14T18:27:14.051973Z","steps":["trace[519229914] 'process raft request' (duration: 426.462133ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T18:27:14.052638Z","caller":"traceutil/trace.go:171","msg":"trace[1533265280] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25768; }","duration":"212.245354ms","start":"2026-10-14T18:27:13.840369Z","end":"2026-10-14T18:27:14.052614Z","steps":["trace[1533265280] 'agreement among raft nodes before linearized reading' (duration: 211.923856ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T18:27:14.052925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:27:13.625087Z","time spent":"427.788824ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T18:27:14.053286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T18:27:13.625234Z","time spent":"427.441736ms","remote":"127.0.0.1:38216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12241,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-10-14T18:31:51.223399Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25589} {"level":"info","ts":"2026-10-14T18:31:51.395646Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25589,"took":"167.909809ms","hash":1335769259,"current-db-size-bytes":58429440,"current-db-size":"58 MB","current-db-size-in-use-bytes":35770368,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-14T18:31:51.395712Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1335769259,"revision":25589,"compact-revision":22223} {"level":"info","ts":"2026-10-14T18:33:13.112127Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d232699cb6c87299","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-14T18:33:13.118788Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-14T18:33:13.11889Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-14T18:36:51.23803Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28468} {"level":"info","ts":"2026-10-14T18:36:51.389393Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28468,"took":"147.459183ms","hash":7644668,"current-db-size-bytes":58429440,"current-db-size":"58 MB","current-db-size-in-use-bytes":30814208,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-14T18:36:51.38946Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":7644668,"revision":28468,"compact-revision":25589} {"level":"info","ts":"2026-10-14T18:41:51.244404Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30694} {"level":"info","ts":"2026-10-14T18:41:51.363473Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30694,"took":"115.699453ms","hash":3633277072,"current-db-size-bytes":58429440,"current-db-size":"58 MB","current-db-size-in-use-bytes":31285248,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-14T18:41:51.363543Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3633277072,"revision":30694,"compact-revision":28468} {"level":"info","ts":"2026-10-14T18:46:51.251669Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32957} {"level":"info","ts":"2026-10-14T18:46:51.431857Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32957,"took":"175.353454ms","hash":2176043597,"current-db-size-bytes":59469824,"current-db-size":"60 MB","current-db-size-in-use-bytes":30429184,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-14T18:46:51.43195Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2176043597,"revision":32957,"compact-revision":30694} {"level":"info","ts":"2026-10-14T18:51:51.265987Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35241} {"level":"info","ts":"2026-10-14T18:51:51.404653Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35241,"took":"135.067885ms","hash":1359575786,"current-db-size-bytes":59469824,"current-db-size":"60 MB","current-db-size-in-use-bytes":32661504,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-14T18:51:51.404723Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1359575786,"revision":35241,"compact-revision":32957} {"level":"info","ts":"2026-10-14T18:54:45.454579Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d232699cb6c87299","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-14T18:54:45.459845Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-14T18:54:45.459949Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-14T18:56:51.2736Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37476} {"level":"info","ts":"2026-10-14T18:56:51.412703Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37476,"took":"134.489532ms","hash":269974087,"current-db-size-bytes":61173760,"current-db-size":"61 MB","current-db-size-in-use-bytes":32391168,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-14T18:56:51.412768Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":269974087,"revision":37476,"compact-revision":35241} {"level":"info","ts":"2026-10-14T19:01:51.280793Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39749} {"level":"info","ts":"2026-10-14T19:01:51.435007Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39749,"took":"150.345562ms","hash":1999380366,"current-db-size-bytes":61173760,"current-db-size":"61 MB","current-db-size-in-use-bytes":30912512,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-14T19:01:51.435094Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1999380366,"revision":39749,"compact-revision":37476}