{"level":"warn","ts":"2026-09-01T05:08:20.883033Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T05:08:20.883133Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.195: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.195:2380","--initial-cluster=instance=https://162.253.55.195:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.195:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.195:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-01T05:08:20.883211Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T05:08:20.883224Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-09-01T05:08:20.883245Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-01T05:08:20.883793Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"]} {"level":"info","ts":"2026-09-01T05:08:20.883858Z","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.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.195:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-01T05:08:20.890767Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.673257ms"} {"level":"info","ts":"2026-09-01T05:08:20.901244Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b66d12fd59101739","cluster-id":"a64a525934ce8379"} {"level":"info","ts":"2026-09-01T05:08:20.901329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=()"} {"level":"info","ts":"2026-09-01T05:08:20.901357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 0"} {"level":"info","ts":"2026-09-01T05:08:20.901378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b66d12fd59101739 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-01T05:08:20.901389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 1"} {"level":"info","ts":"2026-09-01T05:08:20.901433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"warn","ts":"2026-09-01T05:08:20.911566Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-01T05:08:20.913989Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-01T05:08:20.920555Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-01T05:08:20.92811Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b66d12fd59101739","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-01T05:08:20.928548Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b66d12fd59101739","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-01T05:08:20.928765Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T05:08:20.92884Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T05:08:20.9289Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T05:08:20.931133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"info","ts":"2026-09-01T05:08:20.931227Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","added-peer-id":"b66d12fd59101739","added-peer-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-09-01T05:08:20.932241Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-01T05:08:20.932404Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-09-01T05:08:20.932483Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-09-01T05:08:20.932734Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-01T05:08:20.933946Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b66d12fd59101739","initial-advertise-peer-urls":["https://162.253.55.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-01T05:08:21.002257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 is starting a new election at term 1"} {"level":"info","ts":"2026-09-01T05:08:21.002346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-01T05:08:21.002366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgPreVoteResp from b66d12fd59101739 at term 1"} {"level":"info","ts":"2026-09-01T05:08:21.002378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became candidate at term 2"} {"level":"info","ts":"2026-09-01T05:08:21.002383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgVoteResp from b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-09-01T05:08:21.002392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became leader at term 2"} {"level":"info","ts":"2026-09-01T05:08:21.0024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b66d12fd59101739 elected leader b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-09-01T05:08:21.003277Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b66d12fd59101739","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.195:2379]}","request-path":"/0/members/b66d12fd59101739/attributes","cluster-id":"a64a525934ce8379","publish-timeout":"7s"} {"level":"info","ts":"2026-09-01T05:08:21.003302Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T05:08:21.003358Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T05:08:21.003463Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T05:08:21.004688Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T05:08:21.004756Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T05:08:21.004778Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T05:08:21.00583Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-01T05:08:21.005865Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-01T05:08:21.007142Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-01T05:08:21.007962Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.195:2379"} {"level":"info","ts":"2026-09-01T05:08:57.585973Z","caller":"traceutil/trace.go:171","msg":"trace[543502430] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"101.459455ms","start":"2026-09-01T05:08:57.484486Z","end":"2026-09-01T05:08:57.585946Z","steps":["trace[543502430] 'process raft request' (duration: 101.338711ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:08:57.585949Z","caller":"traceutil/trace.go:171","msg":"trace[1672125268] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"143.907869ms","start":"2026-09-01T05:08:57.441994Z","end":"2026-09-01T05:08:57.585902Z","steps":["trace[1672125268] 'process raft request' (duration: 130.208423ms)","trace[1672125268] 'compare' (duration: 13.440288ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T05:09:03.778366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.148707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qv68t\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-01T05:09:03.778449Z","caller":"traceutil/trace.go:171","msg":"trace[1710548694] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qv68t; range_end:; response_count:1; response_revision:622; }","duration":"138.2608ms","start":"2026-09-01T05:09:03.640174Z","end":"2026-09-01T05:09:03.778435Z","steps":["trace[1710548694] 'range keys from in-memory index tree' (duration: 138.001362ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:09:03.778337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.351247ms","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-09-01T05:09:03.778482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.590415ms","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-09-01T05:09:03.778549Z","caller":"traceutil/trace.go:171","msg":"trace[167576838] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:622; }","duration":"152.641516ms","start":"2026-09-01T05:09:03.625886Z","end":"2026-09-01T05:09:03.778527Z","steps":["trace[167576838] 'range keys from in-memory index tree' (duration: 152.217712ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:09:03.778602Z","caller":"traceutil/trace.go:171","msg":"trace[535193947] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:622; }","duration":"152.74358ms","start":"2026-09-01T05:09:03.625827Z","end":"2026-09-01T05:09:03.77857Z","steps":["trace[535193947] 'range keys from in-memory index tree' (duration: 152.46358ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:09:04.032976Z","caller":"traceutil/trace.go:171","msg":"trace[569362138] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:645; }","duration":"191.628419ms","start":"2026-09-01T05:09:03.841322Z","end":"2026-09-01T05:09:04.032951Z","steps":["trace[569362138] 'read index received' (duration: 184.54878ms)","trace[569362138] 'applied index is now lower than readState.Index' (duration: 7.078569ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:09:04.033058Z","caller":"traceutil/trace.go:171","msg":"trace[737491005] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"250.448737ms","start":"2026-09-01T05:09:03.782581Z","end":"2026-09-01T05:09:04.03303Z","steps":["trace[737491005] 'process raft request' (duration: 243.224572ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:09:04.033333Z","caller":"traceutil/trace.go:171","msg":"trace[591850009] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"238.949047ms","start":"2026-09-01T05:09:03.794329Z","end":"2026-09-01T05:09:04.033279Z","steps":["trace[591850009] 'process raft request' (duration: 238.530492ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:09:04.033798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.819415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-01T05:09:04.033967Z","caller":"traceutil/trace.go:171","msg":"trace[1534180225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:625; }","duration":"192.674775ms","start":"2026-09-01T05:09:03.84127Z","end":"2026-09-01T05:09:04.033945Z","steps":["trace[1534180225] 'agreement among raft nodes before linearized reading' (duration: 191.801554ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:09:04.075655Z","caller":"traceutil/trace.go:171","msg":"trace[2008313256] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"218.74535ms","start":"2026-09-01T05:09:03.856889Z","end":"2026-09-01T05:09:04.075634Z","steps":["trace[2008313256] 'process raft request' (duration: 218.252793ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:09:04.702611Z","caller":"traceutil/trace.go:171","msg":"trace[1948077835] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"558.633212ms","start":"2026-09-01T05:09:04.143948Z","end":"2026-09-01T05:09:04.702581Z","steps":["trace[1948077835] 'process raft request' (duration: 555.605289ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:09:04.703576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:09:04.143906Z","time spent":"559.269654ms","remote":"127.0.0.1:42560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-01T05:09:10.873707Z","caller":"traceutil/trace.go:171","msg":"trace[1912171740] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"104.426276ms","start":"2026-09-01T05:09:10.769255Z","end":"2026-09-01T05:09:10.873682Z","steps":["trace[1912171740] 'process raft request' (duration: 104.286431ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:10:21.407068Z","caller":"traceutil/trace.go:171","msg":"trace[785969545] transaction","detail":"{read_only:false; response_revision:1479; number_of_response:1; }","duration":"113.752025ms","start":"2026-09-01T05:10:21.293281Z","end":"2026-09-01T05:10:21.407033Z","steps":["trace[785969545] 'process raft request' (duration: 101.263626ms)","trace[785969545] 'compare' (duration: 12.07694ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T05:10:50.630688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.440475ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-09-01T05:10:50.630842Z","caller":"traceutil/trace.go:171","msg":"trace[319985952] linearizableReadLoop","detail":"{readStateIndex:1995; appliedIndex:1994; }","duration":"516.275853ms","start":"2026-09-01T05:10:50.114521Z","end":"2026-09-01T05:10:50.630797Z","steps":["trace[319985952] 'read index received' (duration: 21.549076ms)","trace[319985952] 'applied index is now lower than readState.Index' (duration: 494.725446ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T05:10:50.631147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.606407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c5d0b02c-868a-47e8-95be-1803638e72d3\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-01T05:10:50.631188Z","caller":"traceutil/trace.go:171","msg":"trace[1344951854] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c5d0b02c-868a-47e8-95be-1803638e72d3; range_end:; response_count:1; response_revision:1918; }","duration":"516.667611ms","start":"2026-09-01T05:10:50.114507Z","end":"2026-09-01T05:10:50.631174Z","steps":["trace[1344951854] 'agreement among raft nodes before linearized reading' (duration: 516.408222ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:10:50.631219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:10:50.114447Z","time spent":"516.763168ms","remote":"127.0.0.1:42418","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-c5d0b02c-868a-47e8-95be-1803638e72d3\" "} {"level":"warn","ts":"2026-09-01T05:10:50.63133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.088781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-01T05:10:50.63142Z","caller":"traceutil/trace.go:171","msg":"trace[945384208] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1918; }","duration":"436.20867ms","start":"2026-09-01T05:10:50.195185Z","end":"2026-09-01T05:10:50.631394Z","steps":["trace[945384208] 'agreement among raft nodes before linearized reading' (duration: 435.95044ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:10:50.631477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:10:50.195174Z","time spent":"436.290116ms","remote":"127.0.0.1:44300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-01T05:10:50.631304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.074218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c5d0b02c-868a-47e8-95be-1803638e72d3\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-01T05:10:50.632885Z","caller":"traceutil/trace.go:171","msg":"trace[572582868] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c5d0b02c-868a-47e8-95be-1803638e72d3; range_end:; response_count:1; response_revision:1918; }","duration":"461.808187ms","start":"2026-09-01T05:10:50.171052Z","end":"2026-09-01T05:10:50.632861Z","steps":["trace[572582868] 'agreement among raft nodes before linearized reading' (duration: 459.941828ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:10:50.633028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:10:50.171034Z","time spent":"461.9756ms","remote":"127.0.0.1:42418","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-c5d0b02c-868a-47e8-95be-1803638e72d3\" "} {"level":"info","ts":"2026-09-01T05:10:50.764484Z","caller":"traceutil/trace.go:171","msg":"trace[1335340766] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"123.49034ms","start":"2026-09-01T05:10:50.640965Z","end":"2026-09-01T05:10:50.764455Z","steps":["trace[1335340766] 'process raft request' (duration: 118.064528ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:10:51.000983Z","caller":"traceutil/trace.go:171","msg":"trace[1400724903] linearizableReadLoop","detail":"{readStateIndex:1999; appliedIndex:1998; }","duration":"181.600825ms","start":"2026-09-01T05:10:50.819356Z","end":"2026-09-01T05:10:51.000957Z","steps":["trace[1400724903] 'read index received' (duration: 163.647425ms)","trace[1400724903] 'applied index is now lower than readState.Index' (duration: 17.95241ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T05:10:51.001228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.834493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T05:10:51.001275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.245158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-01T05:10:51.001315Z","caller":"traceutil/trace.go:171","msg":"trace[737390021] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1922; }","duration":"110.314823ms","start":"2026-09-01T05:10:50.89099Z","end":"2026-09-01T05:10:51.001305Z","steps":["trace[737390021] 'agreement among raft nodes before linearized reading' (duration: 110.193794ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:10:51.001316Z","caller":"traceutil/trace.go:171","msg":"trace[137676707] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1922; }","duration":"182.004595ms","start":"2026-09-01T05:10:50.819294Z","end":"2026-09-01T05:10:51.001298Z","steps":["trace[137676707] 'agreement among raft nodes before linearized reading' (duration: 181.79568ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:10:51.001219Z","caller":"traceutil/trace.go:171","msg":"trace[2084982254] transaction","detail":"{read_only:false; response_revision:1922; number_of_response:1; }","duration":"221.771172ms","start":"2026-09-01T05:10:50.779265Z","end":"2026-09-01T05:10:51.001036Z","steps":["trace[2084982254] 'process raft request' (duration: 203.79639ms)","trace[2084982254] 'compare' (duration: 17.744965ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T05:10:51.001502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.718954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-01T05:10:51.001609Z","caller":"traceutil/trace.go:171","msg":"trace[224679419] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1922; }","duration":"137.850673ms","start":"2026-09-01T05:10:50.863689Z","end":"2026-09-01T05:10:51.00154Z","steps":["trace[224679419] 'agreement among raft nodes before linearized reading' (duration: 137.560092ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:10:51.002023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.72213ms","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-09-01T05:10:51.002114Z","caller":"traceutil/trace.go:171","msg":"trace[113005641] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1922; }","duration":"153.849699ms","start":"2026-09-01T05:10:50.848252Z","end":"2026-09-01T05:10:51.002102Z","steps":["trace[113005641] 'agreement among raft nodes before linearized reading' (duration: 152.928661ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:10:57.237867Z","caller":"traceutil/trace.go:171","msg":"trace[1407741777] transaction","detail":"{read_only:false; response_revision:1989; number_of_response:1; }","duration":"116.049512ms","start":"2026-09-01T05:10:57.121786Z","end":"2026-09-01T05:10:57.237836Z","steps":["trace[1407741777] 'process raft request' (duration: 93.944973ms)","trace[1407741777] 'compare' (duration: 21.59388ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:11:03.269984Z","caller":"traceutil/trace.go:171","msg":"trace[254501764] transaction","detail":"{read_only:false; response_revision:2026; number_of_response:1; }","duration":"128.558787ms","start":"2026-09-01T05:11:03.141388Z","end":"2026-09-01T05:11:03.269947Z","steps":["trace[254501764] 'process raft request' (duration: 128.302837ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:11:24.134033Z","caller":"traceutil/trace.go:171","msg":"trace[1867726520] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"104.994606ms","start":"2026-09-01T05:11:24.028999Z","end":"2026-09-01T05:11:24.133994Z","steps":["trace[1867726520] 'process raft request' (duration: 97.004553ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:11:25.176093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.197159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-01T05:11:25.176156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.799547ms","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-09-01T05:11:25.176184Z","caller":"traceutil/trace.go:171","msg":"trace[776619549] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:2160; }","duration":"206.33041ms","start":"2026-09-01T05:11:24.969827Z","end":"2026-09-01T05:11:25.176157Z","steps":["trace[776619549] 'count revisions from in-memory index tree' (duration: 206.108002ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:11:25.176213Z","caller":"traceutil/trace.go:171","msg":"trace[698764875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2160; }","duration":"151.904075ms","start":"2026-09-01T05:11:25.024294Z","end":"2026-09-01T05:11:25.176199Z","steps":["trace[698764875] 'range keys from in-memory index tree' (duration: 151.5849ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:11:25.176156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.492451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T05:11:25.176325Z","caller":"traceutil/trace.go:171","msg":"trace[282868947] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2160; }","duration":"101.697316ms","start":"2026-09-01T05:11:25.07461Z","end":"2026-09-01T05:11:25.176308Z","steps":["trace[282868947] 'range keys from in-memory index tree' (duration: 101.433526ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:11:25.533977Z","caller":"traceutil/trace.go:171","msg":"trace[1126104048] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"148.597367ms","start":"2026-09-01T05:11:25.385354Z","end":"2026-09-01T05:11:25.533951Z","steps":["trace[1126104048] 'process raft request' (duration: 148.37858ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:11:26.022605Z","caller":"traceutil/trace.go:171","msg":"trace[1584763330] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"636.864336ms","start":"2026-09-01T05:11:25.38573Z","end":"2026-09-01T05:11:26.022595Z","steps":["trace[1584763330] 'process raft request' (duration: 636.445183ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:11:26.022889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:11:25.385712Z","time spent":"636.993435ms","remote":"127.0.0.1:42494","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-09-01T05:11:26.023023Z","caller":"traceutil/trace.go:171","msg":"trace[261031690] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"597.625733ms","start":"2026-09-01T05:11:25.424917Z","end":"2026-09-01T05:11:26.022543Z","steps":["trace[261031690] 'process raft request' (duration: 597.59291ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:11:26.023093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:11:25.42491Z","time spent":"598.149514ms","remote":"127.0.0.1:42494","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-09-01T05:11:26.034808Z","caller":"traceutil/trace.go:171","msg":"trace[1577951661] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"370.13517ms","start":"2026-09-01T05:11:25.66465Z","end":"2026-09-01T05:11:26.034785Z","steps":["trace[1577951661] 'process raft request' (duration: 369.976067ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:11:26.035005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:11:25.664634Z","time spent":"370.244148ms","remote":"127.0.0.1:42494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T05:11:26.035227Z","caller":"traceutil/trace.go:171","msg":"trace[2104531685] linearizableReadLoop","detail":"{readStateIndex:2252; appliedIndex:2249; }","duration":"152.209943ms","start":"2026-09-01T05:11:25.883001Z","end":"2026-09-01T05:11:26.03521Z","steps":["trace[2104531685] 'read index received' (duration: 139.63486ms)","trace[2104531685] 'applied index is now lower than readState.Index' (duration: 12.574313ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:11:26.035291Z","caller":"traceutil/trace.go:171","msg":"trace[1360536215] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"160.931554ms","start":"2026-09-01T05:11:25.874327Z","end":"2026-09-01T05:11:26.035259Z","steps":["trace[1360536215] 'process raft request' (duration: 160.824695ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:11:26.035301Z","caller":"traceutil/trace.go:171","msg":"trace[1991743565] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"265.832799ms","start":"2026-09-01T05:11:25.769437Z","end":"2026-09-01T05:11:26.03527Z","steps":["trace[1991743565] 'process raft request' (duration: 265.312918ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:11:26.035392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.387926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-01T05:11:26.035439Z","caller":"traceutil/trace.go:171","msg":"trace[15902054] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2167; }","duration":"152.43408ms","start":"2026-09-01T05:11:25.882996Z","end":"2026-09-01T05:11:26.03543Z","steps":["trace[15902054] 'agreement among raft nodes before linearized reading' (duration: 152.291289ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:11:26.317517Z","caller":"traceutil/trace.go:171","msg":"trace[300450489] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"179.18819ms","start":"2026-09-01T05:11:26.13831Z","end":"2026-09-01T05:11:26.317498Z","steps":["trace[300450489] 'process raft request' (duration: 179.040858ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:12:28.40119Z","caller":"traceutil/trace.go:171","msg":"trace[715338363] transaction","detail":"{read_only:false; response_revision:2546; number_of_response:1; }","duration":"111.0244ms","start":"2026-09-01T05:12:28.290134Z","end":"2026-09-01T05:12:28.401159Z","steps":["trace[715338363] 'process raft request' (duration: 33.518699ms)","trace[715338363] 'compare' (duration: 77.037763ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:12:28.401399Z","caller":"traceutil/trace.go:171","msg":"trace[2006955089] transaction","detail":"{read_only:false; response_revision:2547; number_of_response:1; }","duration":"107.879364ms","start":"2026-09-01T05:12:28.293504Z","end":"2026-09-01T05:12:28.401383Z","steps":["trace[2006955089] 'process raft request' (duration: 107.421857ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:12:32.585807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.022865ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T05:12:32.585924Z","caller":"traceutil/trace.go:171","msg":"trace[1965444316] transaction","detail":"{read_only:false; response_revision:2579; number_of_response:1; }","duration":"137.108581ms","start":"2026-09-01T05:12:32.448798Z","end":"2026-09-01T05:12:32.585906Z","steps":["trace[1965444316] 'compare' (duration: 130.589709ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:12:32.597009Z","caller":"traceutil/trace.go:171","msg":"trace[1383636968] transaction","detail":"{read_only:false; response_revision:2580; number_of_response:1; }","duration":"147.959076ms","start":"2026-09-01T05:12:32.449021Z","end":"2026-09-01T05:12:32.59698Z","steps":["trace[1383636968] 'process raft request' (duration: 147.822875ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:12:38.538146Z","caller":"traceutil/trace.go:171","msg":"trace[1530718716] transaction","detail":"{read_only:false; response_revision:2655; number_of_response:1; }","duration":"227.98423ms","start":"2026-09-01T05:12:38.310138Z","end":"2026-09-01T05:12:38.538122Z","steps":["trace[1530718716] 'process raft request' (duration: 227.818996ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:17:42.599688Z","caller":"traceutil/trace.go:171","msg":"trace[1107942416] linearizableReadLoop","detail":"{readStateIndex:5105; appliedIndex:5104; }","duration":"199.071634ms","start":"2026-09-01T05:17:42.400593Z","end":"2026-09-01T05:17:42.599664Z","steps":["trace[1107942416] 'read index received' (duration: 154.759068ms)","trace[1107942416] 'applied index is now lower than readState.Index' (duration: 44.311596ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:17:42.599996Z","caller":"traceutil/trace.go:171","msg":"trace[864858330] transaction","detail":"{read_only:false; response_revision:4915; number_of_response:1; }","duration":"209.731273ms","start":"2026-09-01T05:17:42.390235Z","end":"2026-09-01T05:17:42.599967Z","steps":["trace[864858330] 'process raft request' (duration: 165.188858ms)","trace[864858330] 'compare' (duration: 43.898431ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T05:17:42.600059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.694657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-065a0929-8547-44bd-95ac-3a1a541ce863\" ","response":"range_response_count:1 size:3774"} {"level":"warn","ts":"2026-09-01T05:17:42.600069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.463296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-09-01T05:17:42.600093Z","caller":"traceutil/trace.go:171","msg":"trace[78341666] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-065a0929-8547-44bd-95ac-3a1a541ce863; range_end:; response_count:1; response_revision:4915; }","duration":"170.783884ms","start":"2026-09-01T05:17:42.429299Z","end":"2026-09-01T05:17:42.600083Z","steps":["trace[78341666] 'agreement among raft nodes before linearized reading' (duration: 170.625771ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:17:42.600108Z","caller":"traceutil/trace.go:171","msg":"trace[679682368] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4915; }","duration":"199.537303ms","start":"2026-09-01T05:17:42.400559Z","end":"2026-09-01T05:17:42.600097Z","steps":["trace[679682368] 'agreement among raft nodes before linearized reading' (duration: 199.396381ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:17:44.396784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.467361ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T05:17:44.396888Z","caller":"traceutil/trace.go:171","msg":"trace[1607660914] linearizableReadLoop","detail":"{readStateIndex:5126; appliedIndex:5125; }","duration":"134.965077ms","start":"2026-09-01T05:17:44.261905Z","end":"2026-09-01T05:17:44.39687Z","steps":["trace[1607660914] 'read index received' (duration: 4.247555ms)","trace[1607660914] 'applied index is now lower than readState.Index' (duration: 130.716342ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:17:44.396941Z","caller":"traceutil/trace.go:171","msg":"trace[1737864443] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"183.781368ms","start":"2026-09-01T05:17:44.213117Z","end":"2026-09-01T05:17:44.396898Z","steps":["trace[1737864443] 'process raft request' (duration: 53.102469ms)","trace[1737864443] 'compare' (duration: 130.352482ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T05:17:44.397048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.150083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-01T05:17:44.397077Z","caller":"traceutil/trace.go:171","msg":"trace[2022830788] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4936; }","duration":"135.218159ms","start":"2026-09-01T05:17:44.26185Z","end":"2026-09-01T05:17:44.397068Z","steps":["trace[2022830788] 'agreement among raft nodes before linearized reading' (duration: 135.062985ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:18:01.971231Z","caller":"traceutil/trace.go:171","msg":"trace[2092489241] transaction","detail":"{read_only:false; response_revision:5224; number_of_response:1; }","duration":"254.203643ms","start":"2026-09-01T05:18:01.716997Z","end":"2026-09-01T05:18:01.9712Z","steps":["trace[2092489241] 'process raft request' (duration: 254.033448ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:18:02.140194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.204353ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T05:18:02.14038Z","caller":"traceutil/trace.go:171","msg":"trace[386297540] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5224; }","duration":"122.404809ms","start":"2026-09-01T05:18:02.01795Z","end":"2026-09-01T05:18:02.140355Z","steps":["trace[386297540] 'range keys from in-memory index tree' (duration: 122.184571ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:18:02.191519Z","caller":"traceutil/trace.go:171","msg":"trace[2010993347] transaction","detail":"{read_only:false; response_revision:5225; number_of_response:1; }","duration":"462.032318ms","start":"2026-09-01T05:18:01.729453Z","end":"2026-09-01T05:18:02.191486Z","steps":["trace[2010993347] 'process raft request' (duration: 461.735543ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:18:02.191758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:18:01.729428Z","time spent":"462.200732ms","remote":"127.0.0.1:42418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13837,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T05:18:02.192181Z","caller":"traceutil/trace.go:171","msg":"trace[754030471] transaction","detail":"{read_only:false; response_revision:5226; number_of_response:1; }","duration":"411.182645ms","start":"2026-09-01T05:18:01.780979Z","end":"2026-09-01T05:18:02.192161Z","steps":["trace[754030471] 'process raft request' (duration: 410.378528ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:18:02.192337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:18:01.780954Z","time spent":"411.282073ms","remote":"127.0.0.1:42494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T05:18:02.192482Z","caller":"traceutil/trace.go:171","msg":"trace[592875593] transaction","detail":"{read_only:false; response_revision:5227; number_of_response:1; }","duration":"371.138137ms","start":"2026-09-01T05:18:01.821322Z","end":"2026-09-01T05:18:02.19246Z","steps":["trace[592875593] 'process raft request' (duration: 370.762675ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:18:02.192592Z","caller":"traceutil/trace.go:171","msg":"trace[1693615462] transaction","detail":"{read_only:false; response_revision:5228; number_of_response:1; }","duration":"371.141507ms","start":"2026-09-01T05:18:01.821396Z","end":"2026-09-01T05:18:02.192537Z","steps":["trace[1693615462] 'process raft request' (duration: 370.976383ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:18:02.192687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:18:01.821288Z","time spent":"371.29944ms","remote":"127.0.0.1:42494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T05:18:02.192753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:18:01.821367Z","time spent":"371.30086ms","remote":"127.0.0.1:42494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T05:18:02.315795Z","caller":"traceutil/trace.go:171","msg":"trace[1720936179] transaction","detail":"{read_only:false; response_revision:5229; number_of_response:1; }","duration":"102.601208ms","start":"2026-09-01T05:18:02.213159Z","end":"2026-09-01T05:18:02.31576Z","steps":["trace[1720936179] 'process raft request' (duration: 29.948038ms)","trace[1720936179] 'compare' (duration: 72.323002ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:18:02.539213Z","caller":"traceutil/trace.go:171","msg":"trace[859914006] transaction","detail":"{read_only:false; response_revision:5232; number_of_response:1; }","duration":"128.607857ms","start":"2026-09-01T05:18:02.410576Z","end":"2026-09-01T05:18:02.539184Z","steps":["trace[859914006] 'process raft request' (duration: 128.395009ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:18:02.591739Z","caller":"traceutil/trace.go:171","msg":"trace[189051347] transaction","detail":"{read_only:false; response_revision:5234; number_of_response:1; }","duration":"179.769835ms","start":"2026-09-01T05:18:02.411944Z","end":"2026-09-01T05:18:02.591714Z","steps":["trace[189051347] 'process raft request' (duration: 179.523294ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:18:02.591799Z","caller":"traceutil/trace.go:171","msg":"trace[987749201] linearizableReadLoop","detail":"{readStateIndex:5431; appliedIndex:5428; }","duration":"179.685037ms","start":"2026-09-01T05:18:02.412094Z","end":"2026-09-01T05:18:02.591779Z","steps":["trace[987749201] 'read index received' (duration: 126.939687ms)","trace[987749201] 'applied index is now lower than readState.Index' (duration: 52.725088ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:18:02.591901Z","caller":"traceutil/trace.go:171","msg":"trace[1977324882] transaction","detail":"{read_only:false; response_revision:5235; number_of_response:1; }","duration":"179.47547ms","start":"2026-09-01T05:18:02.412405Z","end":"2026-09-01T05:18:02.59188Z","steps":["trace[1977324882] 'process raft request' (duration: 179.23616ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:18:02.592051Z","caller":"traceutil/trace.go:171","msg":"trace[1188398222] transaction","detail":"{read_only:false; response_revision:5236; number_of_response:1; }","duration":"166.048939ms","start":"2026-09-01T05:18:02.425986Z","end":"2026-09-01T05:18:02.592035Z","steps":["trace[1188398222] 'process raft request' (duration: 165.719592ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:18:02.592247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.430756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-01T05:18:02.592299Z","caller":"traceutil/trace.go:171","msg":"trace[1558568169] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5236; }","duration":"179.521644ms","start":"2026-09-01T05:18:02.412761Z","end":"2026-09-01T05:18:02.592282Z","steps":["trace[1558568169] 'agreement among raft nodes before linearized reading' (duration: 179.359ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:18:02.592466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.044642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-01T05:18:02.592502Z","caller":"traceutil/trace.go:171","msg":"trace[2080380149] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:5236; }","duration":"158.085225ms","start":"2026-09-01T05:18:02.434407Z","end":"2026-09-01T05:18:02.592492Z","steps":["trace[2080380149] 'agreement among raft nodes before linearized reading' (duration: 158.02187ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:18:02.592476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.817197ms","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-09-01T05:18:02.592712Z","caller":"traceutil/trace.go:171","msg":"trace[1244561057] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5236; }","duration":"109.098339ms","start":"2026-09-01T05:18:02.483599Z","end":"2026-09-01T05:18:02.592697Z","steps":["trace[1244561057] 'agreement among raft nodes before linearized reading' (duration: 108.649712ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:18:02.592822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.707622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13852"} {"level":"info","ts":"2026-09-01T05:18:02.592874Z","caller":"traceutil/trace.go:171","msg":"trace[366041371] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5236; }","duration":"180.787959ms","start":"2026-09-01T05:18:02.412072Z","end":"2026-09-01T05:18:02.59286Z","steps":["trace[366041371] 'agreement among raft nodes before linearized reading' (duration: 180.629476ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:18:02.593038Z","caller":"traceutil/trace.go:171","msg":"trace[1408879825] transaction","detail":"{read_only:false; response_revision:5233; number_of_response:1; }","duration":"180.110042ms","start":"2026-09-01T05:18:02.41144Z","end":"2026-09-01T05:18:02.59155Z","steps":["trace[1408879825] 'process raft request' (duration: 179.891174ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:18:21.410927Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2892} {"level":"info","ts":"2026-09-01T05:18:21.487247Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2892,"took":"74.987046ms","hash":3924623751,"current-db-size-bytes":51712000,"current-db-size":"52 MB","current-db-size-in-use-bytes":27721728,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-01T05:18:21.487318Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3924623751,"revision":2892,"compact-revision":-1} {"level":"info","ts":"2026-09-01T05:21:46.789653Z","caller":"traceutil/trace.go:171","msg":"trace[1289944685] transaction","detail":"{read_only:false; response_revision:6861; number_of_response:1; }","duration":"162.460275ms","start":"2026-09-01T05:21:46.627166Z","end":"2026-09-01T05:21:46.789626Z","steps":["trace[1289944685] 'process raft request' (duration: 162.105877ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:23:21.420072Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5370} {"level":"info","ts":"2026-09-01T05:23:21.506535Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5370,"took":"84.794813ms","hash":140258803,"current-db-size-bytes":51712000,"current-db-size":"52 MB","current-db-size-in-use-bytes":18964480,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-01T05:23:21.506601Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":140258803,"revision":5370,"compact-revision":2892}