{"level":"warn","ts":"2026-07-25T19:10:10.180883Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T19:10:10.181017Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109: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.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-07-25T19:10:10.181392Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T19:10:10.181424Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-07-25T19:10:10.181502Z","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-07-25T19:10:10.182284Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-07-25T19:10:10.182453Z","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.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109: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-07-25T19:10:10.188656Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.862275ms"} {"level":"info","ts":"2026-07-25T19:10:10.196568Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-07-25T19:10:10.196665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-07-25T19:10:10.196727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-07-25T19:10:10.196744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-25T19:10:10.196757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-07-25T19:10:10.196821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-07-25T19:10:10.201667Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-25T19:10:10.20459Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-25T19:10:10.205872Z","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-07-25T19:10:10.207526Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-25T19:10:10.207703Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-25T19:10:10.207825Z","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-07-25T19:10:10.207867Z","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-07-25T19:10:10.207874Z","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-07-25T19:10:10.209574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-07-25T19:10:10.209776Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-07-25T19:10:10.21451Z","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-07-25T19:10:10.214709Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-07-25T19:10:10.214754Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-07-25T19:10:10.214881Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-25T19:10:10.214912Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-25T19:10:10.497268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-07-25T19:10:10.497343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-07-25T19:10:10.497377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-07-25T19:10:10.497401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-07-25T19:10:10.497413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-07-25T19:10:10.497429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-07-25T19:10:10.497443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-07-25T19:10:10.498441Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T19:10:10.499623Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T19:10:10.499694Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T19:10:10.499716Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T19:10:10.499961Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-07-25T19:10:10.499971Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T19:10:10.500122Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T19:10:10.500367Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-25T19:10:10.500399Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-25T19:10:10.503426Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-25T19:10:10.504798Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"warn","ts":"2026-07-25T19:10:14.453116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.907154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-tj6di1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T19:10:14.453296Z","caller":"traceutil/trace.go:171","msg":"trace[877771836] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-tj6di1; range_end:; response_count:0; response_revision:205; }","duration":"280.142831ms","start":"2026-07-25T19:10:14.173132Z","end":"2026-07-25T19:10:14.453275Z","steps":["trace[877771836] 'range keys from in-memory index tree' (duration: 279.833622ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:10:52.189353Z","caller":"traceutil/trace.go:171","msg":"trace[2006500080] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"196.378374ms","start":"2026-07-25T19:10:51.992946Z","end":"2026-07-25T19:10:52.189324Z","steps":["trace[2006500080] 'process raft request' (duration: 195.286514ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:10:52.293976Z","caller":"traceutil/trace.go:171","msg":"trace[1350485034] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"100.106636ms","start":"2026-07-25T19:10:52.193835Z","end":"2026-07-25T19:10:52.293941Z","steps":["trace[1350485034] 'process raft request' (duration: 85.475653ms)","trace[1350485034] 'compare' (duration: 14.181451ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T19:10:52.746459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.242535ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T19:10:52.746848Z","caller":"traceutil/trace.go:171","msg":"trace[1669290714] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"412.355018ms","start":"2026-07-25T19:10:52.33446Z","end":"2026-07-25T19:10:52.746815Z","steps":["trace[1669290714] 'process raft request' (duration: 236.697504ms)","trace[1669290714] 'compare' (duration: 174.07104ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T19:10:52.747307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:10:52.334448Z","time spent":"412.79853ms","remote":"127.0.0.1:53490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T19:10:52.746987Z","caller":"traceutil/trace.go:171","msg":"trace[900563271] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"176.499927ms","start":"2026-07-25T19:10:52.570472Z","end":"2026-07-25T19:10:52.746972Z","steps":["trace[900563271] 'read index received' (duration: 663.678µs)","trace[900563271] 'applied index is now lower than readState.Index' (duration: 175.834789ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T19:10:52.747191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.716153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ztjxj\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-25T19:10:52.747486Z","caller":"traceutil/trace.go:171","msg":"trace[732756122] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ztjxj; range_end:; response_count:1; response_revision:588; }","duration":"177.071423ms","start":"2026-07-25T19:10:52.570399Z","end":"2026-07-25T19:10:52.747471Z","steps":["trace[732756122] 'agreement among raft nodes before linearized reading' (duration: 176.645031ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:11:47.735632Z","caller":"traceutil/trace.go:171","msg":"trace[1722021483] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"135.709991ms","start":"2026-07-25T19:11:47.59989Z","end":"2026-07-25T19:11:47.7356Z","steps":["trace[1722021483] 'process raft request' (duration: 135.528446ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:11:48.481835Z","caller":"traceutil/trace.go:171","msg":"trace[2026118569] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"163.540444ms","start":"2026-07-25T19:11:48.318256Z","end":"2026-07-25T19:11:48.481797Z","steps":["trace[2026118569] 'process raft request' (duration: 163.293527ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:13:02.018033Z","caller":"traceutil/trace.go:171","msg":"trace[836341392] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"114.341817ms","start":"2026-07-25T19:13:01.90365Z","end":"2026-07-25T19:13:02.017992Z","steps":["trace[836341392] 'process raft request' (duration: 114.207613ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:13:27.321015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.663751ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T19:13:27.321302Z","caller":"traceutil/trace.go:171","msg":"trace[138156072] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"219.446341ms","start":"2026-07-25T19:13:27.101819Z","end":"2026-07-25T19:13:27.321265Z","steps":["trace[138156072] 'process raft request' (duration: 13.432399ms)","trace[138156072] 'compare' (duration: 205.553548ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:14:46.119852Z","caller":"traceutil/trace.go:171","msg":"trace[700668486] transaction","detail":"{read_only:false; response_revision:1602; number_of_response:1; }","duration":"105.797048ms","start":"2026-07-25T19:14:46.014034Z","end":"2026-07-25T19:14:46.119831Z","steps":["trace[700668486] 'process raft request' (duration: 95.773643ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:15:13.848821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.573622ms","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-07-25T19:15:13.848855Z","caller":"traceutil/trace.go:171","msg":"trace[597078628] transaction","detail":"{read_only:false; response_revision:1692; number_of_response:1; }","duration":"151.171549ms","start":"2026-07-25T19:15:13.697646Z","end":"2026-07-25T19:15:13.848817Z","steps":["trace[597078628] 'process raft request' (duration: 82.393965ms)","trace[597078628] 'compare' (duration: 68.470075ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:15:13.848915Z","caller":"traceutil/trace.go:171","msg":"trace[868341143] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1691; }","duration":"172.758187ms","start":"2026-07-25T19:15:13.676137Z","end":"2026-07-25T19:15:13.848895Z","steps":["trace[868341143] 'range keys from in-memory index tree' (duration: 172.414937ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:15:13.970475Z","caller":"traceutil/trace.go:171","msg":"trace[1703153242] transaction","detail":"{read_only:false; response_revision:1693; number_of_response:1; }","duration":"116.603547ms","start":"2026-07-25T19:15:13.853844Z","end":"2026-07-25T19:15:13.970447Z","steps":["trace[1703153242] 'process raft request' (duration: 113.772145ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:15:13.982107Z","caller":"traceutil/trace.go:171","msg":"trace[1814747551] transaction","detail":"{read_only:false; response_revision:1694; number_of_response:1; }","duration":"128.105447ms","start":"2026-07-25T19:15:13.853985Z","end":"2026-07-25T19:15:13.982091Z","steps":["trace[1814747551] 'process raft request' (duration: 128.020784ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:20:10.598298Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1682} {"level":"info","ts":"2026-07-25T19:20:10.63703Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":1682,"took":"38.19705ms","hash":3107668798,"current-db-size-bytes":23810048,"current-db-size":"24 MB","current-db-size-in-use-bytes":5562368,"current-db-size-in-use":"5.6 MB"} {"level":"info","ts":"2026-07-25T19:20:10.637191Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3107668798,"revision":1682,"compact-revision":-1} {"level":"info","ts":"2026-07-25T19:21:00.266546Z","caller":"traceutil/trace.go:171","msg":"trace[1315491966] transaction","detail":"{read_only:false; response_revision:3158; number_of_response:1; }","duration":"185.637461ms","start":"2026-07-25T19:21:00.080874Z","end":"2026-07-25T19:21:00.266511Z","steps":["trace[1315491966] 'process raft request' (duration: 185.484087ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:06.642263Z","caller":"traceutil/trace.go:171","msg":"trace[1189508752] linearizableReadLoop","detail":"{readStateIndex:3392; appliedIndex:3391; }","duration":"119.223228ms","start":"2026-07-25T19:21:06.52302Z","end":"2026-07-25T19:21:06.642243Z","steps":["trace[1189508752] 'read index received' (duration: 119.053594ms)","trace[1189508752] 'applied index is now lower than readState.Index' (duration: 168.604µs)"],"step_count":2} {"level":"warn","ts":"2026-07-25T19:21:06.642486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.437324ms","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-07-25T19:21:06.642532Z","caller":"traceutil/trace.go:171","msg":"trace[1795280242] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3239; }","duration":"119.531587ms","start":"2026-07-25T19:21:06.522987Z","end":"2026-07-25T19:21:06.642519Z","steps":["trace[1795280242] 'agreement among raft nodes before linearized reading' (duration: 119.353702ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:06.642475Z","caller":"traceutil/trace.go:171","msg":"trace[181073058] transaction","detail":"{read_only:false; response_revision:3239; number_of_response:1; }","duration":"120.897884ms","start":"2026-07-25T19:21:06.521515Z","end":"2026-07-25T19:21:06.642413Z","steps":["trace[181073058] 'process raft request' (duration: 120.607276ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:06.969537Z","caller":"traceutil/trace.go:171","msg":"trace[862169580] transaction","detail":"{read_only:false; response_revision:3245; number_of_response:1; }","duration":"137.095193ms","start":"2026-07-25T19:21:06.832411Z","end":"2026-07-25T19:21:06.969506Z","steps":["trace[862169580] 'process raft request' (duration: 137.023171ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:06.969552Z","caller":"traceutil/trace.go:171","msg":"trace[1097034877] transaction","detail":"{read_only:false; response_revision:3244; number_of_response:1; }","duration":"137.502945ms","start":"2026-07-25T19:21:06.832005Z","end":"2026-07-25T19:21:06.969508Z","steps":["trace[1097034877] 'process raft request' (duration: 129.059381ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:29.424497Z","caller":"traceutil/trace.go:171","msg":"trace[1872314686] transaction","detail":"{read_only:false; response_revision:3754; number_of_response:1; }","duration":"140.108512ms","start":"2026-07-25T19:21:29.284353Z","end":"2026-07-25T19:21:29.424462Z","steps":["trace[1872314686] 'process raft request' (duration: 139.774323ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:21:29.81321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.969122ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T19:21:29.813325Z","caller":"traceutil/trace.go:171","msg":"trace[1537153461] transaction","detail":"{read_only:false; response_revision:3755; number_of_response:1; }","duration":"381.672892ms","start":"2026-07-25T19:21:29.431631Z","end":"2026-07-25T19:21:29.813304Z","steps":["trace[1537153461] 'process raft request' (duration: 171.514264ms)","trace[1537153461] 'compare' (duration: 209.828459ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T19:21:29.813511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:21:29.431612Z","time spent":"381.862416ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":646,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T19:21:29.824651Z","caller":"traceutil/trace.go:171","msg":"trace[1919878282] transaction","detail":"{read_only:false; response_revision:3756; number_of_response:1; }","duration":"392.192503ms","start":"2026-07-25T19:21:29.432441Z","end":"2026-07-25T19:21:29.824634Z","steps":["trace[1919878282] 'process raft request' (duration: 392.047179ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:29.824675Z","caller":"traceutil/trace.go:171","msg":"trace[457885212] linearizableReadLoop","detail":"{readStateIndex:3945; appliedIndex:3942; }","duration":"276.360997ms","start":"2026-07-25T19:21:29.548283Z","end":"2026-07-25T19:21:29.824644Z","steps":["trace[457885212] 'read index received' (duration: 54.877875ms)","trace[457885212] 'applied index is now lower than readState.Index' (duration: 221.482422ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T19:21:29.82476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:21:29.432419Z","time spent":"392.278066ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":778,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T19:21:29.824945Z","caller":"traceutil/trace.go:171","msg":"trace[1368332990] transaction","detail":"{read_only:false; response_revision:3758; number_of_response:1; }","duration":"237.615091ms","start":"2026-07-25T19:21:29.58732Z","end":"2026-07-25T19:21:29.824935Z","steps":["trace[1368332990] 'process raft request' (duration: 237.293762ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:29.824978Z","caller":"traceutil/trace.go:171","msg":"trace[2052914954] transaction","detail":"{read_only:false; response_revision:3757; number_of_response:1; }","duration":"388.795139ms","start":"2026-07-25T19:21:29.436166Z","end":"2026-07-25T19:21:29.824961Z","steps":["trace[2052914954] 'process raft request' (duration: 388.403369ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:21:29.825058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:21:29.436155Z","time spent":"388.857842ms","remote":"127.0.0.1:45752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7713,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T19:21:29.825176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.661544ms","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-07-25T19:21:29.825251Z","caller":"traceutil/trace.go:171","msg":"trace[1923775537] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3758; }","duration":"101.780307ms","start":"2026-07-25T19:21:29.723456Z","end":"2026-07-25T19:21:29.825237Z","steps":["trace[1923775537] 'agreement among raft nodes before linearized reading' (duration: 101.592422ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:21:29.825385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.413149ms","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-07-25T19:21:29.825485Z","caller":"traceutil/trace.go:171","msg":"trace[48779324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3758; }","duration":"100.550562ms","start":"2026-07-25T19:21:29.72492Z","end":"2026-07-25T19:21:29.825471Z","steps":["trace[48779324] 'agreement among raft nodes before linearized reading' (duration: 100.348907ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:21:29.825407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.067976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cd8baa39-84b9-4741-95ff-55921823a49e\" ","response":"range_response_count:1 size:3617"} {"level":"info","ts":"2026-07-25T19:21:29.82561Z","caller":"traceutil/trace.go:171","msg":"trace[1533696226] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cd8baa39-84b9-4741-95ff-55921823a49e; range_end:; response_count:1; response_revision:3758; }","duration":"277.386205ms","start":"2026-07-25T19:21:29.54821Z","end":"2026-07-25T19:21:29.825596Z","steps":["trace[1533696226] 'agreement among raft nodes before linearized reading' (duration: 276.954903ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:55.057881Z","caller":"traceutil/trace.go:171","msg":"trace[622072959] transaction","detail":"{read_only:false; response_revision:3975; number_of_response:1; }","duration":"148.779082ms","start":"2026-07-25T19:21:54.909075Z","end":"2026-07-25T19:21:55.057854Z","steps":["trace[622072959] 'process raft request' (duration: 122.526993ms)","trace[622072959] 'compare' (duration: 26.166027ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:21:55.653574Z","caller":"traceutil/trace.go:171","msg":"trace[776839764] transaction","detail":"{read_only:false; response_revision:3977; number_of_response:1; }","duration":"175.419633ms","start":"2026-07-25T19:21:55.478106Z","end":"2026-07-25T19:21:55.653526Z","steps":["trace[776839764] 'process raft request' (duration: 147.601541ms)","trace[776839764] 'compare' (duration: 26.656661ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:21:56.612767Z","caller":"traceutil/trace.go:171","msg":"trace[1921502722] transaction","detail":"{read_only:false; response_revision:3983; number_of_response:1; }","duration":"119.646433ms","start":"2026-07-25T19:21:56.493073Z","end":"2026-07-25T19:21:56.61272Z","steps":["trace[1921502722] 'process raft request' (duration: 47.49934ms)","trace[1921502722] 'compare' (duration: 71.739182ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:21:56.847383Z","caller":"traceutil/trace.go:171","msg":"trace[255281709] transaction","detail":"{read_only:false; response_revision:3985; number_of_response:1; }","duration":"191.268852ms","start":"2026-07-25T19:21:56.656065Z","end":"2026-07-25T19:21:56.847334Z","steps":["trace[255281709] 'process raft request' (duration: 144.070261ms)","trace[255281709] 'compare' (duration: 46.764969ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:21:56.847436Z","caller":"traceutil/trace.go:171","msg":"trace[1533946444] linearizableReadLoop","detail":"{readStateIndex:4182; appliedIndex:4180; }","duration":"140.544054ms","start":"2026-07-25T19:21:56.706872Z","end":"2026-07-25T19:21:56.847416Z","steps":["trace[1533946444] 'read index received' (duration: 93.283791ms)","trace[1533946444] 'applied index is now lower than readState.Index' (duration: 47.259232ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:21:56.84745Z","caller":"traceutil/trace.go:171","msg":"trace[337779879] transaction","detail":"{read_only:false; response_revision:3986; number_of_response:1; }","duration":"140.683368ms","start":"2026-07-25T19:21:56.706748Z","end":"2026-07-25T19:21:56.847431Z","steps":["trace[337779879] 'process raft request' (duration: 140.443611ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:21:56.84752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.642877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T19:21:56.847815Z","caller":"traceutil/trace.go:171","msg":"trace[1181087821] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:3987; }","duration":"140.980726ms","start":"2026-07-25T19:21:56.706821Z","end":"2026-07-25T19:21:56.847802Z","steps":["trace[1181087821] 'agreement among raft nodes before linearized reading' (duration: 140.662587ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:21:56.847501Z","caller":"traceutil/trace.go:171","msg":"trace[635066665] transaction","detail":"{read_only:false; response_revision:3987; number_of_response:1; }","duration":"103.754602ms","start":"2026-07-25T19:21:56.743725Z","end":"2026-07-25T19:21:56.84748Z","steps":["trace[635066665] 'process raft request' (duration: 103.65413ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:23:05.989369Z","caller":"traceutil/trace.go:171","msg":"trace[2124804632] transaction","detail":"{read_only:false; response_revision:4494; number_of_response:1; }","duration":"204.641158ms","start":"2026-07-25T19:23:05.784689Z","end":"2026-07-25T19:23:05.98933Z","steps":["trace[2124804632] 'process raft request' (duration: 114.484919ms)","trace[2124804632] 'compare' (duration: 89.940764ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:25:10.603491Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2668} {"level":"info","ts":"2026-07-25T19:25:10.625003Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2668,"took":"20.663033ms","hash":1440399427,"current-db-size-bytes":23810048,"current-db-size":"24 MB","current-db-size-in-use-bytes":17702912,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-25T19:25:10.62507Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1440399427,"revision":2668,"compact-revision":1682} {"level":"info","ts":"2026-07-25T19:30:10.63268Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5221} {"level":"warn","ts":"2026-07-25T19:30:10.806045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.370693ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T19:30:10.806727Z","caller":"traceutil/trace.go:171","msg":"trace[52284927] transaction","detail":"{read_only:false; response_revision:7829; number_of_response:1; }","duration":"171.731758ms","start":"2026-07-25T19:30:10.634968Z","end":"2026-07-25T19:30:10.8067Z","steps":["trace[52284927] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/cert-manager.io/certificates/monitoring/alertmanager-tls; req_size:3073; } (duration: 163.757206ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:30:10.807032Z","caller":"traceutil/trace.go:171","msg":"trace[2108462314] transaction","detail":"{read_only:false; response_revision:7830; number_of_response:1; }","duration":"170.739051ms","start":"2026-07-25T19:30:10.636286Z","end":"2026-07-25T19:30:10.807025Z","steps":["trace[2108462314] 'process raft request' (duration: 170.402972ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:30:10.807293Z","caller":"traceutil/trace.go:171","msg":"trace[2102345771] transaction","detail":"{read_only:false; response_revision:7831; number_of_response:1; }","duration":"170.323699ms","start":"2026-07-25T19:30:10.636959Z","end":"2026-07-25T19:30:10.807282Z","steps":["trace[2102345771] 'process raft request' (duration: 169.910158ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:30:10.80732Z","caller":"traceutil/trace.go:171","msg":"trace[820281463] transaction","detail":"{read_only:false; number_of_response:1; response_revision:7831; }","duration":"129.176817ms","start":"2026-07-25T19:30:10.678077Z","end":"2026-07-25T19:30:10.807254Z","steps":["trace[820281463] 'process raft request' (duration: 128.847147ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:30:10.925958Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5221,"took":"291.867674ms","hash":530270241,"current-db-size-bytes":38756352,"current-db-size":"39 MB","current-db-size-in-use-bytes":27942912,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-07-25T19:30:10.92603Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":530270241,"revision":5221,"compact-revision":2668} {"level":"warn","ts":"2026-07-25T19:30:16.278921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.228446ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-25T19:30:16.284333Z","caller":"traceutil/trace.go:171","msg":"trace[849416817] transaction","detail":"{read_only:false; response_revision:7978; number_of_response:1; }","duration":"328.77092ms","start":"2026-07-25T19:30:15.950234Z","end":"2026-07-25T19:30:16.279005Z","steps":["trace[849416817] 'compare' (duration: 12.090346ms)","trace[849416817] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/events/monitoring/kube-prometheus-stack-admission-patch.18c59f26b66d7b16; req_size:705; } (duration: 311.029208ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T19:30:16.284385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:30:15.950215Z","time spent":"334.151649ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":708,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T19:30:20.437907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.401215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T19:30:20.437972Z","caller":"traceutil/trace.go:171","msg":"trace[119510214] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:8061; }","duration":"383.496418ms","start":"2026-07-25T19:30:20.054461Z","end":"2026-07-25T19:30:20.437957Z","steps":["trace[119510214] 'count revisions from in-memory index tree' (duration: 383.340274ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:30:20.438001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:30:20.054447Z","time spent":"383.546909ms","remote":"127.0.0.1:45784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":3,"response size":30,"request content":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true "} {"level":"warn","ts":"2026-07-25T19:30:20.438154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.624552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T19:30:20.438227Z","caller":"traceutil/trace.go:171","msg":"trace[2075063580] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:8061; }","duration":"383.747075ms","start":"2026-07-25T19:30:20.054459Z","end":"2026-07-25T19:30:20.438206Z","steps":["trace[2075063580] 'count revisions from in-memory index tree' (duration: 383.55452ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:30:20.438272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:30:20.054436Z","time spent":"383.824347ms","remote":"127.0.0.1:60330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-07-25T19:30:20.438425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.90418ms","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-07-25T19:30:20.438494Z","caller":"traceutil/trace.go:171","msg":"trace[1583290870] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8061; }","duration":"384.001772ms","start":"2026-07-25T19:30:20.054474Z","end":"2026-07-25T19:30:20.438475Z","steps":["trace[1583290870] 'range keys from in-memory index tree' (duration: 383.746855ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:30:20.438532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:30:20.054441Z","time spent":"384.082764ms","remote":"127.0.0.1:53490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-25T19:30:20.438974Z","caller":"traceutil/trace.go:171","msg":"trace[1485063472] linearizableReadLoop","detail":"{readStateIndex:8404; appliedIndex:8403; }","duration":"384.353862ms","start":"2026-07-25T19:30:20.054608Z","end":"2026-07-25T19:30:20.438962Z","steps":["trace[1485063472] 'read index received' (duration: 384.229609ms)","trace[1485063472] 'applied index is now lower than readState.Index' (duration: 123.263µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:30:20.439089Z","caller":"traceutil/trace.go:171","msg":"trace[2033781970] transaction","detail":"{read_only:false; response_revision:8062; number_of_response:1; }","duration":"384.502156ms","start":"2026-07-25T19:30:20.054562Z","end":"2026-07-25T19:30:20.439064Z","steps":["trace[2033781970] 'process raft request' (duration: 384.309081ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:30:20.439213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:30:20.054553Z","time spent":"384.599588ms","remote":"127.0.0.1:53490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T19:30:20.439291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.65634ms","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-07-25T19:30:20.440374Z","caller":"traceutil/trace.go:171","msg":"trace[1384987758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8062; }","duration":"384.762333ms","start":"2026-07-25T19:30:20.05459Z","end":"2026-07-25T19:30:20.439352Z","steps":["trace[1384987758] 'agreement among raft nodes before linearized reading' (duration: 384.522086ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:30:20.440445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:30:20.054584Z","time spent":"385.845633ms","remote":"127.0.0.1:53490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-25T19:30:20.4425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:30:20.09234Z","time spent":"350.156313ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-25T19:30:20.442725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.990321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/valkey-data-valkey-node-1.18c59ee1a8e42f14\" ","response":"range_response_count:1 size:764"} {"level":"info","ts":"2026-07-25T19:30:20.442788Z","caller":"traceutil/trace.go:171","msg":"trace[69383111] range","detail":"{range_begin:/registry/events/openstack/valkey-data-valkey-node-1.18c59ee1a8e42f14; range_end:; response_count:1; response_revision:8064; }","duration":"362.070064ms","start":"2026-07-25T19:30:20.080703Z","end":"2026-07-25T19:30:20.442773Z","steps":["trace[69383111] 'agreement among raft nodes before linearized reading' (duration: 361.89998ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:30:20.442828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:30:20.080697Z","time spent":"362.122925ms","remote":"127.0.0.1:53332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":787,"request content":"key:\"/registry/events/openstack/valkey-data-valkey-node-1.18c59ee1a8e42f14\" "} {"level":"info","ts":"2026-07-25T19:30:20.443018Z","caller":"traceutil/trace.go:171","msg":"trace[361812407] transaction","detail":"{read_only:false; response_revision:8063; number_of_response:1; }","duration":"349.545895ms","start":"2026-07-25T19:30:20.093455Z","end":"2026-07-25T19:30:20.443Z","steps":["trace[361812407] 'process raft request' (duration: 348.961518ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:30:20.443119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:30:20.093446Z","time spent":"349.613057ms","remote":"127.0.0.1:53424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11870,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T19:30:20.443166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.027949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-ls68w\" ","response":"range_response_count:1 size:5148"} {"level":"info","ts":"2026-07-25T19:30:20.443213Z","caller":"traceutil/trace.go:171","msg":"trace[462025213] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-ls68w; range_end:; response_count:1; response_revision:8064; }","duration":"359.08189ms","start":"2026-07-25T19:30:20.084119Z","end":"2026-07-25T19:30:20.4432Z","steps":["trace[462025213] 'agreement among raft nodes before linearized reading' (duration: 358.971347ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:30:20.443244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:30:20.084113Z","time spent":"359.124351ms","remote":"127.0.0.1:53428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":5171,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-ls68w\" "} {"level":"warn","ts":"2026-07-25T19:30:20.443402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.615799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T19:30:20.443431Z","caller":"traceutil/trace.go:171","msg":"trace[2004981933] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8064; }","duration":"362.65091ms","start":"2026-07-25T19:30:20.080771Z","end":"2026-07-25T19:30:20.443422Z","steps":["trace[2004981933] 'agreement among raft nodes before linearized reading' (duration: 362.609389ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:30:20.44346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T19:30:20.080768Z","time spent":"362.686361ms","remote":"127.0.0.1:53260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-25T19:30:27.185193Z","caller":"traceutil/trace.go:171","msg":"trace[1525870910] linearizableReadLoop","detail":"{readStateIndex:8462; appliedIndex:8461; }","duration":"229.656297ms","start":"2026-07-25T19:30:26.955505Z","end":"2026-07-25T19:30:27.185161Z","steps":["trace[1525870910] 'read index received' (duration: 229.367519ms)","trace[1525870910] 'applied index is now lower than readState.Index' (duration: 287.308µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:30:27.185242Z","caller":"traceutil/trace.go:171","msg":"trace[621430498] transaction","detail":"{read_only:false; response_revision:8118; number_of_response:1; }","duration":"233.781881ms","start":"2026-07-25T19:30:26.951432Z","end":"2026-07-25T19:30:27.185214Z","steps":["trace[621430498] 'process raft request' (duration: 233.553834ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T19:30:27.185438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.907694ms","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-07-25T19:30:27.185486Z","caller":"traceutil/trace.go:171","msg":"trace[1109514907] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8118; }","duration":"229.985417ms","start":"2026-07-25T19:30:26.955486Z","end":"2026-07-25T19:30:27.185472Z","steps":["trace[1109514907] 'agreement among raft nodes before linearized reading' (duration: 229.812521ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:30:27.3371Z","caller":"traceutil/trace.go:171","msg":"trace[725286430] transaction","detail":"{read_only:false; response_revision:8121; number_of_response:1; }","duration":"139.261197ms","start":"2026-07-25T19:30:27.197776Z","end":"2026-07-25T19:30:27.337037Z","steps":["trace[725286430] 'process raft request' (duration: 114.926061ms)","trace[725286430] 'compare' (duration: 24.143731ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T19:30:27.363403Z","caller":"traceutil/trace.go:171","msg":"trace[729771916] transaction","detail":"{read_only:false; response_revision:8122; number_of_response:1; }","duration":"150.334534ms","start":"2026-07-25T19:30:27.213021Z","end":"2026-07-25T19:30:27.363356Z","steps":["trace[729771916] 'process raft request' (duration: 150.076057ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:30:27.363637Z","caller":"traceutil/trace.go:171","msg":"trace[1715285134] transaction","detail":"{read_only:false; response_revision:8123; number_of_response:1; }","duration":"150.14717ms","start":"2026-07-25T19:30:27.213417Z","end":"2026-07-25T19:30:27.363564Z","steps":["trace[1715285134] 'process raft request' (duration: 149.859512ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T19:34:59.65596Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d71a1778b31d4ce","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-25T19:34:59.666342Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-25T19:34:59.666421Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-25T19:35:10.640569Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7828} {"level":"info","ts":"2026-07-25T19:35:10.788385Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7828,"took":"146.308304ms","hash":1898683155,"current-db-size-bytes":40058880,"current-db-size":"40 MB","current-db-size-in-use-bytes":30457856,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-25T19:35:10.788484Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1898683155,"revision":7828,"compact-revision":5221}