{"level":"warn","ts":"2026-07-26T15:45:11.710243Z","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-26T15:45:11.710349Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.129: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.129:2380","--initial-cluster=instance=https://199.204.45.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.129: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-26T15:45:11.710429Z","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-26T15:45:11.710445Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-07-26T15:45:11.710468Z","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-26T15:45:11.711127Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"]} {"level":"info","ts":"2026-07-26T15:45:11.711208Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.129: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-26T15:45:11.715098Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.676772ms"} {"level":"info","ts":"2026-07-26T15:45:11.723481Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-07-26T15:45:11.72358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-07-26T15:45:11.723604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-07-26T15:45:11.723618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cec112083e8d3ff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-26T15:45:11.723631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-07-26T15:45:11.723674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-07-26T15:45:11.732813Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-26T15:45:11.738366Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-26T15:45:11.740041Z","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-26T15:45:11.743645Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cec112083e8d3ff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-26T15:45:11.743867Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cec112083e8d3ff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-26T15:45:11.744004Z","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-26T15:45:11.744132Z","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-26T15:45:11.744164Z","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-26T15:45:11.744694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-07-26T15:45:11.744813Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","added-peer-id":"3cec112083e8d3ff","added-peer-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-07-26T15:45:11.746705Z","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-26T15:45:11.746776Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-07-26T15:45:11.746814Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-07-26T15:45:11.746959Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cec112083e8d3ff","initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-26T15:45:11.747006Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-26T15:45:12.124408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-07-26T15:45:12.124498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-07-26T15:45:12.124543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-07-26T15:45:12.124566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-07-26T15:45:12.124576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-07-26T15:45:12.124591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-07-26T15:45:12.124621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-07-26T15:45:12.134437Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T15:45:12.135709Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-26T15:45:12.135756Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-26T15:45:12.135709Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cec112083e8d3ff","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.129:2379]}","request-path":"/0/members/3cec112083e8d3ff/attributes","cluster-id":"3f68255a3b440659","publish-timeout":"7s"} {"level":"info","ts":"2026-07-26T15:45:12.136136Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-26T15:45:12.136237Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-26T15:45:12.137131Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T15:45:12.137324Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T15:45:12.137379Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-26T15:45:12.139154Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"info","ts":"2026-07-26T15:45:12.139486Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-26T15:45:33.786438Z","caller":"traceutil/trace.go:171","msg":"trace[226690622] linearizableReadLoop","detail":"{readStateIndex:399; appliedIndex:398; }","duration":"109.873037ms","start":"2026-07-26T15:45:33.676537Z","end":"2026-07-26T15:45:33.78641Z","steps":["trace[226690622] 'read index received' (duration: 109.638022ms)","trace[226690622] 'applied index is now lower than readState.Index' (duration: 233.925µs)"],"step_count":2} {"level":"info","ts":"2026-07-26T15:45:33.786562Z","caller":"traceutil/trace.go:171","msg":"trace[1863045742] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"179.680581ms","start":"2026-07-26T15:45:33.606839Z","end":"2026-07-26T15:45:33.78652Z","steps":["trace[1863045742] 'process raft request' (duration: 179.415576ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:45:33.786627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.060841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-26T15:45:33.786698Z","caller":"traceutil/trace.go:171","msg":"trace[1908652435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:382; }","duration":"110.202274ms","start":"2026-07-26T15:45:33.676483Z","end":"2026-07-26T15:45:33.786686Z","steps":["trace[1908652435] 'agreement among raft nodes before linearized reading' (duration: 110.062431ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:45:34.016179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.906304ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T15:45:34.016294Z","caller":"traceutil/trace.go:171","msg":"trace[1709129417] linearizableReadLoop","detail":"{readStateIndex:401; appliedIndex:400; }","duration":"108.449976ms","start":"2026-07-26T15:45:33.907826Z","end":"2026-07-26T15:45:34.016276Z","steps":["trace[1709129417] 'read index received' (duration: 34.091µs)","trace[1709129417] 'applied index is now lower than readState.Index' (duration: 108.414175ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T15:45:34.016386Z","caller":"traceutil/trace.go:171","msg":"trace[2016363084] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"168.192977ms","start":"2026-07-26T15:45:33.84818Z","end":"2026-07-26T15:45:34.016373Z","steps":["trace[2016363084] 'process raft request' (duration: 45.260912ms)","trace[2016363084] 'compare' (duration: 121.766721ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T15:45:34.016638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.775633ms","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-07-26T15:45:34.016736Z","caller":"traceutil/trace.go:171","msg":"trace[1275199910] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:384; }","duration":"108.953838ms","start":"2026-07-26T15:45:33.907757Z","end":"2026-07-26T15:45:34.016711Z","steps":["trace[1275199910] 'agreement among raft nodes before linearized reading' (duration: 108.727103ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:45:34.268048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.760318ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T15:45:34.268158Z","caller":"traceutil/trace.go:171","msg":"trace[479143965] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"247.694792ms","start":"2026-07-26T15:45:34.020443Z","end":"2026-07-26T15:45:34.268138Z","steps":["trace[479143965] 'process raft request' (duration: 139.758181ms)","trace[479143965] 'compare' (duration: 107.638295ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T15:45:34.283437Z","caller":"traceutil/trace.go:171","msg":"trace[1760745245] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"262.140281ms","start":"2026-07-26T15:45:34.021274Z","end":"2026-07-26T15:45:34.283414Z","steps":["trace[1760745245] 'process raft request' (duration: 261.983578ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:45:34.283555Z","caller":"traceutil/trace.go:171","msg":"trace[683566580] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"255.612813ms","start":"2026-07-26T15:45:34.027921Z","end":"2026-07-26T15:45:34.283534Z","steps":["trace[683566580] 'process raft request' (duration: 255.443629ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:45:56.05844Z","caller":"traceutil/trace.go:171","msg":"trace[898122059] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"113.143715ms","start":"2026-07-26T15:45:55.945269Z","end":"2026-07-26T15:45:56.058412Z","steps":["trace[898122059] 'process raft request' (duration: 94.231671ms)","trace[898122059] 'compare' (duration: 18.801001ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T15:45:56.239196Z","caller":"traceutil/trace.go:171","msg":"trace[745150922] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"134.235989ms","start":"2026-07-26T15:45:56.104924Z","end":"2026-07-26T15:45:56.23916Z","steps":["trace[745150922] 'read index received' (duration: 85.712252ms)","trace[745150922] 'applied index is now lower than readState.Index' (duration: 48.522527ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T15:45:56.239249Z","caller":"traceutil/trace.go:171","msg":"trace[1440804830] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"154.394271ms","start":"2026-07-26T15:45:56.084808Z","end":"2026-07-26T15:45:56.239203Z","steps":["trace[1440804830] 'process raft request' (duration: 106.045468ms)","trace[1440804830] 'compare' (duration: 47.967374ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T15:45:56.239412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.467734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8hwrj\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-26T15:45:56.239458Z","caller":"traceutil/trace.go:171","msg":"trace[954049412] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8hwrj; range_end:; response_count:1; response_revision:581; }","duration":"134.555266ms","start":"2026-07-26T15:45:56.104891Z","end":"2026-07-26T15:45:56.239446Z","steps":["trace[954049412] 'agreement among raft nodes before linearized reading' (duration: 134.382882ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:45:56.497005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.707072ms","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-07-26T15:45:56.497076Z","caller":"traceutil/trace.go:171","msg":"trace[1086532337] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:582; }","duration":"127.821394ms","start":"2026-07-26T15:45:56.369239Z","end":"2026-07-26T15:45:56.497061Z","steps":["trace[1086532337] 'range keys from in-memory index tree' (duration: 127.516998ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:45:56.497297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.663529ms","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-07-26T15:45:56.497422Z","caller":"traceutil/trace.go:171","msg":"trace[852638840] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:582; }","duration":"126.839712ms","start":"2026-07-26T15:45:56.370554Z","end":"2026-07-26T15:45:56.497394Z","steps":["trace[852638840] 'range keys from in-memory index tree' (duration: 126.417383ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:45:56.980993Z","caller":"traceutil/trace.go:171","msg":"trace[59543678] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"235.471118ms","start":"2026-07-26T15:45:56.745492Z","end":"2026-07-26T15:45:56.980963Z","steps":["trace[59543678] 'process raft request' (duration: 228.279307ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:46:39.322554Z","caller":"traceutil/trace.go:171","msg":"trace[826187764] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"136.797113ms","start":"2026-07-26T15:46:39.185728Z","end":"2026-07-26T15:46:39.322525Z","steps":["trace[826187764] 'process raft request' (duration: 136.577997ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:46:45.846014Z","caller":"traceutil/trace.go:171","msg":"trace[1963036971] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"216.373496ms","start":"2026-07-26T15:46:45.629606Z","end":"2026-07-26T15:46:45.845979Z","steps":["trace[1963036971] 'process raft request' (duration: 216.222932ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:46:45.846746Z","caller":"traceutil/trace.go:171","msg":"trace[1180365959] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"110.938723ms","start":"2026-07-26T15:46:45.73579Z","end":"2026-07-26T15:46:45.846729Z","steps":["trace[1180365959] 'process raft request' (duration: 110.611696ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:47:16.923184Z","caller":"traceutil/trace.go:171","msg":"trace[908311739] transaction","detail":"{read_only:false; response_revision:1792; number_of_response:1; }","duration":"124.110587ms","start":"2026-07-26T15:47:16.799046Z","end":"2026-07-26T15:47:16.923157Z","steps":["trace[908311739] 'process raft request' (duration: 123.875151ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:47:17.179153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.804854ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T15:47:17.179272Z","caller":"traceutil/trace.go:171","msg":"trace[1693454234] linearizableReadLoop","detail":"{readStateIndex:1862; appliedIndex:1860; }","duration":"297.206775ms","start":"2026-07-26T15:47:16.882046Z","end":"2026-07-26T15:47:17.179253Z","steps":["trace[1693454234] 'read index received' (duration: 40.99496ms)","trace[1693454234] 'applied index is now lower than readState.Index' (duration: 256.210094ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T15:47:17.179322Z","caller":"traceutil/trace.go:171","msg":"trace[298954369] transaction","detail":"{read_only:false; response_revision:1793; number_of_response:1; }","duration":"310.559639ms","start":"2026-07-26T15:47:16.868712Z","end":"2026-07-26T15:47:17.179271Z","steps":["trace[298954369] 'process raft request' (duration: 176.534729ms)","trace[298954369] 'compare' (duration: 133.542727ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T15:47:17.179404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.363288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T15:47:17.179437Z","caller":"traceutil/trace.go:171","msg":"trace[1851099675] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1793; }","duration":"297.41801ms","start":"2026-07-26T15:47:16.882007Z","end":"2026-07-26T15:47:17.179425Z","steps":["trace[1851099675] 'agreement among raft nodes before linearized reading' (duration: 297.353258ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:47:17.179551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:47:16.86867Z","time spent":"310.762554ms","remote":"127.0.0.1:37522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T15:47:17.17977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.013283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T15:47:17.179896Z","caller":"traceutil/trace.go:171","msg":"trace[914323536] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1793; }","duration":"284.65624ms","start":"2026-07-26T15:47:16.895218Z","end":"2026-07-26T15:47:17.179874Z","steps":["trace[914323536] 'agreement among raft nodes before linearized reading' (duration: 284.468685ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:47:17.180239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.747279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-26T15:47:17.180206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.922196ms","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-07-26T15:47:17.18029Z","caller":"traceutil/trace.go:171","msg":"trace[1366775792] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1793; }","duration":"198.850531ms","start":"2026-07-26T15:47:16.981429Z","end":"2026-07-26T15:47:17.180279Z","steps":["trace[1366775792] 'agreement among raft nodes before linearized reading' (duration: 198.655386ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:47:17.18032Z","caller":"traceutil/trace.go:171","msg":"trace[1064258708] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1793; }","duration":"108.123071ms","start":"2026-07-26T15:47:17.072172Z","end":"2026-07-26T15:47:17.180295Z","steps":["trace[1064258708] 'agreement among raft nodes before linearized reading' (duration: 107.750421ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:47:45.20132Z","caller":"traceutil/trace.go:171","msg":"trace[335130375] transaction","detail":"{read_only:false; response_revision:1943; number_of_response:1; }","duration":"154.188575ms","start":"2026-07-26T15:47:45.04708Z","end":"2026-07-26T15:47:45.201269Z","steps":["trace[335130375] 'process raft request' (duration: 80.609021ms)","trace[335130375] 'compare' (duration: 73.236655ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T15:49:07.29728Z","caller":"traceutil/trace.go:171","msg":"trace[1092508297] transaction","detail":"{read_only:false; response_revision:2363; number_of_response:1; }","duration":"308.237568ms","start":"2026-07-26T15:49:06.989015Z","end":"2026-07-26T15:49:07.297253Z","steps":["trace[1092508297] 'process raft request' (duration: 308.035074ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:49:07.297469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:49:06.988961Z","time spent":"308.419291ms","remote":"127.0.0.1:37522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-26T15:49:07.371499Z","caller":"traceutil/trace.go:171","msg":"trace[1116390035] linearizableReadLoop","detail":"{readStateIndex:2455; appliedIndex:2453; }","duration":"154.481536ms","start":"2026-07-26T15:49:07.216975Z","end":"2026-07-26T15:49:07.371457Z","steps":["trace[1116390035] 'read index received' (duration: 80.170553ms)","trace[1116390035] 'applied index is now lower than readState.Index' (duration: 74.309133ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T15:49:07.371619Z","caller":"traceutil/trace.go:171","msg":"trace[1506147667] transaction","detail":"{read_only:false; response_revision:2364; number_of_response:1; }","duration":"256.586509ms","start":"2026-07-26T15:49:07.11501Z","end":"2026-07-26T15:49:07.371597Z","steps":["trace[1506147667] 'process raft request' (duration: 256.255003ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:49:07.371854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.850782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-26T15:49:07.371907Z","caller":"traceutil/trace.go:171","msg":"trace[1620424468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2364; }","duration":"154.997025ms","start":"2026-07-26T15:49:07.216897Z","end":"2026-07-26T15:49:07.371894Z","steps":["trace[1620424468] 'agreement among raft nodes before linearized reading' (duration: 154.74484ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:49:07.542966Z","caller":"traceutil/trace.go:171","msg":"trace[1477424426] transaction","detail":"{read_only:false; response_revision:2365; number_of_response:1; }","duration":"165.426561ms","start":"2026-07-26T15:49:07.377503Z","end":"2026-07-26T15:49:07.54293Z","steps":["trace[1477424426] 'process raft request' (duration: 139.817671ms)","trace[1477424426] 'compare' (duration: 25.397276ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T15:49:07.54346Z","caller":"traceutil/trace.go:171","msg":"trace[1575566146] transaction","detail":"{read_only:false; response_revision:2366; number_of_response:1; }","duration":"165.402221ms","start":"2026-07-26T15:49:07.378022Z","end":"2026-07-26T15:49:07.543424Z","steps":["trace[1575566146] 'process raft request' (duration: 164.85826ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:49:29.405344Z","caller":"traceutil/trace.go:171","msg":"trace[466181619] transaction","detail":"{read_only:false; response_revision:2473; number_of_response:1; }","duration":"118.095084ms","start":"2026-07-26T15:49:29.287187Z","end":"2026-07-26T15:49:29.405283Z","steps":["trace[466181619] 'process raft request' (duration: 117.856928ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:49:30.091785Z","caller":"traceutil/trace.go:171","msg":"trace[8771307] transaction","detail":"{read_only:false; response_revision:2479; number_of_response:1; }","duration":"103.27027ms","start":"2026-07-26T15:49:29.988478Z","end":"2026-07-26T15:49:30.091748Z","steps":["trace[8771307] 'process raft request' (duration: 103.088307ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:49:30.167657Z","caller":"traceutil/trace.go:171","msg":"trace[860239110] transaction","detail":"{read_only:false; response_revision:2480; number_of_response:1; }","duration":"176.64125ms","start":"2026-07-26T15:49:29.990949Z","end":"2026-07-26T15:49:30.16759Z","steps":["trace[860239110] 'process raft request' (duration: 122.630642ms)","trace[860239110] 'compare' (duration: 53.792924ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T15:49:31.218506Z","caller":"traceutil/trace.go:171","msg":"trace[580796044] transaction","detail":"{read_only:false; response_revision:2483; number_of_response:1; }","duration":"278.241426ms","start":"2026-07-26T15:49:30.940231Z","end":"2026-07-26T15:49:31.218472Z","steps":["trace[580796044] 'process raft request' (duration: 224.462696ms)","trace[580796044] 'compare' (duration: 53.156728ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T15:54:04.63924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.820049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T15:54:04.639328Z","caller":"traceutil/trace.go:171","msg":"trace[1506262821] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:4039; }","duration":"158.974312ms","start":"2026-07-26T15:54:04.480335Z","end":"2026-07-26T15:54:04.639309Z","steps":["trace[1506262821] 'count revisions from in-memory index tree' (duration: 158.713047ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:54:04.639786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.856442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"info","ts":"2026-07-26T15:54:04.639843Z","caller":"traceutil/trace.go:171","msg":"trace[1816668771] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:4039; }","duration":"134.913633ms","start":"2026-07-26T15:54:04.504917Z","end":"2026-07-26T15:54:04.639831Z","steps":["trace[1816668771] 'range keys from in-memory index tree' (duration: 134.697439ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:54:04.640352Z","caller":"traceutil/trace.go:171","msg":"trace[1579458739] transaction","detail":"{read_only:false; response_revision:4040; number_of_response:1; }","duration":"128.120398ms","start":"2026-07-26T15:54:04.512217Z","end":"2026-07-26T15:54:04.640338Z","steps":["trace[1579458739] 'process raft request' (duration: 71.542783ms)","trace[1579458739] 'compare' (duration: 56.484223ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T15:54:04.678899Z","caller":"traceutil/trace.go:171","msg":"trace[1481793159] transaction","detail":"{read_only:false; response_revision:4041; number_of_response:1; }","duration":"101.983068ms","start":"2026-07-26T15:54:04.576902Z","end":"2026-07-26T15:54:04.678885Z","steps":["trace[1481793159] 'process raft request' (duration: 101.776394ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:54:43.5468Z","caller":"traceutil/trace.go:171","msg":"trace[295503545] transaction","detail":"{read_only:false; response_revision:4345; number_of_response:1; }","duration":"102.67921ms","start":"2026-07-26T15:54:43.444072Z","end":"2026-07-26T15:54:43.546752Z","steps":["trace[295503545] 'process raft request' (duration: 102.280442ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:54:55.767507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.925123ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T15:54:55.767827Z","caller":"traceutil/trace.go:171","msg":"trace[1906329172] transaction","detail":"{read_only:false; response_revision:4409; number_of_response:1; }","duration":"168.788131ms","start":"2026-07-26T15:54:55.599016Z","end":"2026-07-26T15:54:55.767804Z","steps":["trace[1906329172] 'process raft request' (duration: 168.71804ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:54:55.768042Z","caller":"traceutil/trace.go:171","msg":"trace[532823258] transaction","detail":"{read_only:false; response_revision:4408; number_of_response:1; }","duration":"291.832178ms","start":"2026-07-26T15:54:55.476184Z","end":"2026-07-26T15:54:55.768017Z","steps":["trace[532823258] 'process raft request' (duration: 291.44193ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:54:55.768051Z","caller":"traceutil/trace.go:171","msg":"trace[440275234] linearizableReadLoop","detail":"{readStateIndex:4580; appliedIndex:4579; }","duration":"365.350867ms","start":"2026-07-26T15:54:55.40257Z","end":"2026-07-26T15:54:55.767921Z","steps":["trace[440275234] 'read index received' (duration: 153.016646ms)","trace[440275234] 'applied index is now lower than readState.Index' (duration: 212.326871ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T15:54:55.768077Z","caller":"traceutil/trace.go:171","msg":"trace[79090179] transaction","detail":"{read_only:false; response_revision:4407; number_of_response:1; }","duration":"384.622521ms","start":"2026-07-26T15:54:55.38339Z","end":"2026-07-26T15:54:55.768012Z","steps":["trace[79090179] 'process raft request' (duration: 172.090166ms)","trace[79090179] 'compare' (duration: 211.693669ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T15:54:55.768335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.745675ms","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":"warn","ts":"2026-07-26T15:54:55.768393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.756135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-07-26T15:54:55.768398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.966195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-dh59b\" ","response":"range_response_count:1 size:20565"} {"level":"info","ts":"2026-07-26T15:54:55.768447Z","caller":"traceutil/trace.go:171","msg":"trace[1975881999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4409; }","duration":"339.831686ms","start":"2026-07-26T15:54:55.428598Z","end":"2026-07-26T15:54:55.76843Z","steps":["trace[1975881999] 'agreement among raft nodes before linearized reading' (duration: 339.652863ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:54:55.768445Z","caller":"traceutil/trace.go:171","msg":"trace[2092013526] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4409; }","duration":"365.893718ms","start":"2026-07-26T15:54:55.402525Z","end":"2026-07-26T15:54:55.768418Z","steps":["trace[2092013526] 'agreement among raft nodes before linearized reading' (duration: 365.620203ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:54:55.768465Z","caller":"traceutil/trace.go:171","msg":"trace[1393857365] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-dh59b; range_end:; response_count:1; response_revision:4409; }","duration":"144.065137ms","start":"2026-07-26T15:54:55.624382Z","end":"2026-07-26T15:54:55.768448Z","steps":["trace[1393857365] 'agreement among raft nodes before linearized reading' (duration: 143.880493ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:54:55.768503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:54:55.428587Z","time spent":"339.904228ms","remote":"127.0.0.1:37522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-26T15:54:55.768519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:54:55.402476Z","time spent":"366.026601ms","remote":"127.0.0.1:37522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-26T15:54:55.768365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:54:55.383367Z","time spent":"384.905387ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T15:54:56.110688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.539336ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-26T15:54:56.110794Z","caller":"traceutil/trace.go:171","msg":"trace[542281670] linearizableReadLoop","detail":"{readStateIndex:4583; appliedIndex:4582; }","duration":"338.367598ms","start":"2026-07-26T15:54:55.772406Z","end":"2026-07-26T15:54:56.110774Z","steps":["trace[542281670] 'read index received' (duration: 185.73126ms)","trace[542281670] 'applied index is now lower than readState.Index' (duration: 152.634928ms)"],"step_count":2} {"level":"info","ts":"2026-07-26T15:54:56.11087Z","caller":"traceutil/trace.go:171","msg":"trace[1826548011] transaction","detail":"{read_only:false; response_revision:4410; number_of_response:1; }","duration":"339.037381ms","start":"2026-07-26T15:54:55.771819Z","end":"2026-07-26T15:54:56.110857Z","steps":["trace[1826548011] 'process raft request' (duration: 186.210329ms)","trace[1826548011] 'compare' (duration: 152.23812ms)"],"step_count":2} {"level":"warn","ts":"2026-07-26T15:54:56.111053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:54:55.7718Z","time spent":"339.158744ms","remote":"127.0.0.1:37522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T15:54:56.111093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.668484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-26T15:54:56.111449Z","caller":"traceutil/trace.go:171","msg":"trace[27174105] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:4410; }","duration":"338.97022ms","start":"2026-07-26T15:54:55.772365Z","end":"2026-07-26T15:54:56.111335Z","steps":["trace[27174105] 'agreement among raft nodes before linearized reading' (duration: 338.534831ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:54:56.111536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:54:55.772349Z","time spent":"339.145854ms","remote":"127.0.0.1:37274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"info","ts":"2026-07-26T15:54:56.111598Z","caller":"traceutil/trace.go:171","msg":"trace[1084546732] transaction","detail":"{read_only:false; response_revision:4411; number_of_response:1; }","duration":"338.299217ms","start":"2026-07-26T15:54:55.773283Z","end":"2026-07-26T15:54:56.111582Z","steps":["trace[1084546732] 'process raft request' (duration: 337.947679ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:54:56.111684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:54:55.773253Z","time spent":"338.394108ms","remote":"127.0.0.1:37522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-26T15:54:56.111669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.33034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-26T15:54:56.111802Z","caller":"traceutil/trace.go:171","msg":"trace[2124359266] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4411; }","duration":"230.590236ms","start":"2026-07-26T15:54:55.881192Z","end":"2026-07-26T15:54:56.111782Z","steps":["trace[2124359266] 'agreement among raft nodes before linearized reading' (duration: 230.233558ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:54:56.111754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.549654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-07-26T15:54:56.111922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.168494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:86322"} {"level":"info","ts":"2026-07-26T15:54:56.112004Z","caller":"traceutil/trace.go:171","msg":"trace[1485404275] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:4411; }","duration":"338.269426ms","start":"2026-07-26T15:54:55.773715Z","end":"2026-07-26T15:54:56.111984Z","steps":["trace[1485404275] 'agreement among raft nodes before linearized reading' (duration: 337.661603ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:54:56.112029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.985861ms","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-26T15:54:56.112057Z","caller":"traceutil/trace.go:171","msg":"trace[487881015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4411; }","duration":"272.056143ms","start":"2026-07-26T15:54:55.839993Z","end":"2026-07-26T15:54:56.112049Z","steps":["trace[487881015] 'agreement among raft nodes before linearized reading' (duration: 271.674505ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T15:54:56.112063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-26T15:54:55.773704Z","time spent":"338.343698ms","remote":"127.0.0.1:37454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":9,"response size":86344,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-07-26T15:54:56.111939Z","caller":"traceutil/trace.go:171","msg":"trace[1571945071] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4411; }","duration":"267.763507ms","start":"2026-07-26T15:54:55.844157Z","end":"2026-07-26T15:54:56.111921Z","steps":["trace[1571945071] 'agreement among raft nodes before linearized reading' (duration: 267.439761ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:55:12.185588Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2692} {"level":"info","ts":"2026-07-26T15:55:12.267869Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2692,"took":"81.343024ms","hash":1228240869,"current-db-size-bytes":34648064,"current-db-size":"35 MB","current-db-size-in-use-bytes":9764864,"current-db-size-in-use":"9.8 MB"} {"level":"info","ts":"2026-07-26T15:55:12.267953Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1228240869,"revision":2692,"compact-revision":-1} {"level":"info","ts":"2026-07-26T15:55:44.475748Z","caller":"traceutil/trace.go:171","msg":"trace[1127127656] transaction","detail":"{read_only:false; response_revision:4777; number_of_response:1; }","duration":"123.542421ms","start":"2026-07-26T15:55:44.352167Z","end":"2026-07-26T15:55:44.475709Z","steps":["trace[1127127656] 'process raft request' (duration: 123.218575ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:55:45.274579Z","caller":"traceutil/trace.go:171","msg":"trace[1478155547] transaction","detail":"{read_only:false; response_revision:4785; number_of_response:1; }","duration":"123.683113ms","start":"2026-07-26T15:55:45.150505Z","end":"2026-07-26T15:55:45.274188Z","steps":["trace[1478155547] 'process raft request' (duration: 123.364167ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T15:55:56.631673Z","caller":"traceutil/trace.go:171","msg":"trace[50331531] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"114.305365ms","start":"2026-07-26T15:55:56.517339Z","end":"2026-07-26T15:55:56.631645Z","steps":["trace[50331531] 'process raft request' (duration: 114.0609ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T16:00:12.191797Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4499} {"level":"info","ts":"2026-07-26T16:00:12.231166Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4499,"took":"38.267807ms","hash":2004400386,"current-db-size-bytes":34648064,"current-db-size":"35 MB","current-db-size-in-use-bytes":13082624,"current-db-size-in-use":"13 MB"} {"level":"info","ts":"2026-07-26T16:00:12.231213Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2004400386,"revision":4499,"compact-revision":2692} {"level":"info","ts":"2026-07-26T16:04:59.511284Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"3cec112083e8d3ff","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-26T16:04:59.516995Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-26T16:04:59.5171Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-26T16:05:10.194961Z","caller":"traceutil/trace.go:171","msg":"trace[379478480] transaction","detail":"{read_only:false; response_revision:9762; number_of_response:1; }","duration":"101.976068ms","start":"2026-07-26T16:05:10.092843Z","end":"2026-07-26T16:05:10.194819Z","steps":["trace[379478480] 'process raft request' (duration: 101.707653ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T16:05:10.23676Z","caller":"traceutil/trace.go:171","msg":"trace[856717543] transaction","detail":"{read_only:false; response_revision:9763; number_of_response:1; }","duration":"122.178948ms","start":"2026-07-26T16:05:10.114545Z","end":"2026-07-26T16:05:10.236724Z","steps":["trace[856717543] 'process raft request' (duration: 121.903363ms)"],"step_count":1} {"level":"warn","ts":"2026-07-26T16:05:10.236895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.919664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-8qpkc\" ","response":"range_response_count:1 size:22021"} {"level":"info","ts":"2026-07-26T16:05:10.236956Z","caller":"traceutil/trace.go:171","msg":"trace[109987335] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-8qpkc; range_end:; response_count:1; response_revision:9763; }","duration":"126.047277ms","start":"2026-07-26T16:05:10.110889Z","end":"2026-07-26T16:05:10.236936Z","steps":["trace[109987335] 'agreement among raft nodes before linearized reading' (duration: 125.789682ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T16:05:12.198256Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6488} {"level":"info","ts":"2026-07-26T16:05:12.241208Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6488,"took":"40.907351ms","hash":3666956037,"current-db-size-bytes":34648064,"current-db-size":"35 MB","current-db-size-in-use-bytes":23199744,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-07-26T16:05:12.241282Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3666956037,"revision":6488,"compact-revision":4499} {"level":"info","ts":"2026-07-26T16:10:12.205566Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9777} {"level":"info","ts":"2026-07-26T16:10:12.294528Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9777,"took":"86.317575ms","hash":2886359008,"current-db-size-bytes":34648064,"current-db-size":"35 MB","current-db-size-in-use-bytes":20901888,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-07-26T16:10:12.294592Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2886359008,"revision":9777,"compact-revision":6488} {"level":"warn","ts":"2026-07-26T16:11:20.217343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.391985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-8qpkc\" ","response":"range_response_count:1 size:22021"} {"level":"info","ts":"2026-07-26T16:11:20.217451Z","caller":"traceutil/trace.go:171","msg":"trace[2126559956] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-8qpkc; range_end:; response_count:1; response_revision:12561; }","duration":"107.558188ms","start":"2026-07-26T16:11:20.109868Z","end":"2026-07-26T16:11:20.217427Z","steps":["trace[2126559956] 'range keys from in-memory index tree' (duration: 107.15555ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T16:11:26.321297Z","caller":"traceutil/trace.go:171","msg":"trace[1140143222] transaction","detail":"{read_only:false; response_revision:12605; number_of_response:1; }","duration":"151.883935ms","start":"2026-07-26T16:11:26.169378Z","end":"2026-07-26T16:11:26.321262Z","steps":["trace[1140143222] 'process raft request' (duration: 151.63493ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T16:11:26.893192Z","caller":"traceutil/trace.go:171","msg":"trace[107877059] transaction","detail":"{read_only:false; response_revision:12607; number_of_response:1; }","duration":"109.505679ms","start":"2026-07-26T16:11:26.78366Z","end":"2026-07-26T16:11:26.893166Z","steps":["trace[107877059] 'process raft request' (duration: 109.291865ms)"],"step_count":1} {"level":"info","ts":"2026-07-26T16:15:12.212235Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12093} {"level":"info","ts":"2026-07-26T16:15:12.289587Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12093,"took":"74.932349ms","hash":1013355095,"current-db-size-bytes":34648064,"current-db-size":"35 MB","current-db-size-in-use-bytes":17608704,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-26T16:15:12.289676Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1013355095,"revision":12093,"compact-revision":9777} {"level":"info","ts":"2026-07-26T16:20:12.219372Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13914} {"level":"info","ts":"2026-07-26T16:20:12.295684Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13914,"took":"73.920988ms","hash":1340464176,"current-db-size-bytes":34648064,"current-db-size":"35 MB","current-db-size-in-use-bytes":14798848,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-07-26T16:20:12.295789Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1340464176,"revision":13914,"compact-revision":12093} {"level":"info","ts":"2026-07-26T16:25:12.225289Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15528} {"level":"info","ts":"2026-07-26T16:25:12.290522Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15528,"took":"63.102002ms","hash":1745328365,"current-db-size-bytes":34648064,"current-db-size":"35 MB","current-db-size-in-use-bytes":14594048,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-07-26T16:25:12.290611Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1745328365,"revision":15528,"compact-revision":13914} {"level":"info","ts":"2026-07-26T16:30:12.233052Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17104} {"level":"info","ts":"2026-07-26T16:30:12.301977Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17104,"took":"66.491537ms","hash":2102378251,"current-db-size-bytes":34648064,"current-db-size":"35 MB","current-db-size-in-use-bytes":14565376,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-07-26T16:30:12.302069Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2102378251,"revision":17104,"compact-revision":15528} {"level":"info","ts":"2026-07-26T16:32:13.586639Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"3cec112083e8d3ff","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-26T16:32:13.593138Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-26T16:32:13.593224Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-26T16:35:12.239101Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18667} {"level":"info","ts":"2026-07-26T16:35:12.305827Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18667,"took":"64.04972ms","hash":1499904252,"current-db-size-bytes":34648064,"current-db-size":"35 MB","current-db-size-in-use-bytes":14594048,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-07-26T16:35:12.305898Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1499904252,"revision":18667,"compact-revision":17104} {"level":"info","ts":"2026-07-26T16:40:12.247913Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20236} {"level":"info","ts":"2026-07-26T16:40:12.324625Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20236,"took":"73.721049ms","hash":1526244655,"current-db-size-bytes":34648064,"current-db-size":"35 MB","current-db-size-in-use-bytes":14680064,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-07-26T16:40:12.324717Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1526244655,"revision":20236,"compact-revision":18667}