{"level":"warn","ts":"2026-08-22T14:33:16.717721Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T14:33:16.717847Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.186: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.186:2380","--initial-cluster=instance=https://162.253.55.186:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.186:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.186: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-08-22T14:33:16.71793Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T14:33:16.71796Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.186:2380"]} {"level":"info","ts":"2026-08-22T14:33:16.717991Z","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-08-22T14:33:16.718642Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"]} {"level":"info","ts":"2026-08-22T14:33:16.718744Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.186:2380"],"listen-peer-urls":["https://162.253.55.186:2380"],"advertise-client-urls":["https://162.253.55.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.186: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-08-22T14:33:16.722743Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.749525ms"} {"level":"info","ts":"2026-08-22T14:33:16.731377Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"612d5169b08bb96b","cluster-id":"20ec8eafba602517"} {"level":"info","ts":"2026-08-22T14:33:16.731503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=()"} {"level":"info","ts":"2026-08-22T14:33:16.731553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became follower at term 0"} {"level":"info","ts":"2026-08-22T14:33:16.73159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 612d5169b08bb96b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-22T14:33:16.731616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became follower at term 1"} {"level":"info","ts":"2026-08-22T14:33:16.731691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=(7002342510006352235)"} {"level":"warn","ts":"2026-08-22T14:33:16.736856Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-22T14:33:16.739894Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-22T14:33:16.741344Z","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-08-22T14:33:16.743935Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"612d5169b08bb96b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-22T14:33:16.744149Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"612d5169b08bb96b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-22T14:33:16.744179Z","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-08-22T14:33:16.744261Z","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-08-22T14:33:16.744292Z","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-08-22T14:33:16.745249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=(7002342510006352235)"} {"level":"info","ts":"2026-08-22T14:33:16.745446Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"20ec8eafba602517","local-member-id":"612d5169b08bb96b","added-peer-id":"612d5169b08bb96b","added-peer-peer-urls":["https://162.253.55.186:2380"]} {"level":"info","ts":"2026-08-22T14:33:16.746632Z","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-08-22T14:33:16.746828Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"612d5169b08bb96b","initial-advertise-peer-urls":["https://162.253.55.186:2380"],"listen-peer-urls":["https://162.253.55.186:2380"],"advertise-client-urls":["https://162.253.55.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-22T14:33:16.746873Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-22T14:33:16.746827Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.186:2380"} {"level":"info","ts":"2026-08-22T14:33:16.747139Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.186:2380"} {"level":"info","ts":"2026-08-22T14:33:17.032475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b is starting a new election at term 1"} {"level":"info","ts":"2026-08-22T14:33:17.032556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became pre-candidate at term 1"} {"level":"info","ts":"2026-08-22T14:33:17.032588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b received MsgPreVoteResp from 612d5169b08bb96b at term 1"} {"level":"info","ts":"2026-08-22T14:33:17.032609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became candidate at term 2"} {"level":"info","ts":"2026-08-22T14:33:17.03262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b received MsgVoteResp from 612d5169b08bb96b at term 2"} {"level":"info","ts":"2026-08-22T14:33:17.032638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became leader at term 2"} {"level":"info","ts":"2026-08-22T14:33:17.032651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 612d5169b08bb96b elected leader 612d5169b08bb96b at term 2"} {"level":"info","ts":"2026-08-22T14:33:17.034146Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T14:33:17.034345Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"612d5169b08bb96b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.186:2379]}","request-path":"/0/members/612d5169b08bb96b/attributes","cluster-id":"20ec8eafba602517","publish-timeout":"7s"} {"level":"info","ts":"2026-08-22T14:33:17.034361Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T14:33:17.0345Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T14:33:17.034668Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-22T14:33:17.034765Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-22T14:33:17.035341Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"20ec8eafba602517","local-member-id":"612d5169b08bb96b","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T14:33:17.035524Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T14:33:17.035585Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T14:33:17.037832Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-22T14:33:17.039695Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.186:2379"} {"level":"info","ts":"2026-08-22T14:33:59.948406Z","caller":"traceutil/trace.go:171","msg":"trace[108688138] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"227.937046ms","start":"2026-08-22T14:33:59.720438Z","end":"2026-08-22T14:33:59.948375Z","steps":["trace[108688138] 'read index received' (duration: 227.524728ms)","trace[108688138] 'applied index is now lower than readState.Index' (duration: 411.208µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:33:59.948537Z","caller":"traceutil/trace.go:171","msg":"trace[80629661] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"242.604455ms","start":"2026-08-22T14:33:59.70592Z","end":"2026-08-22T14:33:59.948524Z","steps":["trace[80629661] 'process raft request' (duration: 242.299149ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:33:59.948894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.194976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T14:33:59.949032Z","caller":"traceutil/trace.go:171","msg":"trace[1425971523] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"163.423409ms","start":"2026-08-22T14:33:59.78558Z","end":"2026-08-22T14:33:59.949003Z","steps":["trace[1425971523] 'agreement among raft nodes before linearized reading' (duration: 163.130314ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:33:59.949251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.796912ms","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-08-22T14:33:59.949333Z","caller":"traceutil/trace.go:171","msg":"trace[220616854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:593; }","duration":"228.920995ms","start":"2026-08-22T14:33:59.720374Z","end":"2026-08-22T14:33:59.949295Z","steps":["trace[220616854] 'agreement among raft nodes before linearized reading' (duration: 228.65531ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:34:00.425866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.759664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-08-22T14:34:00.425883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.347321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jjq5p\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-22T14:34:00.425976Z","caller":"traceutil/trace.go:171","msg":"trace[692413167] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:594; }","duration":"218.934247ms","start":"2026-08-22T14:34:00.207015Z","end":"2026-08-22T14:34:00.42595Z","steps":["trace[692413167] 'range keys from in-memory index tree' (duration: 218.524859ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:34:00.425989Z","caller":"traceutil/trace.go:171","msg":"trace[2129745184] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jjq5p; range_end:; response_count:1; response_revision:594; }","duration":"194.516944ms","start":"2026-08-22T14:34:00.231451Z","end":"2026-08-22T14:34:00.425968Z","steps":["trace[2129745184] 'range keys from in-memory index tree' (duration: 194.162197ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:34:00.425983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.536025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.186\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-22T14:34:00.426089Z","caller":"traceutil/trace.go:171","msg":"trace[1865848533] range","detail":"{range_begin:/registry/masterleases/162.253.55.186; range_end:; response_count:1; response_revision:594; }","duration":"111.707857ms","start":"2026-08-22T14:34:00.314357Z","end":"2026-08-22T14:34:00.426064Z","steps":["trace[1865848533] 'range keys from in-memory index tree' (duration: 111.40732ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:35:47.93867Z","caller":"traceutil/trace.go:171","msg":"trace[1563636469] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"126.226341ms","start":"2026-08-22T14:35:47.812388Z","end":"2026-08-22T14:35:47.938614Z","steps":["trace[1563636469] 'process raft request' (duration: 117.104651ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:35:48.187756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.169238ms","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-08-22T14:35:48.187854Z","caller":"traceutil/trace.go:171","msg":"trace[1218056396] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1961; }","duration":"127.326183ms","start":"2026-08-22T14:35:48.060504Z","end":"2026-08-22T14:35:48.187831Z","steps":["trace[1218056396] 'range keys from in-memory index tree' (duration: 126.951435ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:18.241092Z","caller":"traceutil/trace.go:171","msg":"trace[914092198] linearizableReadLoop","detail":"{readStateIndex:2215; appliedIndex:2214; }","duration":"167.231289ms","start":"2026-08-22T14:36:18.073833Z","end":"2026-08-22T14:36:18.241064Z","steps":["trace[914092198] 'read index received' (duration: 167.133817ms)","trace[914092198] 'applied index is now lower than readState.Index' (duration: 95.582µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:36:18.241198Z","caller":"traceutil/trace.go:171","msg":"trace[706021660] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"207.993263ms","start":"2026-08-22T14:36:18.033175Z","end":"2026-08-22T14:36:18.241168Z","steps":["trace[706021660] 'process raft request' (duration: 207.713538ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:18.241455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.587687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-22T14:36:18.241603Z","caller":"traceutil/trace.go:171","msg":"trace[1645063796] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2135; }","duration":"167.795741ms","start":"2026-08-22T14:36:18.073777Z","end":"2026-08-22T14:36:18.241573Z","steps":["trace[1645063796] 'agreement among raft nodes before linearized reading' (duration: 167.414214ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:18.372888Z","caller":"traceutil/trace.go:171","msg":"trace[1874288318] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"127.200459ms","start":"2026-08-22T14:36:18.24564Z","end":"2026-08-22T14:36:18.37284Z","steps":["trace[1874288318] 'process raft request' (duration: 117.500608ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:19.086294Z","caller":"traceutil/trace.go:171","msg":"trace[1619783163] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"462.304261ms","start":"2026-08-22T14:36:18.623929Z","end":"2026-08-22T14:36:19.086234Z","steps":["trace[1619783163] 'process raft request' (duration: 461.680628ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:19.086592Z","caller":"traceutil/trace.go:171","msg":"trace[1418645504] linearizableReadLoop","detail":"{readStateIndex:2219; appliedIndex:2218; }","duration":"456.747291ms","start":"2026-08-22T14:36:18.629818Z","end":"2026-08-22T14:36:19.086565Z","steps":["trace[1418645504] 'read index received' (duration: 456.193981ms)","trace[1418645504] 'applied index is now lower than readState.Index' (duration: 551.14µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:36:19.086732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.906625ms","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-08-22T14:36:19.086839Z","caller":"traceutil/trace.go:171","msg":"trace[715169864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2139; }","duration":"457.021397ms","start":"2026-08-22T14:36:18.629792Z","end":"2026-08-22T14:36:19.086814Z","steps":["trace[715169864] 'agreement among raft nodes before linearized reading' (duration: 456.547688ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:19.086884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:36:18.629715Z","time spent":"457.159119ms","remote":"127.0.0.1:33196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-22T14:36:19.087188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:36:18.623898Z","time spent":"462.529726ms","remote":"127.0.0.1:33196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:36:19.147901Z","caller":"traceutil/trace.go:171","msg":"trace[747531640] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"420.501476ms","start":"2026-08-22T14:36:18.727378Z","end":"2026-08-22T14:36:19.147879Z","steps":["trace[747531640] 'process raft request' (duration: 420.18742ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:19.148012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:36:18.72735Z","time spent":"420.602509ms","remote":"127.0.0.1:33196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:36:19.487327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.727186ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:36:19.487548Z","caller":"traceutil/trace.go:171","msg":"trace[182992231] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"395.991953ms","start":"2026-08-22T14:36:19.09154Z","end":"2026-08-22T14:36:19.487532Z","steps":["trace[182992231] 'process raft request' (duration: 140.586253ms)","trace[182992231] 'compare' (duration: 254.317929ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:36:19.487621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:36:19.091512Z","time spent":"396.077425ms","remote":"127.0.0.1:33196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T14:36:19.487887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.783921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-22T14:36:19.487969Z","caller":"traceutil/trace.go:171","msg":"trace[1990477044] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2142; }","duration":"389.917044ms","start":"2026-08-22T14:36:19.098034Z","end":"2026-08-22T14:36:19.487951Z","steps":["trace[1990477044] 'agreement among raft nodes before linearized reading' (duration: 389.603998ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:19.48749Z","caller":"traceutil/trace.go:171","msg":"trace[1737959665] linearizableReadLoop","detail":"{readStateIndex:2222; appliedIndex:2219; }","duration":"389.393463ms","start":"2026-08-22T14:36:19.09808Z","end":"2026-08-22T14:36:19.487474Z","steps":["trace[1737959665] 'read index received' (duration: 49.532998ms)","trace[1737959665] 'applied index is now lower than readState.Index' (duration: 339.858905ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:36:19.488011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:36:19.098017Z","time spent":"389.986185ms","remote":"127.0.0.1:33196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-22T14:36:19.488302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.54905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-22T14:36:19.488386Z","caller":"traceutil/trace.go:171","msg":"trace[1028881436] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2142; }","duration":"262.670003ms","start":"2026-08-22T14:36:19.225697Z","end":"2026-08-22T14:36:19.488367Z","steps":["trace[1028881436] 'agreement among raft nodes before linearized reading' (duration: 262.401657ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:25.766265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.363368ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-22T14:36:25.766386Z","caller":"traceutil/trace.go:171","msg":"trace[2010519757] linearizableReadLoop","detail":"{readStateIndex:2257; appliedIndex:2256; }","duration":"253.260187ms","start":"2026-08-22T14:36:25.513105Z","end":"2026-08-22T14:36:25.766365Z","steps":["trace[2010519757] 'read index received' (duration: 1.717425ms)","trace[2010519757] 'applied index is now lower than readState.Index' (duration: 251.541192ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:36:25.766578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.45817ms","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-08-22T14:36:25.766703Z","caller":"traceutil/trace.go:171","msg":"trace[1357252282] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2174; }","duration":"253.627624ms","start":"2026-08-22T14:36:25.513056Z","end":"2026-08-22T14:36:25.766684Z","steps":["trace[1357252282] 'agreement among raft nodes before linearized reading' (duration: 253.358989ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:25.854936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.001778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-22T14:36:25.854949Z","caller":"traceutil/trace.go:171","msg":"trace[1165781269] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"256.892239ms","start":"2026-08-22T14:36:25.59802Z","end":"2026-08-22T14:36:25.854913Z","steps":["trace[1165781269] 'process raft request' (duration: 256.441501ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:25.854967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.36125ms","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-08-22T14:36:25.855019Z","caller":"traceutil/trace.go:171","msg":"trace[1383287184] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2175; }","duration":"118.134221ms","start":"2026-08-22T14:36:25.736867Z","end":"2026-08-22T14:36:25.855001Z","steps":["trace[1383287184] 'agreement among raft nodes before linearized reading' (duration: 117.874016ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:25.855234Z","caller":"traceutil/trace.go:171","msg":"trace[19220687] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2175; }","duration":"324.488713ms","start":"2026-08-22T14:36:25.530542Z","end":"2026-08-22T14:36:25.855031Z","steps":["trace[19220687] 'agreement among raft nodes before linearized reading' (duration: 324.236218ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:25.855301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:36:25.530524Z","time spent":"324.760607ms","remote":"127.0.0.1:48378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-08-22T14:36:25.855592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.228652ms","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-08-22T14:36:25.855663Z","caller":"traceutil/trace.go:171","msg":"trace[1869809781] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2175; }","duration":"271.341314ms","start":"2026-08-22T14:36:25.584303Z","end":"2026-08-22T14:36:25.855645Z","steps":["trace[1869809781] 'agreement among raft nodes before linearized reading' (duration: 271.026698ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:36:25.874518Z","caller":"traceutil/trace.go:171","msg":"trace[673118895] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"102.865469ms","start":"2026-08-22T14:36:25.771628Z","end":"2026-08-22T14:36:25.874494Z","steps":["trace[673118895] 'process raft request' (duration: 100.760858ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:36:25.874624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.062414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T14:36:25.874698Z","caller":"traceutil/trace.go:171","msg":"trace[602344371] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2179; }","duration":"101.175416ms","start":"2026-08-22T14:36:25.773506Z","end":"2026-08-22T14:36:25.874682Z","steps":["trace[602344371] 'agreement among raft nodes before linearized reading' (duration: 101.028213ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:37:59.645774Z","caller":"traceutil/trace.go:171","msg":"trace[1709659088] transaction","detail":"{read_only:false; response_revision:2875; number_of_response:1; }","duration":"147.891135ms","start":"2026-08-22T14:37:59.497852Z","end":"2026-08-22T14:37:59.645744Z","steps":["trace[1709659088] 'process raft request' (duration: 71.6388ms)","trace[1709659088] 'compare' (duration: 76.085331ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:37:59.663701Z","caller":"traceutil/trace.go:171","msg":"trace[1289924628] transaction","detail":"{read_only:false; response_revision:2876; number_of_response:1; }","duration":"160.018306ms","start":"2026-08-22T14:37:59.503653Z","end":"2026-08-22T14:37:59.663671Z","steps":["trace[1289924628] 'process raft request' (duration: 159.851683ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:40:35.301547Z","caller":"traceutil/trace.go:171","msg":"trace[1693289645] transaction","detail":"{read_only:false; response_revision:3894; number_of_response:1; }","duration":"130.749366ms","start":"2026-08-22T14:40:35.170765Z","end":"2026-08-22T14:40:35.301514Z","steps":["trace[1693289645] 'process raft request' (duration: 130.538601ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:40:35.301695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.062983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-22T14:40:35.301785Z","caller":"traceutil/trace.go:171","msg":"trace[1069269489] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3894; }","duration":"100.209225ms","start":"2026-08-22T14:40:35.201559Z","end":"2026-08-22T14:40:35.301768Z","steps":["trace[1069269489] 'agreement among raft nodes before linearized reading' (duration: 99.94848ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:42:22.212283Z","caller":"traceutil/trace.go:171","msg":"trace[786850045] transaction","detail":"{read_only:false; response_revision:5526; number_of_response:1; }","duration":"212.050173ms","start":"2026-08-22T14:42:22.000202Z","end":"2026-08-22T14:42:22.212252Z","steps":["trace[786850045] 'process raft request' (duration: 211.754597ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:42:22.335712Z","caller":"traceutil/trace.go:171","msg":"trace[1154899738] transaction","detail":"{read_only:false; response_revision:5527; number_of_response:1; }","duration":"117.168324ms","start":"2026-08-22T14:42:22.218414Z","end":"2026-08-22T14:42:22.335582Z","steps":["trace[1154899738] 'process raft request' (duration: 34.567556ms)","trace[1154899738] 'compare' (duration: 82.261191ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:42:22.337254Z","caller":"traceutil/trace.go:171","msg":"trace[1919161608] transaction","detail":"{read_only:false; response_revision:5528; number_of_response:1; }","duration":"118.628994ms","start":"2026-08-22T14:42:22.218597Z","end":"2026-08-22T14:42:22.337226Z","steps":["trace[1919161608] 'process raft request' (duration: 118.358538ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:42:22.337494Z","caller":"traceutil/trace.go:171","msg":"trace[325826094] transaction","detail":"{read_only:false; response_revision:5529; number_of_response:1; }","duration":"118.350978ms","start":"2026-08-22T14:42:22.219095Z","end":"2026-08-22T14:42:22.337446Z","steps":["trace[325826094] 'process raft request' (duration: 118.009991ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:42:22.337812Z","caller":"traceutil/trace.go:171","msg":"trace[616521484] transaction","detail":"{read_only:false; response_revision:5530; number_of_response:1; }","duration":"118.493611ms","start":"2026-08-22T14:42:22.219297Z","end":"2026-08-22T14:42:22.33779Z","steps":["trace[616521484] 'process raft request' (duration: 117.877219ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:42:22.338337Z","caller":"traceutil/trace.go:171","msg":"trace[1063304674] linearizableReadLoop","detail":"{readStateIndex:5733; appliedIndex:5728; }","duration":"118.227276ms","start":"2026-08-22T14:42:22.220082Z","end":"2026-08-22T14:42:22.338309Z","steps":["trace[1063304674] 'read index received' (duration: 33.036546ms)","trace[1063304674] 'applied index is now lower than readState.Index' (duration: 85.18918ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:42:22.338387Z","caller":"traceutil/trace.go:171","msg":"trace[2099423975] transaction","detail":"{read_only:false; response_revision:5532; number_of_response:1; }","duration":"115.952149ms","start":"2026-08-22T14:42:22.222413Z","end":"2026-08-22T14:42:22.338365Z","steps":["trace[2099423975] 'process raft request' (duration: 115.751855ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:42:22.338521Z","caller":"traceutil/trace.go:171","msg":"trace[1685648927] transaction","detail":"{read_only:false; response_revision:5531; number_of_response:1; }","duration":"119.000901ms","start":"2026-08-22T14:42:22.219503Z","end":"2026-08-22T14:42:22.338504Z","steps":["trace[1685648927] 'process raft request' (duration: 118.214685ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:42:22.33866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.820496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-22T14:42:22.338665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.554113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-29f9f4db-3b37-494b-b80d-9ff1444de3ed\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-08-22T14:42:22.338767Z","caller":"traceutil/trace.go:171","msg":"trace[1094333079] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-29f9f4db-3b37-494b-b80d-9ff1444de3ed; range_end:; response_count:1; response_revision:5532; }","duration":"118.718816ms","start":"2026-08-22T14:42:22.220026Z","end":"2026-08-22T14:42:22.338745Z","steps":["trace[1094333079] 'agreement among raft nodes before linearized reading' (duration: 118.461371ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:42:22.33872Z","caller":"traceutil/trace.go:171","msg":"trace[796869933] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5532; }","duration":"115.940739ms","start":"2026-08-22T14:42:22.222764Z","end":"2026-08-22T14:42:22.338705Z","steps":["trace[796869933] 'agreement among raft nodes before linearized reading' (duration: 115.794026ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:42:22.64877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.595629ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T14:42:22.648983Z","caller":"traceutil/trace.go:171","msg":"trace[785098981] transaction","detail":"{read_only:false; response_revision:5535; number_of_response:1; }","duration":"301.157164ms","start":"2026-08-22T14:42:22.347807Z","end":"2026-08-22T14:42:22.648964Z","steps":["trace[785098981] 'process raft request' (duration: 301.074222ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:42:22.649064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:42:22.347782Z","time spent":"301.244315ms","remote":"127.0.0.1:33118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:42:22.649112Z","caller":"traceutil/trace.go:171","msg":"trace[2021710629] transaction","detail":"{read_only:false; response_revision:5534; number_of_response:1; }","duration":"304.166225ms","start":"2026-08-22T14:42:22.344909Z","end":"2026-08-22T14:42:22.649075Z","steps":["trace[2021710629] 'process raft request' (duration: 148.176168ms)","trace[2021710629] 'compare' (duration: 155.435116ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:42:22.649294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:42:22.344895Z","time spent":"304.295317ms","remote":"127.0.0.1:33196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:42:22.703706Z","caller":"traceutil/trace.go:171","msg":"trace[1559051036] transaction","detail":"{read_only:false; response_revision:5536; number_of_response:1; }","duration":"328.35097ms","start":"2026-08-22T14:42:22.375329Z","end":"2026-08-22T14:42:22.70368Z","steps":["trace[1559051036] 'process raft request' (duration: 328.160306ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:42:22.703862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T14:42:22.375313Z","time spent":"328.471053ms","remote":"127.0.0.1:33196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T14:42:22.70412Z","caller":"traceutil/trace.go:171","msg":"trace[1806208132] transaction","detail":"{read_only:false; response_revision:5537; number_of_response:1; }","duration":"238.403042ms","start":"2026-08-22T14:42:22.465642Z","end":"2026-08-22T14:42:22.704045Z","steps":["trace[1806208132] 'process raft request' (duration: 237.982514ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:42:22.81893Z","caller":"traceutil/trace.go:171","msg":"trace[66771135] transaction","detail":"{read_only:false; response_revision:5538; number_of_response:1; }","duration":"107.126049ms","start":"2026-08-22T14:42:22.711764Z","end":"2026-08-22T14:42:22.81889Z","steps":["trace[66771135] 'process raft request' (duration: 90.751264ms)","trace[66771135] 'compare' (duration: 16.184661ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:42:22.818984Z","caller":"traceutil/trace.go:171","msg":"trace[1168962816] transaction","detail":"{read_only:false; response_revision:5539; number_of_response:1; }","duration":"103.354312ms","start":"2026-08-22T14:42:22.715596Z","end":"2026-08-22T14:42:22.818951Z","steps":["trace[1168962816] 'process raft request' (duration: 103.22977ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:43:17.270694Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2971} {"level":"info","ts":"2026-08-22T14:43:17.34695Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2971,"took":"74.881646ms","hash":1236250330,"current-db-size-bytes":59301888,"current-db-size":"59 MB","current-db-size-in-use-bytes":33910784,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-22T14:43:17.347023Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1236250330,"revision":2971,"compact-revision":-1} {"level":"info","ts":"2026-08-22T14:48:17.276893Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6028} {"level":"info","ts":"2026-08-22T14:48:17.372706Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6028,"took":"93.506811ms","hash":3234001131,"current-db-size-bytes":59301888,"current-db-size":"59 MB","current-db-size-in-use-bytes":21360640,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-08-22T14:48:17.372796Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3234001131,"revision":6028,"compact-revision":2971} {"level":"info","ts":"2026-08-22T14:48:42.276876Z","caller":"traceutil/trace.go:171","msg":"trace[1674740166] transaction","detail":"{read_only:false; response_revision:8399; number_of_response:1; }","duration":"275.593715ms","start":"2026-08-22T14:48:42.001258Z","end":"2026-08-22T14:48:42.276852Z","steps":["trace[1674740166] 'process raft request' (duration: 275.447463ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:48:42.296862Z","caller":"traceutil/trace.go:171","msg":"trace[1511549593] transaction","detail":"{read_only:false; response_revision:8402; number_of_response:1; }","duration":"189.985474ms","start":"2026-08-22T14:48:42.10686Z","end":"2026-08-22T14:48:42.296845Z","steps":["trace[1511549593] 'process raft request' (duration: 189.911142ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:48:42.296871Z","caller":"traceutil/trace.go:171","msg":"trace[419936711] transaction","detail":"{read_only:false; response_revision:8401; number_of_response:1; }","duration":"292.563289ms","start":"2026-08-22T14:48:42.00427Z","end":"2026-08-22T14:48:42.296833Z","steps":["trace[419936711] 'process raft request' (duration: 292.453367ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:48:42.297107Z","caller":"traceutil/trace.go:171","msg":"trace[1110204709] transaction","detail":"{read_only:false; response_revision:8400; number_of_response:1; }","duration":"294.853765ms","start":"2026-08-22T14:48:42.002236Z","end":"2026-08-22T14:48:42.29709Z","steps":["trace[1110204709] 'process raft request' (duration: 294.377415ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:48:42.297537Z","caller":"traceutil/trace.go:171","msg":"trace[1045485902] linearizableReadLoop","detail":"{readStateIndex:8699; appliedIndex:8695; }","duration":"136.969837ms","start":"2026-08-22T14:48:42.160535Z","end":"2026-08-22T14:48:42.297505Z","steps":["trace[1045485902] 'read index received' (duration: 116.189078ms)","trace[1045485902] 'applied index is now lower than readState.Index' (duration: 20.779669ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T14:48:42.297758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.210311ms","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-08-22T14:48:42.297804Z","caller":"traceutil/trace.go:171","msg":"trace[1962072094] 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:8404; }","duration":"137.305294ms","start":"2026-08-22T14:48:42.160484Z","end":"2026-08-22T14:48:42.297789Z","steps":["trace[1962072094] 'agreement among raft nodes before linearized reading' (duration: 137.14069ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:48:54.930435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.017012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-22T14:48:54.930538Z","caller":"traceutil/trace.go:171","msg":"trace[2128113707] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:8468; }","duration":"106.143245ms","start":"2026-08-22T14:48:54.824369Z","end":"2026-08-22T14:48:54.930512Z","steps":["trace[2128113707] 'count revisions from in-memory index tree' (duration: 105.905431ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:49:22.65546Z","caller":"traceutil/trace.go:171","msg":"trace[514222201] transaction","detail":"{read_only:false; response_revision:8669; number_of_response:1; }","duration":"157.5683ms","start":"2026-08-22T14:49:22.497865Z","end":"2026-08-22T14:49:22.655433Z","steps":["trace[514222201] 'process raft request' (duration: 157.430028ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:49:22.677673Z","caller":"traceutil/trace.go:171","msg":"trace[864148844] transaction","detail":"{read_only:false; response_revision:8670; number_of_response:1; }","duration":"177.749367ms","start":"2026-08-22T14:49:22.499912Z","end":"2026-08-22T14:49:22.677661Z","steps":["trace[864148844] 'process raft request' (duration: 177.665215ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:49:22.677773Z","caller":"traceutil/trace.go:171","msg":"trace[1940008915] linearizableReadLoop","detail":"{readStateIndex:8978; appliedIndex:8976; }","duration":"135.211961ms","start":"2026-08-22T14:49:22.542555Z","end":"2026-08-22T14:49:22.677767Z","steps":["trace[1940008915] 'read index received' (duration: 113.28132ms)","trace[1940008915] 'applied index is now lower than readState.Index' (duration: 21.929451ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:49:22.677844Z","caller":"traceutil/trace.go:171","msg":"trace[589970127] transaction","detail":"{read_only:false; response_revision:8671; number_of_response:1; }","duration":"168.344268ms","start":"2026-08-22T14:49:22.509493Z","end":"2026-08-22T14:49:22.677838Z","steps":["trace[589970127] 'process raft request' (duration: 168.140254ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:49:22.677978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.408135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-08-22T14:49:22.678006Z","caller":"traceutil/trace.go:171","msg":"trace[1418686445] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8671; }","duration":"135.475095ms","start":"2026-08-22T14:49:22.542525Z","end":"2026-08-22T14:49:22.678Z","steps":["trace[1418686445] 'agreement among raft nodes before linearized reading' (duration: 135.375564ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:49:22.678155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.564047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-22T14:49:22.67818Z","caller":"traceutil/trace.go:171","msg":"trace[1499330812] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8671; }","duration":"135.595958ms","start":"2026-08-22T14:49:22.542578Z","end":"2026-08-22T14:49:22.678174Z","steps":["trace[1499330812] 'agreement among raft nodes before linearized reading' (duration: 135.536167ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:49:22.678354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.740592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-22T14:49:22.678379Z","caller":"traceutil/trace.go:171","msg":"trace[193350209] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8671; }","duration":"135.780333ms","start":"2026-08-22T14:49:22.542592Z","end":"2026-08-22T14:49:22.678373Z","steps":["trace[193350209] 'agreement among raft nodes before linearized reading' (duration: 135.707981ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T14:49:22.678468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.757153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-22T14:49:22.678553Z","caller":"traceutil/trace.go:171","msg":"trace[383054242] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8671; }","duration":"135.870275ms","start":"2026-08-22T14:49:22.542662Z","end":"2026-08-22T14:49:22.678533Z","steps":["trace[383054242] 'agreement among raft nodes before linearized reading' (duration: 135.61955ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:49:32.707332Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002349.wal"} {"level":"info","ts":"2026-08-22T14:49:34.845849Z","caller":"traceutil/trace.go:171","msg":"trace[1432798550] transaction","detail":"{read_only:false; response_revision:8733; number_of_response:1; }","duration":"129.846483ms","start":"2026-08-22T14:49:34.715964Z","end":"2026-08-22T14:49:34.84581Z","steps":["trace[1432798550] 'process raft request' (duration: 106.959832ms)","trace[1432798550] 'compare' (duration: 22.691957ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:49:34.846082Z","caller":"traceutil/trace.go:171","msg":"trace[1098130653] transaction","detail":"{read_only:false; response_revision:8734; number_of_response:1; }","duration":"111.647647ms","start":"2026-08-22T14:49:34.734389Z","end":"2026-08-22T14:49:34.846036Z","steps":["trace[1098130653] 'process raft request' (duration: 111.363741ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:49:35.10777Z","caller":"traceutil/trace.go:171","msg":"trace[1559077132] transaction","detail":"{read_only:false; response_revision:8735; number_of_response:1; }","duration":"256.331378ms","start":"2026-08-22T14:49:34.851383Z","end":"2026-08-22T14:49:35.107714Z","steps":["trace[1559077132] 'process raft request' (duration: 172.548973ms)","trace[1559077132] 'compare' (duration: 83.52072ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T14:49:35.135827Z","caller":"traceutil/trace.go:171","msg":"trace[69743400] transaction","detail":"{read_only:false; response_revision:8736; number_of_response:1; }","duration":"284.067757ms","start":"2026-08-22T14:49:34.851715Z","end":"2026-08-22T14:49:35.135783Z","steps":["trace[69743400] 'process raft request' (duration: 283.822882ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:49:35.135839Z","caller":"traceutil/trace.go:171","msg":"trace[2022280055] transaction","detail":"{read_only:false; response_revision:8737; number_of_response:1; }","duration":"283.966124ms","start":"2026-08-22T14:49:34.85183Z","end":"2026-08-22T14:49:35.135796Z","steps":["trace[2022280055] 'process raft request' (duration: 283.848602ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:49:35.136009Z","caller":"traceutil/trace.go:171","msg":"trace[1532728230] transaction","detail":"{read_only:false; response_revision:8738; number_of_response:1; }","duration":"283.779292ms","start":"2026-08-22T14:49:34.852212Z","end":"2026-08-22T14:49:35.135991Z","steps":["trace[1532728230] 'process raft request' (duration: 283.529276ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:49:35.136206Z","caller":"traceutil/trace.go:171","msg":"trace[1401983995] transaction","detail":"{read_only:false; response_revision:8739; number_of_response:1; }","duration":"283.70317ms","start":"2026-08-22T14:49:34.852493Z","end":"2026-08-22T14:49:35.136196Z","steps":["trace[1401983995] 'process raft request' (duration: 283.443645ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:51:03.215098Z","caller":"traceutil/trace.go:171","msg":"trace[621833613] transaction","detail":"{read_only:false; response_revision:9583; number_of_response:1; }","duration":"153.883217ms","start":"2026-08-22T14:51:03.06118Z","end":"2026-08-22T14:51:03.215063Z","steps":["trace[621833613] 'process raft request' (duration: 153.663952ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T14:51:11.80224Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"612d5169b08bb96b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-22T14:51:11.807827Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-22T14:51:11.807942Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-22T14:53:17.283643Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8091} {"level":"info","ts":"2026-08-22T14:53:17.345974Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8091,"took":"60.005396ms","hash":3378468557,"current-db-size-bytes":59301888,"current-db-size":"59 MB","current-db-size-in-use-bytes":27852800,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-22T14:53:17.346038Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3378468557,"revision":8091,"compact-revision":6028} {"level":"info","ts":"2026-08-22T14:58:17.289666Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10494} {"level":"info","ts":"2026-08-22T14:58:17.371265Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10494,"took":"78.951537ms","hash":1324394038,"current-db-size-bytes":59301888,"current-db-size":"59 MB","current-db-size-in-use-bytes":26406912,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-08-22T14:58:17.371348Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1324394038,"revision":10494,"compact-revision":8091} {"level":"info","ts":"2026-08-22T15:03:17.296587Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12655} {"level":"info","ts":"2026-08-22T15:03:17.374251Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12655,"took":"74.581133ms","hash":492579720,"current-db-size-bytes":59301888,"current-db-size":"59 MB","current-db-size-in-use-bytes":27164672,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-08-22T15:03:17.374311Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":492579720,"revision":12655,"compact-revision":10494} {"level":"info","ts":"2026-08-22T15:03:20.664287Z","caller":"traceutil/trace.go:171","msg":"trace[80368181] transaction","detail":"{read_only:false; response_revision:14680; number_of_response:1; }","duration":"155.054457ms","start":"2026-08-22T15:03:20.509192Z","end":"2026-08-22T15:03:20.664246Z","steps":["trace[80368181] 'process raft request' (duration: 154.940814ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T15:03:20.664558Z","caller":"traceutil/trace.go:171","msg":"trace[2060141177] transaction","detail":"{read_only:false; response_revision:14679; number_of_response:1; }","duration":"204.666856ms","start":"2026-08-22T15:03:20.459876Z","end":"2026-08-22T15:03:20.664542Z","steps":["trace[2060141177] 'process raft request' (duration: 132.008612ms)","trace[2060141177] 'compare' (duration: 71.938579ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T15:03:42.574786Z","caller":"traceutil/trace.go:171","msg":"trace[523264722] linearizableReadLoop","detail":"{readStateIndex:15517; appliedIndex:15516; }","duration":"273.766586ms","start":"2026-08-22T15:03:42.300991Z","end":"2026-08-22T15:03:42.574758Z","steps":["trace[523264722] 'read index received' (duration: 273.499051ms)","trace[523264722] 'applied index is now lower than readState.Index' (duration: 266.435µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T15:03:42.574903Z","caller":"traceutil/trace.go:171","msg":"trace[1075260862] transaction","detail":"{read_only:false; response_revision:14991; number_of_response:1; }","duration":"313.299508ms","start":"2026-08-22T15:03:42.261554Z","end":"2026-08-22T15:03:42.574854Z","steps":["trace[1075260862] 'process raft request' (duration: 313.005542ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T15:03:42.575203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T15:03:42.261534Z","time spent":"313.501063ms","remote":"127.0.0.1:33118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3742,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T15:03:42.575888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.869968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-22T15:03:42.575991Z","caller":"traceutil/trace.go:171","msg":"trace[1712998454] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:14991; }","duration":"274.997461ms","start":"2026-08-22T15:03:42.300973Z","end":"2026-08-22T15:03:42.57597Z","steps":["trace[1712998454] 'agreement among raft nodes before linearized reading' (duration: 273.898699ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T15:08:17.302896Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14644} {"level":"info","ts":"2026-08-22T15:08:17.379195Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14644,"took":"73.097062ms","hash":1159129358,"current-db-size-bytes":59301888,"current-db-size":"59 MB","current-db-size-in-use-bytes":34406400,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-22T15:08:17.379251Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1159129358,"revision":14644,"compact-revision":12655} {"level":"info","ts":"2026-08-22T15:11:21.948824Z","caller":"traceutil/trace.go:171","msg":"trace[1073904483] transaction","detail":"{read_only:false; response_revision:18551; number_of_response:1; }","duration":"113.192326ms","start":"2026-08-22T15:11:21.83558Z","end":"2026-08-22T15:11:21.948772Z","steps":["trace[1073904483] 'process raft request' (duration: 86.694082ms)","trace[1073904483] 'compare' (duration: 26.27301ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T15:11:21.949007Z","caller":"traceutil/trace.go:171","msg":"trace[310143297] transaction","detail":"{read_only:false; response_revision:18552; number_of_response:1; }","duration":"113.367241ms","start":"2026-08-22T15:11:21.835613Z","end":"2026-08-22T15:11:21.948981Z","steps":["trace[310143297] 'process raft request' (duration: 113.071485ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T15:11:22.101915Z","caller":"traceutil/trace.go:171","msg":"trace[1998639878] transaction","detail":"{read_only:false; response_revision:18554; number_of_response:1; }","duration":"132.784868ms","start":"2026-08-22T15:11:21.969089Z","end":"2026-08-22T15:11:22.101873Z","steps":["trace[1998639878] 'process raft request' (duration: 99.901783ms)","trace[1998639878] 'compare' (duration: 32.717772ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T15:12:34.345999Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"612d5169b08bb96b","local-member-applied-index":20003,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-22T15:12:34.352172Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20003} {"level":"info","ts":"2026-08-22T15:12:34.352258Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15003} {"level":"info","ts":"2026-08-22T15:13:17.309619Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17355} {"level":"info","ts":"2026-08-22T15:13:17.422376Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17355,"took":"109.181584ms","hash":1772139652,"current-db-size-bytes":59301888,"current-db-size":"59 MB","current-db-size-in-use-bytes":35176448,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-08-22T15:13:17.422436Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1772139652,"revision":17355,"compact-revision":14644} {"level":"info","ts":"2026-08-22T15:17:56.021702Z","caller":"traceutil/trace.go:171","msg":"trace[465516920] linearizableReadLoop","detail":"{readStateIndex:22219; appliedIndex:22218; }","duration":"197.146381ms","start":"2026-08-22T15:17:55.824529Z","end":"2026-08-22T15:17:56.021676Z","steps":["trace[465516920] 'read index received' (duration: 196.795124ms)","trace[465516920] 'applied index is now lower than readState.Index' (duration: 350.387µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T15:17:56.021812Z","caller":"traceutil/trace.go:171","msg":"trace[1475812493] transaction","detail":"{read_only:false; response_revision:21482; number_of_response:1; }","duration":"209.52197ms","start":"2026-08-22T15:17:55.812253Z","end":"2026-08-22T15:17:56.021775Z","steps":["trace[1475812493] 'process raft request' (duration: 209.161613ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T15:17:56.021929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.364615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-22T15:17:56.021984Z","caller":"traceutil/trace.go:171","msg":"trace[1469061743] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:21482; }","duration":"197.465737ms","start":"2026-08-22T15:17:55.824502Z","end":"2026-08-22T15:17:56.021968Z","steps":["trace[1469061743] 'agreement among raft nodes before linearized reading' (duration: 197.348345ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T15:17:56.022537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.664539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-22T15:17:56.0226Z","caller":"traceutil/trace.go:171","msg":"trace[358208657] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21482; }","duration":"180.74232ms","start":"2026-08-22T15:17:55.841838Z","end":"2026-08-22T15:17:56.022581Z","steps":["trace[358208657] 'agreement among raft nodes before linearized reading' (duration: 180.576667ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T15:17:56.022699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.542316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-08-22T15:17:56.022813Z","caller":"traceutil/trace.go:171","msg":"trace[1452251029] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21482; }","duration":"178.698759ms","start":"2026-08-22T15:17:55.844085Z","end":"2026-08-22T15:17:56.022784Z","steps":["trace[1452251029] 'agreement among raft nodes before linearized reading' (duration: 178.368603ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T15:17:56.217629Z","caller":"traceutil/trace.go:171","msg":"trace[109182311] linearizableReadLoop","detail":"{readStateIndex:22221; appliedIndex:22219; }","duration":"130.695039ms","start":"2026-08-22T15:17:56.086912Z","end":"2026-08-22T15:17:56.217607Z","steps":["trace[109182311] 'read index received' (duration: 56.812277ms)","trace[109182311] 'applied index is now lower than readState.Index' (duration: 73.881922ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T15:17:56.217679Z","caller":"traceutil/trace.go:171","msg":"trace[1581594302] transaction","detail":"{read_only:false; response_revision:21484; number_of_response:1; }","duration":"190.305363ms","start":"2026-08-22T15:17:56.027335Z","end":"2026-08-22T15:17:56.21764Z","steps":["trace[1581594302] 'process raft request' (duration: 190.190931ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T15:17:56.217689Z","caller":"traceutil/trace.go:171","msg":"trace[523626936] transaction","detail":"{read_only:false; response_revision:21483; number_of_response:1; }","duration":"190.979987ms","start":"2026-08-22T15:17:56.026665Z","end":"2026-08-22T15:17:56.217645Z","steps":["trace[523626936] 'process raft request' (duration: 117.101005ms)","trace[523626936] 'compare' (duration: 73.437963ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T15:17:56.217855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.963444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-08-22T15:17:56.217843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.915423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-08-22T15:17:56.217948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.359042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-08-22T15:17:56.217934Z","caller":"traceutil/trace.go:171","msg":"trace[754418885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21484; }","duration":"131.057826ms","start":"2026-08-22T15:17:56.086853Z","end":"2026-08-22T15:17:56.217911Z","steps":["trace[754418885] 'agreement among raft nodes before linearized reading' (duration: 130.819681ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T15:17:56.21797Z","caller":"traceutil/trace.go:171","msg":"trace[1032510698] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21484; }","duration":"126.400593ms","start":"2026-08-22T15:17:56.091563Z","end":"2026-08-22T15:17:56.217964Z","steps":["trace[1032510698] 'agreement among raft nodes before linearized reading' (duration: 126.339972ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T15:17:56.217888Z","caller":"traceutil/trace.go:171","msg":"trace[1089349516] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21484; }","duration":"130.057306ms","start":"2026-08-22T15:17:56.087818Z","end":"2026-08-22T15:17:56.217876Z","steps":["trace[1089349516] 'agreement among raft nodes before linearized reading' (duration: 129.913773ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T15:17:56.491673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.70049ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-22T15:17:56.491822Z","caller":"traceutil/trace.go:171","msg":"trace[2145206221] linearizableReadLoop","detail":"{readStateIndex:22224; appliedIndex:22222; }","duration":"162.659255ms","start":"2026-08-22T15:17:56.329148Z","end":"2026-08-22T15:17:56.491807Z","steps":["trace[2145206221] 'read index received' (duration: 31.579758ms)","trace[2145206221] 'applied index is now lower than readState.Index' (duration: 131.078537ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T15:17:56.491917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.770487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-22T15:17:56.49192Z","caller":"traceutil/trace.go:171","msg":"trace[1170612478] transaction","detail":"{read_only:false; response_revision:21486; number_of_response:1; }","duration":"268.585894ms","start":"2026-08-22T15:17:56.223312Z","end":"2026-08-22T15:17:56.491898Z","steps":["trace[1170612478] 'process raft request' (duration: 137.586178ms)","trace[1170612478] 'compare' (duration: 130.594908ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T15:17:56.491944Z","caller":"traceutil/trace.go:171","msg":"trace[408095598] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:21487; }","duration":"162.834958ms","start":"2026-08-22T15:17:56.329097Z","end":"2026-08-22T15:17:56.491932Z","steps":["trace[408095598] 'agreement among raft nodes before linearized reading' (duration: 162.754237ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T15:17:56.491932Z","caller":"traceutil/trace.go:171","msg":"trace[1832784403] transaction","detail":"{read_only:false; response_revision:21487; number_of_response:1; }","duration":"268.480282ms","start":"2026-08-22T15:17:56.223415Z","end":"2026-08-22T15:17:56.491895Z","steps":["trace[1832784403] 'process raft request' (duration: 268.343909ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T15:17:57.303277Z","caller":"traceutil/trace.go:171","msg":"trace[409226275] transaction","detail":"{read_only:false; response_revision:21488; number_of_response:1; }","duration":"130.660929ms","start":"2026-08-22T15:17:57.172586Z","end":"2026-08-22T15:17:57.303247Z","steps":["trace[409226275] 'process raft request' (duration: 130.490386ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T15:17:57.329329Z","caller":"traceutil/trace.go:171","msg":"trace[1837705660] linearizableReadLoop","detail":"{readStateIndex:22226; appliedIndex:22224; }","duration":"150.010359ms","start":"2026-08-22T15:17:57.179294Z","end":"2026-08-22T15:17:57.329304Z","steps":["trace[1837705660] 'read index received' (duration: 123.734169ms)","trace[1837705660] 'applied index is now lower than readState.Index' (duration: 26.27534ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T15:17:57.329483Z","caller":"traceutil/trace.go:171","msg":"trace[1697230633] transaction","detail":"{read_only:false; response_revision:21490; number_of_response:1; }","duration":"148.866416ms","start":"2026-08-22T15:17:57.180592Z","end":"2026-08-22T15:17:57.329458Z","steps":["trace[1697230633] 'process raft request' (duration: 148.672963ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T15:17:57.329488Z","caller":"traceutil/trace.go:171","msg":"trace[998846438] transaction","detail":"{read_only:false; response_revision:21489; number_of_response:1; }","duration":"150.272114ms","start":"2026-08-22T15:17:57.179113Z","end":"2026-08-22T15:17:57.329385Z","steps":["trace[998846438] 'process raft request' (duration: 150.043609ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T15:17:57.329671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.290765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-22T15:17:57.330236Z","caller":"traceutil/trace.go:171","msg":"trace[1422216689] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21490; }","duration":"150.934677ms","start":"2026-08-22T15:17:57.17923Z","end":"2026-08-22T15:17:57.330164Z","steps":["trace[1422216689] 'agreement among raft nodes before linearized reading' (duration: 150.271544ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T15:18:17.19821Z","caller":"traceutil/trace.go:171","msg":"trace[2143310114] transaction","detail":"{read_only:false; response_revision:21595; number_of_response:1; }","duration":"140.940077ms","start":"2026-08-22T15:18:17.057233Z","end":"2026-08-22T15:18:17.198173Z","steps":["trace[2143310114] 'process raft request' (duration: 140.781474ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T15:18:17.316324Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19671} {"level":"info","ts":"2026-08-22T15:18:17.423771Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19671,"took":"104.122643ms","hash":3547344203,"current-db-size-bytes":59301888,"current-db-size":"59 MB","current-db-size-in-use-bytes":28180480,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-22T15:18:17.423844Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3547344203,"revision":19671,"compact-revision":17355} {"level":"info","ts":"2026-08-22T15:23:17.32266Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21596} {"level":"info","ts":"2026-08-22T15:23:17.429102Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21596,"took":"102.041262ms","hash":893512482,"current-db-size-bytes":59301888,"current-db-size":"59 MB","current-db-size-in-use-bytes":43528192,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-08-22T15:23:17.429175Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":893512482,"revision":21596,"compact-revision":19671} {"level":"info","ts":"2026-08-22T15:26:37.000817Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006a81.wal"} {"level":"info","ts":"2026-08-22T15:28:17.328861Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24866} {"level":"info","ts":"2026-08-22T15:28:17.469557Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24866,"took":"137.249495ms","hash":3901293999,"current-db-size-bytes":59301888,"current-db-size":"59 MB","current-db-size-in-use-bytes":31666176,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-22T15:28:17.469634Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3901293999,"revision":24866,"compact-revision":21596}