{"level":"warn","ts":"2026-05-05T22:08:29.063842Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T22:08:29.06395Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115: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://199.204.45.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115: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-05-05T22:08:29.064028Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T22:08:29.064042Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-05-05T22:08:29.064063Z","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-05-05T22:08:29.064927Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]} {"level":"info","ts":"2026-05-05T22:08:29.065019Z","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://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115: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-05-05T22:08:29.069204Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.91379ms"} {"level":"info","ts":"2026-05-05T22:08:29.074901Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"} {"level":"info","ts":"2026-05-05T22:08:29.074993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T22:08:29.075082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"} {"level":"info","ts":"2026-05-05T22:08:29.075109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T22:08:29.075468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"} {"level":"info","ts":"2026-05-05T22:08:29.075542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"warn","ts":"2026-05-05T22:08:29.081406Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T22:08:29.08448Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T22:08:29.085688Z","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-05-05T22:08:29.087537Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T22:08:29.087754Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T22:08:29.087956Z","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-05-05T22:08:29.088247Z","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-05-05T22:08:29.088315Z","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-05-05T22:08:29.088616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"info","ts":"2026-05-05T22:08:29.089149Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-05-05T22:08:29.092392Z","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-05-05T22:08:29.092499Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-05-05T22:08:29.09257Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-05-05T22:08:29.092856Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T22:08:29.092895Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T22:08:29.776776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T22:08:29.776838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T22:08:29.776892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"} {"level":"info","ts":"2026-05-05T22:08:29.77694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"} {"level":"info","ts":"2026-05-05T22:08:29.77696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-05-05T22:08:29.776983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"} {"level":"info","ts":"2026-05-05T22:08:29.777012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-05-05T22:08:29.778058Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T22:08:29.779031Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T22:08:29.77905Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T22:08:29.779299Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T22:08:29.779411Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T22:08:29.77959Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T22:08:29.779637Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T22:08:29.782553Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"} {"level":"info","ts":"2026-05-05T22:08:29.782911Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T22:08:29.787066Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T22:08:29.787139Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T22:08:36.290594Z","caller":"traceutil/trace.go:171","msg":"trace[204688275] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"115.393877ms","start":"2026-05-05T22:08:36.175175Z","end":"2026-05-05T22:08:36.290569Z","steps":["trace[204688275] 'process raft request' (duration: 115.281585ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:08:36.688769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.044867ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T22:08:36.689116Z","caller":"traceutil/trace.go:171","msg":"trace[2067359716] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"364.353752ms","start":"2026-05-05T22:08:36.324745Z","end":"2026-05-05T22:08:36.689099Z","steps":["trace[2067359716] 'process raft request' (duration: 150.571625ms)","trace[2067359716] 'compare' (duration: 212.911956ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:08:36.689186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:08:36.324725Z","time spent":"364.439653ms","remote":"127.0.0.1:42606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":205,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T22:08:36.921631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.566649ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T22:08:36.921858Z","caller":"traceutil/trace.go:171","msg":"trace[1792032097] linearizableReadLoop","detail":"{readStateIndex:286; appliedIndex:285; }","duration":"226.261213ms","start":"2026-05-05T22:08:36.695569Z","end":"2026-05-05T22:08:36.92183Z","steps":["trace[1792032097] 'read index received' (duration: 101.018855ms)","trace[1792032097] 'applied index is now lower than readState.Index' (duration: 125.240168ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:08:36.922Z","caller":"traceutil/trace.go:171","msg":"trace[2137691622] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"228.809028ms","start":"2026-05-05T22:08:36.693086Z","end":"2026-05-05T22:08:36.921895Z","steps":["trace[2137691622] 'process raft request' (duration: 103.56067ms)","trace[2137691622] 'compare' (duration: 124.380267ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:08:36.922103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.039984ms","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-05-05T22:08:36.92217Z","caller":"traceutil/trace.go:171","msg":"trace[625021673] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:279; }","duration":"188.144025ms","start":"2026-05-05T22:08:36.734007Z","end":"2026-05-05T22:08:36.922151Z","steps":["trace[625021673] 'agreement among raft nodes before linearized reading' (duration: 188.027104ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:08:36.922063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.459386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-05T22:08:36.922299Z","caller":"traceutil/trace.go:171","msg":"trace[1785412785] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:279; }","duration":"226.72469ms","start":"2026-05-05T22:08:36.695545Z","end":"2026-05-05T22:08:36.92227Z","steps":["trace[1785412785] 'agreement among raft nodes before linearized reading' (duration: 226.408766ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:09:06.528041Z","caller":"traceutil/trace.go:171","msg":"trace[1927759580] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"171.78798ms","start":"2026-05-05T22:09:06.35622Z","end":"2026-05-05T22:09:06.528008Z","steps":["trace[1927759580] 'process raft request' (duration: 170.986702ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:09:07.008211Z","caller":"traceutil/trace.go:171","msg":"trace[484774212] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:597; }","duration":"314.07576ms","start":"2026-05-05T22:09:06.694099Z","end":"2026-05-05T22:09:07.008174Z","steps":["trace[484774212] 'read index received' (duration: 313.893588ms)","trace[484774212] 'applied index is now lower than readState.Index' (duration: 181.432µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:09:07.008299Z","caller":"traceutil/trace.go:171","msg":"trace[1250844948] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"421.091497ms","start":"2026-05-05T22:09:06.587175Z","end":"2026-05-05T22:09:07.008267Z","steps":["trace[1250844948] 'process raft request' (duration: 420.840585ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:09:07.008485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.572194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T22:09:07.008569Z","caller":"traceutil/trace.go:171","msg":"trace[518559905] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"117.686725ms","start":"2026-05-05T22:09:06.890864Z","end":"2026-05-05T22:09:07.008551Z","steps":["trace[518559905] 'agreement among raft nodes before linearized reading' (duration: 117.506663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:09:07.008489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.373152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zgfst\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-05T22:09:07.008663Z","caller":"traceutil/trace.go:171","msg":"trace[1204233055] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zgfst; range_end:; response_count:1; response_revision:581; }","duration":"314.566245ms","start":"2026-05-05T22:09:06.694063Z","end":"2026-05-05T22:09:07.00863Z","steps":["trace[1204233055] 'agreement among raft nodes before linearized reading' (duration: 314.258552ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:09:07.008511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:09:06.587153Z","time spent":"421.291768ms","remote":"127.0.0.1:42946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T22:09:07.008757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:09:06.694043Z","time spent":"314.670125ms","remote":"127.0.0.1:42600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-zgfst\" "} {"level":"info","ts":"2026-05-05T22:09:07.241734Z","caller":"traceutil/trace.go:171","msg":"trace[89976332] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"218.63974ms","start":"2026-05-05T22:09:07.023057Z","end":"2026-05-05T22:09:07.241697Z","steps":["trace[89976332] 'process raft request' (duration: 119.264368ms)","trace[89976332] 'compare' (duration: 99.09248ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:09:07.804957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.662727ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T22:09:07.805058Z","caller":"traceutil/trace.go:171","msg":"trace[717173922] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"487.420406ms","start":"2026-05-05T22:09:07.317622Z","end":"2026-05-05T22:09:07.805042Z","steps":["trace[717173922] 'read index received' (duration: 249.633297ms)","trace[717173922] 'applied index is now lower than readState.Index' (duration: 237.785999ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:09:07.805125Z","caller":"traceutil/trace.go:171","msg":"trace[1647958182] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"555.628441ms","start":"2026-05-05T22:09:07.249486Z","end":"2026-05-05T22:09:07.805115Z","steps":["trace[1647958182] 'process raft request' (duration: 317.724241ms)","trace[1647958182] 'compare' (duration: 237.524496ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:09:07.805176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:09:07.24948Z","time spent":"555.668462ms","remote":"127.0.0.1:42676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T22:09:07.805364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.694338ms","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-05-05T22:09:07.805516Z","caller":"traceutil/trace.go:171","msg":"trace[462352198] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:584; }","duration":"487.89999ms","start":"2026-05-05T22:09:07.317588Z","end":"2026-05-05T22:09:07.805488Z","steps":["trace[462352198] 'agreement among raft nodes before linearized reading' (duration: 487.618668ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:09:07.805574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:09:07.317574Z","time spent":"487.990071ms","remote":"127.0.0.1:42676","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-05-05T22:09:07.820683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.794838ms","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-05-05T22:09:07.820797Z","caller":"traceutil/trace.go:171","msg":"trace[1901203292] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:585; }","duration":"331.961539ms","start":"2026-05-05T22:09:07.488812Z","end":"2026-05-05T22:09:07.820774Z","steps":["trace[1901203292] 'agreement among raft nodes before linearized reading' (duration: 331.747127ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:09:07.820896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:09:07.488749Z","time spent":"332.135809ms","remote":"127.0.0.1:42676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-05T22:09:07.821091Z","caller":"traceutil/trace.go:171","msg":"trace[2071332843] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"392.946544ms","start":"2026-05-05T22:09:07.42807Z","end":"2026-05-05T22:09:07.821017Z","steps":["trace[2071332843] 'process raft request' (duration: 391.784984ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:09:07.821392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:09:07.428022Z","time spent":"393.230025ms","remote":"127.0.0.1:42502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T22:10:39.540308Z","caller":"traceutil/trace.go:171","msg":"trace[1445869706] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"362.798313ms","start":"2026-05-05T22:10:39.177479Z","end":"2026-05-05T22:10:39.540278Z","steps":["trace[1445869706] 'process raft request' (duration: 362.528432ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:39.540707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:10:39.177458Z","time spent":"363.009484ms","remote":"127.0.0.1:42588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T22:10:39.541027Z","caller":"traceutil/trace.go:171","msg":"trace[703520271] transaction","detail":"{read_only:false; response_revision:1826; number_of_response:1; }","duration":"362.668322ms","start":"2026-05-05T22:10:39.178334Z","end":"2026-05-05T22:10:39.541002Z","steps":["trace[703520271] 'process raft request' (duration: 362.550301ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:39.541097Z","caller":"traceutil/trace.go:171","msg":"trace[1416842680] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"363.334655ms","start":"2026-05-05T22:10:39.177721Z","end":"2026-05-05T22:10:39.541055Z","steps":["trace[1416842680] 'process raft request' (duration: 362.47184ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:39.54118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:10:39.178326Z","time spent":"362.775182ms","remote":"127.0.0.1:42692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T22:10:39.541323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:10:39.177698Z","time spent":"363.498347ms","remote":"127.0.0.1:42588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T22:10:39.614235Z","caller":"traceutil/trace.go:171","msg":"trace[2019496035] linearizableReadLoop","detail":"{readStateIndex:1895; appliedIndex:1890; }","duration":"275.96936ms","start":"2026-05-05T22:10:39.338225Z","end":"2026-05-05T22:10:39.614194Z","steps":["trace[2019496035] 'read index received' (duration: 201.705926ms)","trace[2019496035] 'applied index is now lower than readState.Index' (duration: 74.262084ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:39.614453Z","caller":"traceutil/trace.go:171","msg":"trace[1383846687] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"421.665152ms","start":"2026-05-05T22:10:39.192757Z","end":"2026-05-05T22:10:39.614422Z","steps":["trace[1383846687] 'process raft request' (duration: 413.780839ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:39.614496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.233482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6f998eeb-0eb3-4ca8-bea3-2d5b7ad26813\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-05-05T22:10:39.614556Z","caller":"traceutil/trace.go:171","msg":"trace[295952298] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6f998eeb-0eb3-4ca8-bea3-2d5b7ad26813; range_end:; response_count:1; response_revision:1828; }","duration":"276.353202ms","start":"2026-05-05T22:10:39.338185Z","end":"2026-05-05T22:10:39.614538Z","steps":["trace[295952298] 'agreement among raft nodes before linearized reading' (duration: 276.158091ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:39.614633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T22:10:39.192732Z","time spent":"421.790412ms","remote":"127.0.0.1:42600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T22:10:39.614768Z","caller":"traceutil/trace.go:171","msg":"trace[243337371] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"281.759411ms","start":"2026-05-05T22:10:39.332954Z","end":"2026-05-05T22:10:39.614714Z","steps":["trace[243337371] 'process raft request' (duration: 281.163948ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:40.003417Z","caller":"traceutil/trace.go:171","msg":"trace[1820606879] linearizableReadLoop","detail":"{readStateIndex:1897; appliedIndex:1896; }","duration":"217.963855ms","start":"2026-05-05T22:10:39.785431Z","end":"2026-05-05T22:10:40.003395Z","steps":["trace[1820606879] 'read index received' (duration: 217.737954ms)","trace[1820606879] 'applied index is now lower than readState.Index' (duration: 224.811µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:10:40.003471Z","caller":"traceutil/trace.go:171","msg":"trace[1312278182] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"232.674214ms","start":"2026-05-05T22:10:39.770749Z","end":"2026-05-05T22:10:40.003423Z","steps":["trace[1312278182] 'process raft request' (duration: 232.507824ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:40.003727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.236277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-05T22:10:40.003787Z","caller":"traceutil/trace.go:171","msg":"trace[1581041566] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1830; }","duration":"218.375657ms","start":"2026-05-05T22:10:39.785378Z","end":"2026-05-05T22:10:40.003754Z","steps":["trace[1581041566] 'agreement among raft nodes before linearized reading' (duration: 218.157836ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:10:40.003969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.29974ms","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-05-05T22:10:40.004012Z","caller":"traceutil/trace.go:171","msg":"trace[964324030] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1830; }","duration":"123.36375ms","start":"2026-05-05T22:10:39.880624Z","end":"2026-05-05T22:10:40.003988Z","steps":["trace[964324030] 'agreement among raft nodes before linearized reading' (duration: 123.29138ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:51.818Z","caller":"traceutil/trace.go:171","msg":"trace[1507088954] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"154.515336ms","start":"2026-05-05T22:10:51.663454Z","end":"2026-05-05T22:10:51.817969Z","steps":["trace[1507088954] 'process raft request' (duration: 154.323473ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:10:51.828848Z","caller":"traceutil/trace.go:171","msg":"trace[1652939580] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"125.279484ms","start":"2026-05-05T22:10:51.703547Z","end":"2026-05-05T22:10:51.828826Z","steps":["trace[1652939580] 'process raft request' (duration: 125.152935ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:07.828522Z","caller":"traceutil/trace.go:171","msg":"trace[37056330] linearizableReadLoop","detail":"{readStateIndex:2105; appliedIndex:2104; }","duration":"149.721174ms","start":"2026-05-05T22:11:07.678775Z","end":"2026-05-05T22:11:07.828496Z","steps":["trace[37056330] 'read index received' (duration: 149.500721ms)","trace[37056330] 'applied index is now lower than readState.Index' (duration: 219.553µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:11:07.828747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.957878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"} {"level":"info","ts":"2026-05-05T22:11:07.828788Z","caller":"traceutil/trace.go:171","msg":"trace[748385890] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2032; }","duration":"150.038852ms","start":"2026-05-05T22:11:07.678736Z","end":"2026-05-05T22:11:07.828775Z","steps":["trace[748385890] 'agreement among raft nodes before linearized reading' (duration: 149.854552ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:11:07.828842Z","caller":"traceutil/trace.go:171","msg":"trace[456778272] transaction","detail":"{read_only:false; response_revision:2032; number_of_response:1; }","duration":"151.561219ms","start":"2026-05-05T22:11:07.677161Z","end":"2026-05-05T22:11:07.828722Z","steps":["trace[456778272] 'process raft request' (duration: 151.186567ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:11:08.163327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.934748ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T22:11:08.163493Z","caller":"traceutil/trace.go:171","msg":"trace[2078975621] transaction","detail":"{read_only:false; response_revision:2035; number_of_response:1; }","duration":"139.401565ms","start":"2026-05-05T22:11:08.02407Z","end":"2026-05-05T22:11:08.163472Z","steps":["trace[2078975621] 'process raft request' (duration: 19.259186ms)","trace[2078975621] 'compare' (duration: 119.755318ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:12:58.959442Z","caller":"traceutil/trace.go:171","msg":"trace[1203905195] transaction","detail":"{read_only:false; response_revision:2736; number_of_response:1; }","duration":"174.114177ms","start":"2026-05-05T22:12:58.785282Z","end":"2026-05-05T22:12:58.959396Z","steps":["trace[1203905195] 'process raft request' (duration: 121.417265ms)","trace[1203905195] 'compare' (duration: 52.553559ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:12:59.190485Z","caller":"traceutil/trace.go:171","msg":"trace[763361309] linearizableReadLoop","detail":"{readStateIndex:2836; appliedIndex:2835; }","duration":"104.138666ms","start":"2026-05-05T22:12:59.086315Z","end":"2026-05-05T22:12:59.190454Z","steps":["trace[763361309] 'read index received' (duration: 103.978463ms)","trace[763361309] 'applied index is now lower than readState.Index' (duration: 158.203µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:12:59.190499Z","caller":"traceutil/trace.go:171","msg":"trace[1666073615] transaction","detail":"{read_only:false; response_revision:2737; number_of_response:1; }","duration":"170.323681ms","start":"2026-05-05T22:12:59.020145Z","end":"2026-05-05T22:12:59.190468Z","steps":["trace[1666073615] 'process raft request' (duration: 170.150227ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:12:59.190746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.411282ms","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-05-05T22:12:59.190803Z","caller":"traceutil/trace.go:171","msg":"trace[951124689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2737; }","duration":"104.514793ms","start":"2026-05-05T22:12:59.086276Z","end":"2026-05-05T22:12:59.190791Z","steps":["trace[951124689] 'agreement among raft nodes before linearized reading' (duration: 104.288638ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:12:59.356419Z","caller":"traceutil/trace.go:171","msg":"trace[1640267587] transaction","detail":"{read_only:false; response_revision:2738; number_of_response:1; }","duration":"161.218569ms","start":"2026-05-05T22:12:59.195179Z","end":"2026-05-05T22:12:59.356398Z","steps":["trace[1640267587] 'process raft request' (duration: 108.068355ms)","trace[1640267587] 'compare' (duration: 52.966341ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:12:59.356692Z","caller":"traceutil/trace.go:171","msg":"trace[435346995] transaction","detail":"{read_only:false; response_revision:2739; number_of_response:1; }","duration":"161.405933ms","start":"2026-05-05T22:12:59.195264Z","end":"2026-05-05T22:12:59.35667Z","steps":["trace[435346995] 'process raft request' (duration: 161.100527ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:12:59.356783Z","caller":"traceutil/trace.go:171","msg":"trace[995792863] transaction","detail":"{read_only:false; response_revision:2740; number_of_response:1; }","duration":"121.84746ms","start":"2026-05-05T22:12:59.234909Z","end":"2026-05-05T22:12:59.356757Z","steps":["trace[995792863] 'process raft request' (duration: 121.609876ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:13:04.516567Z","caller":"traceutil/trace.go:171","msg":"trace[2091263167] transaction","detail":"{read_only:false; response_revision:2765; number_of_response:1; }","duration":"131.953127ms","start":"2026-05-05T22:13:04.384592Z","end":"2026-05-05T22:13:04.516545Z","steps":["trace[2091263167] 'process raft request' (duration: 118.871652ms)","trace[2091263167] 'compare' (duration: 12.81072ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:16:42.288738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.448192ms","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-05-05T22:16:42.28882Z","caller":"traceutil/trace.go:171","msg":"trace[267225739] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4604; }","duration":"132.585375ms","start":"2026-05-05T22:16:42.156221Z","end":"2026-05-05T22:16:42.288806Z","steps":["trace[267225739] 'agreement among raft nodes before linearized reading' (duration: 132.39488ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:16:42.289117Z","caller":"traceutil/trace.go:171","msg":"trace[751226934] transaction","detail":"{read_only:false; response_revision:4604; number_of_response:1; }","duration":"149.253825ms","start":"2026-05-05T22:16:42.139566Z","end":"2026-05-05T22:16:42.28882Z","steps":["trace[751226934] 'process raft request' (duration: 148.708779ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:16:42.289181Z","caller":"traceutil/trace.go:171","msg":"trace[698902082] linearizableReadLoop","detail":"{readStateIndex:4776; appliedIndex:4775; }","duration":"132.144773ms","start":"2026-05-05T22:16:42.156289Z","end":"2026-05-05T22:16:42.288434Z","steps":["trace[698902082] 'read index received' (duration: 131.846814ms)","trace[698902082] 'applied index is now lower than readState.Index' (duration: 297.279µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:16:42.289866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.226949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T22:16:42.289899Z","caller":"traceutil/trace.go:171","msg":"trace[2111705590] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:4604; }","duration":"130.287351ms","start":"2026-05-05T22:16:42.159602Z","end":"2026-05-05T22:16:42.28989Z","steps":["trace[2111705590] 'agreement among raft nodes before linearized reading' (duration: 129.819568ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:16:42.289833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.869005ms","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-05-05T22:16:42.290006Z","caller":"traceutil/trace.go:171","msg":"trace[472974046] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:4604; }","duration":"125.050871ms","start":"2026-05-05T22:16:42.164936Z","end":"2026-05-05T22:16:42.289987Z","steps":["trace[472974046] 'agreement among raft nodes before linearized reading' (duration: 124.611658ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:16:42.555774Z","caller":"traceutil/trace.go:171","msg":"trace[1610529682] transaction","detail":"{read_only:false; response_revision:4606; number_of_response:1; }","duration":"137.913989ms","start":"2026-05-05T22:16:42.417835Z","end":"2026-05-05T22:16:42.555749Z","steps":["trace[1610529682] 'process raft request' (duration: 137.737064ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:16:48.029853Z","caller":"traceutil/trace.go:171","msg":"trace[1268824933] transaction","detail":"{read_only:false; response_revision:4657; number_of_response:1; }","duration":"141.351157ms","start":"2026-05-05T22:16:47.888465Z","end":"2026-05-05T22:16:48.029816Z","steps":["trace[1268824933] 'process raft request' (duration: 139.525695ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:16:48.043752Z","caller":"traceutil/trace.go:171","msg":"trace[1800240754] linearizableReadLoop","detail":"{readStateIndex:4831; appliedIndex:4829; }","duration":"152.1803ms","start":"2026-05-05T22:16:47.891553Z","end":"2026-05-05T22:16:48.043733Z","steps":["trace[1800240754] 'read index received' (duration: 136.458418ms)","trace[1800240754] 'applied index is now lower than readState.Index' (duration: 15.720982ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:16:48.043819Z","caller":"traceutil/trace.go:171","msg":"trace[1602523204] transaction","detail":"{read_only:false; response_revision:4658; number_of_response:1; }","duration":"154.024492ms","start":"2026-05-05T22:16:47.889772Z","end":"2026-05-05T22:16:48.043796Z","steps":["trace[1602523204] 'process raft request' (duration: 153.856587ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:16:48.043875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.411572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T22:16:48.043908Z","caller":"traceutil/trace.go:171","msg":"trace[1075147865] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:0; response_revision:4658; }","duration":"144.477153ms","start":"2026-05-05T22:16:47.899419Z","end":"2026-05-05T22:16:48.043896Z","steps":["trace[1075147865] 'agreement among raft nodes before linearized reading' (duration: 144.413971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:16:48.043901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.325394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T22:16:48.043962Z","caller":"traceutil/trace.go:171","msg":"trace[1467720193] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4658; }","duration":"152.416607ms","start":"2026-05-05T22:16:47.891532Z","end":"2026-05-05T22:16:48.043949Z","steps":["trace[1467720193] 'agreement among raft nodes before linearized reading' (duration: 152.294004ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:16:48.336726Z","caller":"traceutil/trace.go:171","msg":"trace[2042686224] transaction","detail":"{read_only:false; response_revision:4670; number_of_response:1; }","duration":"135.287554ms","start":"2026-05-05T22:16:48.201394Z","end":"2026-05-05T22:16:48.336681Z","steps":["trace[2042686224] 'process raft request' (duration: 135.119629ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:16:48.336741Z","caller":"traceutil/trace.go:171","msg":"trace[934484079] transaction","detail":"{read_only:false; response_revision:4671; number_of_response:1; }","duration":"135.246133ms","start":"2026-05-05T22:16:48.201464Z","end":"2026-05-05T22:16:48.33671Z","steps":["trace[934484079] 'process raft request' (duration: 135.160691ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:16:48.336905Z","caller":"traceutil/trace.go:171","msg":"trace[181890967] transaction","detail":"{read_only:false; response_revision:4672; number_of_response:1; }","duration":"135.358366ms","start":"2026-05-05T22:16:48.201533Z","end":"2026-05-05T22:16:48.336891Z","steps":["trace[181890967] 'process raft request' (duration: 135.13492ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:16:48.337075Z","caller":"traceutil/trace.go:171","msg":"trace[1919035756] transaction","detail":"{read_only:false; response_revision:4673; number_of_response:1; }","duration":"103.052527ms","start":"2026-05-05T22:16:48.233993Z","end":"2026-05-05T22:16:48.337046Z","steps":["trace[1919035756] 'process raft request' (duration: 102.755309ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:16:48.710506Z","caller":"traceutil/trace.go:171","msg":"trace[2012516305] transaction","detail":"{read_only:false; response_revision:4683; number_of_response:1; }","duration":"169.809245ms","start":"2026-05-05T22:16:48.540658Z","end":"2026-05-05T22:16:48.710468Z","steps":["trace[2012516305] 'process raft request' (duration: 144.531465ms)","trace[2012516305] 'compare' (duration: 24.538909ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T22:16:48.710556Z","caller":"traceutil/trace.go:171","msg":"trace[156153452] transaction","detail":"{read_only:false; response_revision:4684; number_of_response:1; }","duration":"169.823666ms","start":"2026-05-05T22:16:48.5407Z","end":"2026-05-05T22:16:48.710523Z","steps":["trace[156153452] 'process raft request' (duration: 169.671372ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T22:16:48.710732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.449978ms","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-05-05T22:16:48.710921Z","caller":"traceutil/trace.go:171","msg":"trace[1391351691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4685; }","duration":"125.619693ms","start":"2026-05-05T22:16:48.585221Z","end":"2026-05-05T22:16:48.710841Z","steps":["trace[1391351691] 'agreement among raft nodes before linearized reading' (duration: 125.352175ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:16:48.711031Z","caller":"traceutil/trace.go:171","msg":"trace[660048774] transaction","detail":"{read_only:false; response_revision:4685; number_of_response:1; }","duration":"169.31582ms","start":"2026-05-05T22:16:48.541694Z","end":"2026-05-05T22:16:48.71101Z","steps":["trace[660048774] 'process raft request' (duration: 168.734014ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:16:48.710506Z","caller":"traceutil/trace.go:171","msg":"trace[1849622069] linearizableReadLoop","detail":"{readStateIndex:4859; appliedIndex:4856; }","duration":"125.215601ms","start":"2026-05-05T22:16:48.585259Z","end":"2026-05-05T22:16:48.710475Z","steps":["trace[1849622069] 'read index received' (duration: 99.872139ms)","trace[1849622069] 'applied index is now lower than readState.Index' (duration: 25.342312ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T22:16:48.711931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.122519ms","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-05-05T22:16:48.711978Z","caller":"traceutil/trace.go:171","msg":"trace[537111281] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4685; }","duration":"119.211562ms","start":"2026-05-05T22:16:48.592755Z","end":"2026-05-05T22:16:48.711967Z","steps":["trace[537111281] 'agreement among raft nodes before linearized reading' (duration: 118.991906ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T22:18:29.803422Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2900} {"level":"info","ts":"2026-05-05T22:18:29.91196Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2900,"took":"107.000752ms","hash":4134817726,"current-db-size-bytes":54403072,"current-db-size":"54 MB","current-db-size-in-use-bytes":29409280,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-05T22:18:29.912041Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4134817726,"revision":2900,"compact-revision":-1} {"level":"info","ts":"2026-05-05T22:23:29.809183Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5618} {"level":"info","ts":"2026-05-05T22:23:29.889953Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5618,"took":"79.489493ms","hash":2904730575,"current-db-size-bytes":54403072,"current-db-size":"54 MB","current-db-size-in-use-bytes":18153472,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-05T22:23:29.890008Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2904730575,"revision":5618,"compact-revision":2900}