{"level":"warn","ts":"2026-10-10T10:14:31.500686Z","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-10T10:14:31.500761Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.206: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.206:2380","--initial-cluster=instance=https://162.253.55.206:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.206:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.206: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-10T10:14:31.500847Z","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-10T10:14:31.500854Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.206:2380"]} {"level":"info","ts":"2026-10-10T10:14:31.50087Z","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-10T10:14:31.501385Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.206:2379"]} {"level":"info","ts":"2026-10-10T10:14:31.501449Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.206:2380"],"listen-peer-urls":["https://162.253.55.206:2380"],"advertise-client-urls":["https://162.253.55.206:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.206:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.206: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-10T10:14:31.507175Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.536849ms"} {"level":"info","ts":"2026-10-10T10:14:31.516741Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cfc9fec265e3384a","cluster-id":"9866fe2b0d49ed88"} {"level":"info","ts":"2026-10-10T10:14:31.5168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a switched to configuration voters=()"} {"level":"info","ts":"2026-10-10T10:14:31.516824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became follower at term 0"} {"level":"info","ts":"2026-10-10T10:14:31.516831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cfc9fec265e3384a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-10T10:14:31.51684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became follower at term 1"} {"level":"info","ts":"2026-10-10T10:14:31.516872Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a switched to configuration voters=(14972778547056425034)"} {"level":"warn","ts":"2026-10-10T10:14:31.5248Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-10T10:14:31.5261Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-10T10:14:31.527667Z","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-10T10:14:31.529332Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cfc9fec265e3384a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-10T10:14:31.531889Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cfc9fec265e3384a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-10T10:14:31.532087Z","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-10T10:14:31.532146Z","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-10T10:14:31.532169Z","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-10T10:14:31.534879Z","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-10T10:14:31.535061Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cfc9fec265e3384a","initial-advertise-peer-urls":["https://162.253.55.206:2380"],"listen-peer-urls":["https://162.253.55.206:2380"],"advertise-client-urls":["https://162.253.55.206:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.206:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-10T10:14:31.535083Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-10T10:14:31.5351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a switched to configuration voters=(14972778547056425034)"} {"level":"info","ts":"2026-10-10T10:14:31.535165Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.206:2380"} {"level":"info","ts":"2026-10-10T10:14:31.535184Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.206:2380"} {"level":"info","ts":"2026-10-10T10:14:31.535225Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9866fe2b0d49ed88","local-member-id":"cfc9fec265e3384a","added-peer-id":"cfc9fec265e3384a","added-peer-peer-urls":["https://162.253.55.206:2380"]} {"level":"info","ts":"2026-10-10T10:14:31.917156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a is starting a new election at term 1"} {"level":"info","ts":"2026-10-10T10:14:31.917211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became pre-candidate at term 1"} {"level":"info","ts":"2026-10-10T10:14:31.917248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a received MsgPreVoteResp from cfc9fec265e3384a at term 1"} {"level":"info","ts":"2026-10-10T10:14:31.917267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became candidate at term 2"} {"level":"info","ts":"2026-10-10T10:14:31.917283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a received MsgVoteResp from cfc9fec265e3384a at term 2"} {"level":"info","ts":"2026-10-10T10:14:31.917298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cfc9fec265e3384a became leader at term 2"} {"level":"info","ts":"2026-10-10T10:14:31.917311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cfc9fec265e3384a elected leader cfc9fec265e3384a at term 2"} {"level":"info","ts":"2026-10-10T10:14:31.918374Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cfc9fec265e3384a","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.206:2379]}","request-path":"/0/members/cfc9fec265e3384a/attributes","cluster-id":"9866fe2b0d49ed88","publish-timeout":"7s"} {"level":"info","ts":"2026-10-10T10:14:31.918534Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-10T10:14:31.918658Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-10T10:14:31.919962Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-10T10:14:31.921002Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9866fe2b0d49ed88","local-member-id":"cfc9fec265e3384a","cluster-version":"3.5"} {"level":"info","ts":"2026-10-10T10:14:31.92115Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-10T10:14:31.921191Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-10T10:14:31.921504Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.206:2379"} {"level":"info","ts":"2026-10-10T10:14:31.922017Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-10T10:14:31.922068Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-10T10:14:31.930497Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-10T10:15:15.972018Z","caller":"traceutil/trace.go:171","msg":"trace[1169067037] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"107.082269ms","start":"2026-10-10T10:15:15.864898Z","end":"2026-10-10T10:15:15.971981Z","steps":["trace[1169067037] 'process raft request' (duration: 106.829272ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:15:16.334493Z","caller":"traceutil/trace.go:171","msg":"trace[1707702358] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"218.029086ms","start":"2026-10-10T10:15:16.116433Z","end":"2026-10-10T10:15:16.334462Z","steps":["trace[1707702358] 'process raft request' (duration: 217.968932ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:15:16.334564Z","caller":"traceutil/trace.go:171","msg":"trace[1665859766] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"218.738092ms","start":"2026-10-10T10:15:16.115785Z","end":"2026-10-10T10:15:16.334523Z","steps":["trace[1665859766] 'process raft request' (duration: 204.549946ms)","trace[1665859766] 'compare' (duration: 13.917349ms)"],"step_count":2} {"level":"info","ts":"2026-10-10T10:15:16.336051Z","caller":"traceutil/trace.go:171","msg":"trace[468057429] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"205.437913ms","start":"2026-10-10T10:15:16.130585Z","end":"2026-10-10T10:15:16.336023Z","steps":["trace[468057429] 'process raft request' (duration: 205.229359ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:15:19.97288Z","caller":"traceutil/trace.go:171","msg":"trace[1970994723] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"112.850482ms","start":"2026-10-10T10:15:19.859997Z","end":"2026-10-10T10:15:19.972847Z","steps":["trace[1970994723] 'process raft request' (duration: 77.405854ms)","trace[1970994723] 'compare' (duration: 34.654937ms)"],"step_count":2} {"level":"warn","ts":"2026-10-10T10:15:23.269422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.579485ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-10T10:15:23.269824Z","caller":"traceutil/trace.go:171","msg":"trace[1290393708] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"450.814751ms","start":"2026-10-10T10:15:22.818989Z","end":"2026-10-10T10:15:23.269804Z","steps":["trace[1290393708] 'process raft request' (duration: 44.379ms)","trace[1290393708] 'compare' (duration: 405.431056ms)"],"step_count":2} {"level":"warn","ts":"2026-10-10T10:15:23.269883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-10T10:15:22.818971Z","time spent":"450.884705ms","remote":"127.0.0.1:45316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-10T10:16:33.765132Z","caller":"traceutil/trace.go:171","msg":"trace[222731625] transaction","detail":"{read_only:false; response_revision:1481; number_of_response:1; }","duration":"140.129418ms","start":"2026-10-10T10:16:33.624978Z","end":"2026-10-10T10:16:33.765107Z","steps":["trace[222731625] 'process raft request' (duration: 139.964246ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:16:45.076306Z","caller":"traceutil/trace.go:171","msg":"trace[1944160879] transaction","detail":"{read_only:false; response_revision:1708; number_of_response:1; }","duration":"120.063882ms","start":"2026-10-10T10:16:44.956211Z","end":"2026-10-10T10:16:45.076275Z","steps":["trace[1944160879] 'process raft request' (duration: 119.881359ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:16:45.370514Z","caller":"traceutil/trace.go:171","msg":"trace[1288549121] linearizableReadLoop","detail":"{readStateIndex:1782; appliedIndex:1781; }","duration":"108.241175ms","start":"2026-10-10T10:16:45.262186Z","end":"2026-10-10T10:16:45.370427Z","steps":["trace[1288549121] 'read index received' (duration: 104.953742ms)","trace[1288549121] 'applied index is now lower than readState.Index' (duration: 3.285563ms)"],"step_count":2} {"level":"warn","ts":"2026-10-10T10:16:45.370769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.540126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusterrestores.pxc.percona.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-10T10:16:45.370942Z","caller":"traceutil/trace.go:171","msg":"trace[949444766] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusterrestores.pxc.percona.com; range_end:; response_count:0; response_revision:1711; }","duration":"108.7362ms","start":"2026-10-10T10:16:45.262182Z","end":"2026-10-10T10:16:45.370919Z","steps":["trace[949444766] 'agreement among raft nodes before linearized reading' (duration: 108.472191ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:16:45.382629Z","caller":"traceutil/trace.go:171","msg":"trace[1287779998] transaction","detail":"{read_only:false; response_revision:1712; number_of_response:1; }","duration":"113.218968ms","start":"2026-10-10T10:16:45.269379Z","end":"2026-10-10T10:16:45.382598Z","steps":["trace[1287779998] 'process raft request' (duration: 112.953099ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:16:45.524477Z","caller":"traceutil/trace.go:171","msg":"trace[682053150] linearizableReadLoop","detail":"{readStateIndex:1786; appliedIndex:1785; }","duration":"123.882924ms","start":"2026-10-10T10:16:45.400572Z","end":"2026-10-10T10:16:45.524455Z","steps":["trace[682053150] 'read index received' (duration: 122.430001ms)","trace[682053150] 'applied index is now lower than readState.Index' (duration: 1.451822ms)"],"step_count":2} {"level":"info","ts":"2026-10-10T10:16:45.524526Z","caller":"traceutil/trace.go:171","msg":"trace[1929369010] transaction","detail":"{read_only:false; response_revision:1715; number_of_response:1; }","duration":"126.425734ms","start":"2026-10-10T10:16:45.398076Z","end":"2026-10-10T10:16:45.524501Z","steps":["trace[1929369010] 'process raft request' (duration: 124.944249ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:16:45.524617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.023904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusters.pxc.percona.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-10T10:16:45.524638Z","caller":"traceutil/trace.go:171","msg":"trace[1942219939] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/perconaxtradbclusters.pxc.percona.com; range_end:; response_count:0; response_revision:1715; }","duration":"124.084048ms","start":"2026-10-10T10:16:45.400549Z","end":"2026-10-10T10:16:45.524633Z","steps":["trace[1942219939] 'agreement among raft nodes before linearized reading' (duration: 123.996392ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:16:45.530954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.361739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-10T10:16:45.530982Z","caller":"traceutil/trace.go:171","msg":"trace[547203170] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1716; }","duration":"113.412572ms","start":"2026-10-10T10:16:45.417564Z","end":"2026-10-10T10:16:45.530976Z","steps":["trace[547203170] 'agreement among raft nodes before linearized reading' (duration: 113.346987ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:16:45.531012Z","caller":"traceutil/trace.go:171","msg":"trace[551490605] transaction","detail":"{read_only:false; response_revision:1716; number_of_response:1; }","duration":"102.359938ms","start":"2026-10-10T10:16:45.428633Z","end":"2026-10-10T10:16:45.530993Z","steps":["trace[551490605] 'process raft request' (duration: 102.205997ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:16:52.43514Z","caller":"traceutil/trace.go:171","msg":"trace[937152899] transaction","detail":"{read_only:false; response_revision:1795; number_of_response:1; }","duration":"104.088397ms","start":"2026-10-10T10:16:52.331023Z","end":"2026-10-10T10:16:52.435112Z","steps":["trace[937152899] 'process raft request' (duration: 103.909943ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:17:01.933948Z","caller":"traceutil/trace.go:171","msg":"trace[374898931] linearizableReadLoop","detail":"{readStateIndex:1991; appliedIndex:1990; }","duration":"204.820816ms","start":"2026-10-10T10:17:01.729106Z","end":"2026-10-10T10:17:01.933927Z","steps":["trace[374898931] 'read index received' (duration: 204.738218ms)","trace[374898931] 'applied index is now lower than readState.Index' (duration: 81.548µs)"],"step_count":2} {"level":"info","ts":"2026-10-10T10:17:01.934008Z","caller":"traceutil/trace.go:171","msg":"trace[424535197] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"223.935831ms","start":"2026-10-10T10:17:01.710034Z","end":"2026-10-10T10:17:01.93397Z","steps":["trace[424535197] 'process raft request' (duration: 223.764345ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:17:01.934169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.04528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3a1d39d6-83cd-464b-93b6-7dc74eab72d7\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-10T10:17:01.93421Z","caller":"traceutil/trace.go:171","msg":"trace[861411486] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3a1d39d6-83cd-464b-93b6-7dc74eab72d7; range_end:; response_count:1; response_revision:1913; }","duration":"205.120417ms","start":"2026-10-10T10:17:01.729079Z","end":"2026-10-10T10:17:01.9342Z","steps":["trace[861411486] 'agreement among raft nodes before linearized reading' (duration: 204.957262ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:17:01.958742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.122924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-10T10:17:01.958846Z","caller":"traceutil/trace.go:171","msg":"trace[1616811295] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1914; }","duration":"142.27482ms","start":"2026-10-10T10:17:01.816547Z","end":"2026-10-10T10:17:01.958821Z","steps":["trace[1616811295] 'agreement among raft nodes before linearized reading' (duration: 142.095044ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:17:02.458803Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4056231596005354317,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-10T10:17:02.5507Z","caller":"traceutil/trace.go:171","msg":"trace[774880240] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"608.711268ms","start":"2026-10-10T10:17:01.941953Z","end":"2026-10-10T10:17:02.550664Z","steps":["trace[774880240] 'process raft request' (duration: 608.587771ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:17:02.550701Z","caller":"traceutil/trace.go:171","msg":"trace[1540115659] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"609.36394ms","start":"2026-10-10T10:17:01.941288Z","end":"2026-10-10T10:17:02.550652Z","steps":["trace[1540115659] 'process raft request' (duration: 603.530153ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:17:02.550999Z","caller":"traceutil/trace.go:171","msg":"trace[716939094] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"608.428336ms","start":"2026-10-10T10:17:01.942547Z","end":"2026-10-10T10:17:02.550975Z","steps":["trace[716939094] 'process raft request' (duration: 608.079715ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:17:02.55107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-10T10:17:01.941915Z","time spent":"608.849674ms","remote":"127.0.0.1:45060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-10T10:17:02.551152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-10T10:17:01.942535Z","time spent":"608.539363ms","remote":"127.0.0.1:45060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-10T10:17:02.551226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-10T10:17:01.941265Z","time spent":"609.542276ms","remote":"127.0.0.1:44966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-10T10:17:02.551783Z","caller":"traceutil/trace.go:171","msg":"trace[731701153] linearizableReadLoop","detail":"{readStateIndex:1996; appliedIndex:1992; }","duration":"593.176487ms","start":"2026-10-10T10:17:01.958589Z","end":"2026-10-10T10:17:02.551766Z","steps":["trace[731701153] 'read index received' (duration: 586.128322ms)","trace[731701153] 'applied index is now lower than readState.Index' (duration: 7.046385ms)"],"step_count":2} {"level":"warn","ts":"2026-10-10T10:17:02.552054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.13438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3a1d39d6-83cd-464b-93b6-7dc74eab72d7\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-10T10:17:02.552111Z","caller":"traceutil/trace.go:171","msg":"trace[87603956] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3a1d39d6-83cd-464b-93b6-7dc74eab72d7; range_end:; response_count:1; response_revision:1918; }","duration":"613.234817ms","start":"2026-10-10T10:17:01.938857Z","end":"2026-10-10T10:17:02.552091Z","steps":["trace[87603956] 'agreement among raft nodes before linearized reading' (duration: 613.013793ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:17:02.552291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-10T10:17:01.938833Z","time spent":"613.304475ms","remote":"127.0.0.1:44982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3a1d39d6-83cd-464b-93b6-7dc74eab72d7\" "} {"level":"info","ts":"2026-10-10T10:17:02.552474Z","caller":"traceutil/trace.go:171","msg":"trace[122091848] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"609.087129ms","start":"2026-10-10T10:17:01.943367Z","end":"2026-10-10T10:17:02.552454Z","steps":["trace[122091848] 'process raft request' (duration: 607.52094ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:17:02.5526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-10T10:17:01.94335Z","time spent":"609.175007ms","remote":"127.0.0.1:44966","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-10T10:17:10.573986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.9315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-10T10:17:10.574111Z","caller":"traceutil/trace.go:171","msg":"trace[1468202068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1992; }","duration":"153.092658ms","start":"2026-10-10T10:17:10.42098Z","end":"2026-10-10T10:17:10.574072Z","steps":["trace[1468202068] 'range keys from in-memory index tree' (duration: 152.831033ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:17:14.990576Z","caller":"traceutil/trace.go:171","msg":"trace[1386863748] transaction","detail":"{read_only:false; response_revision:2033; number_of_response:1; }","duration":"208.89103ms","start":"2026-10-10T10:17:14.781667Z","end":"2026-10-10T10:17:14.990558Z","steps":["trace[1386863748] 'process raft request' (duration: 208.780502ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:17:36.884026Z","caller":"traceutil/trace.go:171","msg":"trace[1566106625] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"107.183261ms","start":"2026-10-10T10:17:36.776793Z","end":"2026-10-10T10:17:36.883976Z","steps":["trace[1566106625] 'process raft request' (duration: 68.421325ms)","trace[1566106625] 'compare' (duration: 38.645217ms)"],"step_count":2} {"level":"info","ts":"2026-10-10T10:17:37.026433Z","caller":"traceutil/trace.go:171","msg":"trace[2145194606] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"246.191268ms","start":"2026-10-10T10:17:36.780207Z","end":"2026-10-10T10:17:37.026399Z","steps":["trace[2145194606] 'process raft request' (duration: 215.271955ms)","trace[2145194606] 'compare' (duration: 30.629604ms)"],"step_count":2} {"level":"info","ts":"2026-10-10T10:17:37.02647Z","caller":"traceutil/trace.go:171","msg":"trace[1401241018] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"199.591708ms","start":"2026-10-10T10:17:36.826836Z","end":"2026-10-10T10:17:37.026428Z","steps":["trace[1401241018] 'process raft request' (duration: 199.469668ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:17:37.026564Z","caller":"traceutil/trace.go:171","msg":"trace[586397852] linearizableReadLoop","detail":"{readStateIndex:2243; appliedIndex:2241; }","duration":"245.196404ms","start":"2026-10-10T10:17:36.781327Z","end":"2026-10-10T10:17:37.026523Z","steps":["trace[586397852] 'read index received' (duration: 63.879631ms)","trace[586397852] 'applied index is now lower than readState.Index' (duration: 181.314233ms)"],"step_count":2} {"level":"warn","ts":"2026-10-10T10:17:37.02691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.554812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-10T10:17:37.027009Z","caller":"traceutil/trace.go:171","msg":"trace[558326182] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2159; }","duration":"245.674342ms","start":"2026-10-10T10:17:36.781298Z","end":"2026-10-10T10:17:37.026972Z","steps":["trace[558326182] 'agreement among raft nodes before linearized reading' (duration: 245.425683ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:17:37.027023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.046901ms","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:5"} {"level":"info","ts":"2026-10-10T10:17:37.027091Z","caller":"traceutil/trace.go:171","msg":"trace[1106556575] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2160; }","duration":"104.15298ms","start":"2026-10-10T10:17:36.922914Z","end":"2026-10-10T10:17:37.027067Z","steps":["trace[1106556575] 'agreement among raft nodes before linearized reading' (duration: 104.008501ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:17:37.027317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.217357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-10-10T10:17:37.02738Z","caller":"traceutil/trace.go:171","msg":"trace[1256084587] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2160; }","duration":"151.346247ms","start":"2026-10-10T10:17:36.876018Z","end":"2026-10-10T10:17:37.027364Z","steps":["trace[1256084587] 'agreement among raft nodes before linearized reading' (duration: 150.870939ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:17:37.523454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.514018ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-10T10:17:37.523554Z","caller":"traceutil/trace.go:171","msg":"trace[1721502341] linearizableReadLoop","detail":"{readStateIndex:2248; appliedIndex:2247; }","duration":"169.2312ms","start":"2026-10-10T10:17:37.354305Z","end":"2026-10-10T10:17:37.523536Z","steps":["trace[1721502341] 'read index received' (duration: 56.578593ms)","trace[1721502341] 'applied index is now lower than readState.Index' (duration: 112.651347ms)"],"step_count":2} {"level":"warn","ts":"2026-10-10T10:17:37.52373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.431539ms","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-10T10:17:37.523755Z","caller":"traceutil/trace.go:171","msg":"trace[1156540252] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2163; }","duration":"169.502568ms","start":"2026-10-10T10:17:37.354243Z","end":"2026-10-10T10:17:37.523746Z","steps":["trace[1156540252] 'agreement among raft nodes before linearized reading' (duration: 169.338828ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:17:37.523803Z","caller":"traceutil/trace.go:171","msg":"trace[732368503] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"258.084462ms","start":"2026-10-10T10:17:37.265685Z","end":"2026-10-10T10:17:37.52377Z","steps":["trace[732368503] 'process raft request' (duration: 145.157207ms)","trace[732368503] 'compare' (duration: 112.405768ms)"],"step_count":2} {"level":"warn","ts":"2026-10-10T10:18:49.694603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.358535ms","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-10T10:18:49.694674Z","caller":"traceutil/trace.go:171","msg":"trace[1759830973] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2651; }","duration":"117.465687ms","start":"2026-10-10T10:18:49.577193Z","end":"2026-10-10T10:18:49.694659Z","steps":["trace[1759830973] 'range keys from in-memory index tree' (duration: 117.245542ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:19:21.364647Z","caller":"traceutil/trace.go:171","msg":"trace[353344685] transaction","detail":"{read_only:false; response_revision:2823; number_of_response:1; }","duration":"144.326694ms","start":"2026-10-10T10:19:21.220282Z","end":"2026-10-10T10:19:21.364608Z","steps":["trace[353344685] 'process raft request' (duration: 144.053226ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:19:21.578234Z","caller":"traceutil/trace.go:171","msg":"trace[1373373148] transaction","detail":"{read_only:false; response_revision:2824; number_of_response:1; }","duration":"152.287787ms","start":"2026-10-10T10:19:21.425897Z","end":"2026-10-10T10:19:21.578185Z","steps":["trace[1373373148] 'process raft request' (duration: 84.262796ms)","trace[1373373148] 'compare' (duration: 67.454123ms)"],"step_count":2} {"level":"info","ts":"2026-10-10T10:19:21.578276Z","caller":"traceutil/trace.go:171","msg":"trace[1859713058] transaction","detail":"{read_only:false; response_revision:2825; number_of_response:1; }","duration":"140.169752ms","start":"2026-10-10T10:19:21.43808Z","end":"2026-10-10T10:19:21.57825Z","steps":["trace[1859713058] 'process raft request' (duration: 140.069039ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:19:26.771296Z","caller":"traceutil/trace.go:171","msg":"trace[364813239] transaction","detail":"{read_only:false; response_revision:2853; number_of_response:1; }","duration":"136.82611ms","start":"2026-10-10T10:19:26.634445Z","end":"2026-10-10T10:19:26.771271Z","steps":["trace[364813239] 'process raft request' (duration: 136.641554ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:24:03.434102Z","caller":"traceutil/trace.go:171","msg":"trace[1734187419] transaction","detail":"{read_only:false; response_revision:4954; number_of_response:1; }","duration":"103.530546ms","start":"2026-10-10T10:24:03.330534Z","end":"2026-10-10T10:24:03.434065Z","steps":["trace[1734187419] 'process raft request' (duration: 100.926175ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:24:03.437045Z","caller":"traceutil/trace.go:171","msg":"trace[347874006] transaction","detail":"{read_only:false; response_revision:4955; number_of_response:1; }","duration":"103.522035ms","start":"2026-10-10T10:24:03.333506Z","end":"2026-10-10T10:24:03.437028Z","steps":["trace[347874006] 'process raft request' (duration: 103.165275ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:24:03.437164Z","caller":"traceutil/trace.go:171","msg":"trace[258195386] transaction","detail":"{read_only:false; response_revision:4956; number_of_response:1; }","duration":"102.772692ms","start":"2026-10-10T10:24:03.334363Z","end":"2026-10-10T10:24:03.437136Z","steps":["trace[258195386] 'process raft request' (duration: 102.386649ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:24:03.808779Z","caller":"traceutil/trace.go:171","msg":"trace[1641765627] transaction","detail":"{read_only:false; response_revision:4963; number_of_response:1; }","duration":"103.385958ms","start":"2026-10-10T10:24:03.705367Z","end":"2026-10-10T10:24:03.808753Z","steps":["trace[1641765627] 'process raft request' (duration: 88.713878ms)","trace[1641765627] 'compare' (duration: 14.432606ms)"],"step_count":2} {"level":"info","ts":"2026-10-10T10:24:03.809123Z","caller":"traceutil/trace.go:171","msg":"trace[43892052] transaction","detail":"{read_only:false; response_revision:4964; number_of_response:1; }","duration":"103.4302ms","start":"2026-10-10T10:24:03.70568Z","end":"2026-10-10T10:24:03.80911Z","steps":["trace[43892052] 'process raft request' (duration: 103.010426ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:24:22.522896Z","caller":"traceutil/trace.go:171","msg":"trace[1111672871] linearizableReadLoop","detail":"{readStateIndex:5465; appliedIndex:5464; }","duration":"164.593595ms","start":"2026-10-10T10:24:22.358265Z","end":"2026-10-10T10:24:22.522859Z","steps":["trace[1111672871] 'read index received' (duration: 164.263796ms)","trace[1111672871] 'applied index is now lower than readState.Index' (duration: 327.879µs)"],"step_count":2} {"level":"info","ts":"2026-10-10T10:24:22.523018Z","caller":"traceutil/trace.go:171","msg":"trace[96277253] transaction","detail":"{read_only:false; response_revision:5262; number_of_response:1; }","duration":"180.410288ms","start":"2026-10-10T10:24:22.342563Z","end":"2026-10-10T10:24:22.522974Z","steps":["trace[96277253] 'process raft request' (duration: 179.9349ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:24:22.523285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.941166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-10-10T10:24:22.523337Z","caller":"traceutil/trace.go:171","msg":"trace[215706518] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5262; }","duration":"165.119626ms","start":"2026-10-10T10:24:22.358204Z","end":"2026-10-10T10:24:22.523323Z","steps":["trace[215706518] 'agreement among raft nodes before linearized reading' (duration: 164.824539ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:24:22.876935Z","caller":"traceutil/trace.go:171","msg":"trace[806415462] transaction","detail":"{read_only:false; response_revision:5265; number_of_response:1; }","duration":"102.13794ms","start":"2026-10-10T10:24:22.774765Z","end":"2026-10-10T10:24:22.876903Z","steps":["trace[806415462] 'process raft request' (duration: 102.085537ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:24:22.877302Z","caller":"traceutil/trace.go:171","msg":"trace[1851705142] transaction","detail":"{read_only:false; response_revision:5263; number_of_response:1; }","duration":"388.931736ms","start":"2026-10-10T10:24:22.488327Z","end":"2026-10-10T10:24:22.877259Z","steps":["trace[1851705142] 'process raft request' (duration: 380.177505ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:24:22.877483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-10T10:24:22.488303Z","time spent":"389.075124ms","remote":"127.0.0.1:45044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-10T10:24:22.87776Z","caller":"traceutil/trace.go:171","msg":"trace[1484949498] linearizableReadLoop","detail":"{readStateIndex:5466; appliedIndex:5465; }","duration":"340.865191ms","start":"2026-10-10T10:24:22.536883Z","end":"2026-10-10T10:24:22.877748Z","steps":["trace[1484949498] 'read index received' (duration: 331.718997ms)","trace[1484949498] 'applied index is now lower than readState.Index' (duration: 9.145244ms)"],"step_count":2} {"level":"warn","ts":"2026-10-10T10:24:22.877942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.055122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13878"} {"level":"info","ts":"2026-10-10T10:24:22.877978Z","caller":"traceutil/trace.go:171","msg":"trace[1024273967] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5265; }","duration":"341.136917ms","start":"2026-10-10T10:24:22.536829Z","end":"2026-10-10T10:24:22.877966Z","steps":["trace[1024273967] 'agreement among raft nodes before linearized reading' (duration: 340.999459ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:24:22.878036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-10T10:24:22.536799Z","time spent":"341.228672ms","remote":"127.0.0.1:44982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":13902,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"info","ts":"2026-10-10T10:24:22.878174Z","caller":"traceutil/trace.go:171","msg":"trace[1493519870] transaction","detail":"{read_only:false; response_revision:5264; number_of_response:1; }","duration":"246.7434ms","start":"2026-10-10T10:24:22.631399Z","end":"2026-10-10T10:24:22.878142Z","steps":["trace[1493519870] 'process raft request' (duration: 245.368519ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:24:22.878284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.36656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-ccef7138-57e6-4c62-927b-40f64cc303c7\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-10-10T10:24:22.878339Z","caller":"traceutil/trace.go:171","msg":"trace[422225087] range","detail":"{range_begin:/registry/persistentvolumes/pvc-ccef7138-57e6-4c62-927b-40f64cc303c7; range_end:; response_count:1; response_revision:5265; }","duration":"341.481437ms","start":"2026-10-10T10:24:22.536842Z","end":"2026-10-10T10:24:22.878323Z","steps":["trace[422225087] 'agreement among raft nodes before linearized reading' (duration: 341.294516ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:24:22.878376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-10T10:24:22.536819Z","time spent":"341.548461ms","remote":"127.0.0.1:44948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1346,"request content":"key:\"/registry/persistentvolumes/pvc-ccef7138-57e6-4c62-927b-40f64cc303c7\" "} {"level":"warn","ts":"2026-10-10T10:24:22.878585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.414621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-10-10T10:24:22.878699Z","caller":"traceutil/trace.go:171","msg":"trace[632806192] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5265; }","duration":"197.604592ms","start":"2026-10-10T10:24:22.681074Z","end":"2026-10-10T10:24:22.878679Z","steps":["trace[632806192] 'agreement among raft nodes before linearized reading' (duration: 197.254132ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:24:23.242236Z","caller":"traceutil/trace.go:171","msg":"trace[1076319373] transaction","detail":"{read_only:false; response_revision:5275; number_of_response:1; }","duration":"116.393005ms","start":"2026-10-10T10:24:23.125808Z","end":"2026-10-10T10:24:23.242201Z","steps":["trace[1076319373] 'process raft request' (duration: 116.179523ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:24:23.242265Z","caller":"traceutil/trace.go:171","msg":"trace[1710971390] transaction","detail":"{read_only:false; response_revision:5274; number_of_response:1; }","duration":"117.358341ms","start":"2026-10-10T10:24:23.124809Z","end":"2026-10-10T10:24:23.242167Z","steps":["trace[1710971390] 'process raft request' (duration: 21.229749ms)","trace[1710971390] 'compare' (duration: 95.776102ms)"],"step_count":2} {"level":"info","ts":"2026-10-10T10:24:23.242252Z","caller":"traceutil/trace.go:171","msg":"trace[524162469] transaction","detail":"{read_only:false; response_revision:5276; number_of_response:1; }","duration":"114.864006ms","start":"2026-10-10T10:24:23.12737Z","end":"2026-10-10T10:24:23.242234Z","steps":["trace[524162469] 'process raft request' (duration: 114.736279ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:24:23.242473Z","caller":"traceutil/trace.go:171","msg":"trace[143258619] transaction","detail":"{read_only:false; response_revision:5277; number_of_response:1; }","duration":"113.418031ms","start":"2026-10-10T10:24:23.129039Z","end":"2026-10-10T10:24:23.242457Z","steps":["trace[143258619] 'process raft request' (duration: 113.131664ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:24:23.242592Z","caller":"traceutil/trace.go:171","msg":"trace[260765061] linearizableReadLoop","detail":"{readStateIndex:5480; appliedIndex:5476; }","duration":"112.53644ms","start":"2026-10-10T10:24:23.130042Z","end":"2026-10-10T10:24:23.242579Z","steps":["trace[260765061] 'read index received' (duration: 15.984374ms)","trace[260765061] 'applied index is now lower than readState.Index' (duration: 96.549976ms)"],"step_count":2} {"level":"info","ts":"2026-10-10T10:24:23.242624Z","caller":"traceutil/trace.go:171","msg":"trace[1345286141] transaction","detail":"{read_only:false; response_revision:5278; number_of_response:1; }","duration":"109.785909ms","start":"2026-10-10T10:24:23.132824Z","end":"2026-10-10T10:24:23.24261Z","steps":["trace[1345286141] 'process raft request' (duration: 109.62625ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:24:23.2429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.48336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1451"} {"level":"info","ts":"2026-10-10T10:24:23.242945Z","caller":"traceutil/trace.go:171","msg":"trace[998936179] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5278; }","duration":"116.607658ms","start":"2026-10-10T10:24:23.126326Z","end":"2026-10-10T10:24:23.242933Z","steps":["trace[998936179] 'agreement among raft nodes before linearized reading' (duration: 116.340002ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:24:23.258506Z","caller":"traceutil/trace.go:171","msg":"trace[524193050] transaction","detail":"{read_only:false; response_revision:5279; number_of_response:1; }","duration":"112.36776ms","start":"2026-10-10T10:24:23.146101Z","end":"2026-10-10T10:24:23.258469Z","steps":["trace[524193050] 'process raft request' (duration: 112.063652ms)"],"step_count":1} {"level":"warn","ts":"2026-10-10T10:24:23.258593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.255083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-10-10T10:24:23.258883Z","caller":"traceutil/trace.go:171","msg":"trace[428132517] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5279; }","duration":"125.560761ms","start":"2026-10-10T10:24:23.13326Z","end":"2026-10-10T10:24:23.258821Z","steps":["trace[428132517] 'agreement among raft nodes before linearized reading' (duration: 125.124125ms)"],"step_count":1} {"level":"info","ts":"2026-10-10T10:24:31.977429Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2884} {"level":"info","ts":"2026-10-10T10:24:32.072052Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2884,"took":"93.116943ms","hash":1129509238,"current-db-size-bytes":53383168,"current-db-size":"53 MB","current-db-size-in-use-bytes":27754496,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-10T10:24:32.072107Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1129509238,"revision":2884,"compact-revision":-1} {"level":"info","ts":"2026-10-10T10:24:57.184405Z","caller":"traceutil/trace.go:171","msg":"trace[1662735301] transaction","detail":"{read_only:false; response_revision:5587; number_of_response:1; }","duration":"136.985965ms","start":"2026-10-10T10:24:57.047384Z","end":"2026-10-10T10:24:57.18437Z","steps":["trace[1662735301] 'process raft request' (duration: 117.058329ms)","trace[1662735301] 'compare' (duration: 19.764897ms)"],"step_count":2} {"level":"info","ts":"2026-10-10T10:29:31.994657Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5347} {"level":"info","ts":"2026-10-10T10:29:32.131097Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5347,"took":"134.667342ms","hash":1721055707,"current-db-size-bytes":53383168,"current-db-size":"53 MB","current-db-size-in-use-bytes":18980864,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-10T10:29:32.131264Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1721055707,"revision":5347,"compact-revision":2884}