{"level":"warn","ts":"2026-07-16T15:53:31.47381Z","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-16T15:53:31.473905Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72: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-16T15:53:31.473966Z","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-16T15:53:31.47398Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-07-16T15:53:31.473999Z","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-16T15:53:31.474609Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-07-16T15:53:31.474678Z","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.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72: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-16T15:53:31.476613Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.730955ms"} {"level":"info","ts":"2026-07-16T15:53:31.482556Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-07-16T15:53:31.482638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-07-16T15:53:31.482666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-07-16T15:53:31.482676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-16T15:53:31.482683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-07-16T15:53:31.482717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-07-16T15:53:31.486786Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-16T15:53:31.488957Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-16T15:53:31.489985Z","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-16T15:53:31.491581Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-16T15:53:31.492983Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-16T15:53:31.49313Z","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-16T15:53:31.493348Z","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-16T15:53:31.493378Z","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-16T15:53:31.493846Z","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-16T15:53:31.494047Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-16T15:53:31.494064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-07-16T15:53:31.494098Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-16T15:53:31.494155Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-07-16T15:53:31.494241Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-07-16T15:53:31.494239Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-07-16T15:53:31.883408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-07-16T15:53:31.883509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-07-16T15:53:31.883551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-07-16T15:53:31.883582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-07-16T15:53:31.883595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-07-16T15:53:31.883611Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-07-16T15:53:31.883721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-07-16T15:53:31.884627Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-07-16T15:53:31.884832Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-16T15:53:31.884904Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-16T15:53:31.884946Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T15:53:31.885519Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-16T15:53:31.885553Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-16T15:53:31.885869Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T15:53:31.886053Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T15:53:31.886088Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T15:53:31.888631Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-07-16T15:53:31.888743Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-16T15:53:54.234955Z","caller":"traceutil/trace.go:171","msg":"trace[1204631280] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"105.564074ms","start":"2026-07-16T15:53:54.129358Z","end":"2026-07-16T15:53:54.234922Z","steps":["trace[1204631280] 'process raft request' (duration: 105.36416ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T15:54:07.064809Z","caller":"traceutil/trace.go:171","msg":"trace[655745438] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"103.526733ms","start":"2026-07-16T15:54:06.96098Z","end":"2026-07-16T15:54:07.064506Z","steps":["trace[655745438] 'process raft request' (duration: 103.37814ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T15:54:07.072035Z","caller":"traceutil/trace.go:171","msg":"trace[6242996] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"108.666616ms","start":"2026-07-16T15:54:06.963358Z","end":"2026-07-16T15:54:07.072025Z","steps":["trace[6242996] 'process raft request' (duration: 108.189737ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T15:54:07.072116Z","caller":"traceutil/trace.go:171","msg":"trace[1083406430] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"108.484283ms","start":"2026-07-16T15:54:06.963626Z","end":"2026-07-16T15:54:07.07211Z","steps":["trace[1083406430] 'process raft request' (duration: 107.986343ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T15:54:13.419564Z","caller":"traceutil/trace.go:171","msg":"trace[478983473] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"330.001687ms","start":"2026-07-16T15:54:13.089529Z","end":"2026-07-16T15:54:13.419531Z","steps":["trace[478983473] 'process raft request' (duration: 329.406986ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T15:54:13.420174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T15:54:13.089495Z","time spent":"330.15336ms","remote":"127.0.0.1:40312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T15:54:13.855268Z","caller":"traceutil/trace.go:171","msg":"trace[1689834395] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"371.362193ms","start":"2026-07-16T15:54:13.483885Z","end":"2026-07-16T15:54:13.855247Z","steps":["trace[1689834395] 'process raft request' (duration: 371.196809ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T15:54:13.855381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T15:54:13.483864Z","time spent":"371.469825ms","remote":"127.0.0.1:40716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-16T15:54:58.208454Z","caller":"traceutil/trace.go:171","msg":"trace[1964336441] linearizableReadLoop","detail":"{readStateIndex:1222; appliedIndex:1221; }","duration":"118.350055ms","start":"2026-07-16T15:54:58.09008Z","end":"2026-07-16T15:54:58.20843Z","steps":["trace[1964336441] 'read index received' (duration: 118.155922ms)","trace[1964336441] 'applied index is now lower than readState.Index' (duration: 193.223µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T15:54:58.208647Z","caller":"traceutil/trace.go:171","msg":"trace[358261215] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"118.689722ms","start":"2026-07-16T15:54:58.089933Z","end":"2026-07-16T15:54:58.208623Z","steps":["trace[358261215] 'process raft request' (duration: 118.364346ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T15:54:58.208643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.55449ms","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-16T15:54:58.208738Z","caller":"traceutil/trace.go:171","msg":"trace[1443165842] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1189; }","duration":"118.667123ms","start":"2026-07-16T15:54:58.090061Z","end":"2026-07-16T15:54:58.208729Z","steps":["trace[1443165842] 'agreement among raft nodes before linearized reading' (duration: 118.470848ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T15:55:43.374432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.367683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T15:55:43.374564Z","caller":"traceutil/trace.go:171","msg":"trace[1232746858] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1847; }","duration":"287.548476ms","start":"2026-07-16T15:55:43.086984Z","end":"2026-07-16T15:55:43.374533Z","steps":["trace[1232746858] 'range keys from in-memory index tree' (duration: 287.290201ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T15:55:43.37467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.702209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-16T15:55:43.374821Z","caller":"traceutil/trace.go:171","msg":"trace[16162720] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1847; }","duration":"177.961414ms","start":"2026-07-16T15:55:43.196829Z","end":"2026-07-16T15:55:43.37479Z","steps":["trace[16162720] 'count revisions from in-memory index tree' (duration: 177.551696ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T15:55:43.71891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.782885ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T15:55:43.719041Z","caller":"traceutil/trace.go:171","msg":"trace[1157181426] linearizableReadLoop","detail":"{readStateIndex:1919; appliedIndex:1918; }","duration":"255.337955ms","start":"2026-07-16T15:55:43.463678Z","end":"2026-07-16T15:55:43.719016Z","steps":["trace[1157181426] 'read index received' (duration: 17.04588ms)","trace[1157181426] 'applied index is now lower than readState.Index' (duration: 238.290595ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T15:55:43.719272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.580789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-402ed26d-c573-44ce-bd03-cee9cb2e463f\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-07-16T15:55:43.719334Z","caller":"traceutil/trace.go:171","msg":"trace[2072582122] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-402ed26d-c573-44ce-bd03-cee9cb2e463f; range_end:; response_count:1; response_revision:1849; }","duration":"255.663731ms","start":"2026-07-16T15:55:43.463653Z","end":"2026-07-16T15:55:43.719317Z","steps":["trace[2072582122] 'agreement among raft nodes before linearized reading' (duration: 255.477708ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T15:55:43.719534Z","caller":"traceutil/trace.go:171","msg":"trace[785187077] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"261.738502ms","start":"2026-07-16T15:55:43.457746Z","end":"2026-07-16T15:55:43.719485Z","steps":["trace[785187077] 'process raft request' (duration: 23.09332ms)","trace[785187077] 'compare' (duration: 237.664952ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T15:55:43.732209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.541277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T15:55:43.732269Z","caller":"traceutil/trace.go:171","msg":"trace[1898691940] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1850; }","duration":"262.611819ms","start":"2026-07-16T15:55:43.469643Z","end":"2026-07-16T15:55:43.732255Z","steps":["trace[1898691940] 'agreement among raft nodes before linearized reading' (duration: 262.502077ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T15:56:28.756191Z","caller":"traceutil/trace.go:171","msg":"trace[474732890] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"112.567979ms","start":"2026-07-16T15:56:28.643601Z","end":"2026-07-16T15:56:28.756169Z","steps":["trace[474732890] 'process raft request' (duration: 104.626062ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T15:56:35.119111Z","caller":"traceutil/trace.go:171","msg":"trace[1827614607] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"106.177344ms","start":"2026-07-16T15:56:35.01289Z","end":"2026-07-16T15:56:35.119067Z","steps":["trace[1827614607] 'process raft request' (duration: 105.934918ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T15:56:35.301859Z","caller":"traceutil/trace.go:171","msg":"trace[1869345066] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"164.08863ms","start":"2026-07-16T15:56:35.137739Z","end":"2026-07-16T15:56:35.301827Z","steps":["trace[1869345066] 'process raft request' (duration: 74.134839ms)","trace[1869345066] 'compare' (duration: 89.817999ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T15:56:35.942257Z","caller":"traceutil/trace.go:171","msg":"trace[383345002] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"225.274102ms","start":"2026-07-16T15:56:35.716956Z","end":"2026-07-16T15:56:35.94223Z","steps":["trace[383345002] 'process raft request' (duration: 225.118859ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T15:56:41.209831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.502588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T15:56:41.209922Z","caller":"traceutil/trace.go:171","msg":"trace[1858887163] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2218; }","duration":"123.63591ms","start":"2026-07-16T15:56:41.086259Z","end":"2026-07-16T15:56:41.209895Z","steps":["trace[1858887163] 'range keys from in-memory index tree' (duration: 123.419415ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T15:57:30.29246Z","caller":"traceutil/trace.go:171","msg":"trace[2144902943] linearizableReadLoop","detail":"{readStateIndex:2752; appliedIndex:2751; }","duration":"154.432253ms","start":"2026-07-16T15:57:30.138006Z","end":"2026-07-16T15:57:30.292439Z","steps":["trace[2144902943] 'read index received' (duration: 154.28365ms)","trace[2144902943] 'applied index is now lower than readState.Index' (duration: 147.803µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T15:57:30.292546Z","caller":"traceutil/trace.go:171","msg":"trace[717276308] transaction","detail":"{read_only:false; response_revision:2653; number_of_response:1; }","duration":"162.590834ms","start":"2026-07-16T15:57:30.129946Z","end":"2026-07-16T15:57:30.292537Z","steps":["trace[717276308] 'process raft request' (duration: 162.320889ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T15:57:30.292822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.740149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-07-16T15:57:30.292875Z","caller":"traceutil/trace.go:171","msg":"trace[1596043221] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2653; }","duration":"154.922613ms","start":"2026-07-16T15:57:30.137939Z","end":"2026-07-16T15:57:30.292862Z","steps":["trace[1596043221] 'agreement among raft nodes before linearized reading' (duration: 154.701128ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T15:57:30.296726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.763834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-16T15:57:30.296836Z","caller":"traceutil/trace.go:171","msg":"trace[2030834054] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2653; }","duration":"124.906828ms","start":"2026-07-16T15:57:30.171918Z","end":"2026-07-16T15:57:30.296824Z","steps":["trace[2030834054] 'agreement among raft nodes before linearized reading' (duration: 124.699134ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T15:58:03.66703Z","caller":"traceutil/trace.go:171","msg":"trace[295419817] transaction","detail":"{read_only:false; response_revision:2859; number_of_response:1; }","duration":"109.772539ms","start":"2026-07-16T15:58:03.557222Z","end":"2026-07-16T15:58:03.666994Z","steps":["trace[295419817] 'process raft request' (duration: 109.585476ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T15:58:03.856192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.326652ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T15:58:03.85631Z","caller":"traceutil/trace.go:171","msg":"trace[2005989375] transaction","detail":"{read_only:false; response_revision:2860; number_of_response:1; }","duration":"185.076568ms","start":"2026-07-16T15:58:03.671212Z","end":"2026-07-16T15:58:03.856289Z","steps":["trace[2005989375] 'process raft request' (duration: 79.563642ms)","trace[2005989375] 'compare' (duration: 105.18432ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:00:34.356177Z","caller":"traceutil/trace.go:171","msg":"trace[1173251585] transaction","detail":"{read_only:false; response_revision:3855; number_of_response:1; }","duration":"177.571387ms","start":"2026-07-16T16:00:34.178575Z","end":"2026-07-16T16:00:34.356146Z","steps":["trace[1173251585] 'process raft request' (duration: 177.417404ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:01:57.219254Z","caller":"traceutil/trace.go:171","msg":"trace[1573349843] linearizableReadLoop","detail":"{readStateIndex:5230; appliedIndex:5229; }","duration":"135.050963ms","start":"2026-07-16T16:01:57.084171Z","end":"2026-07-16T16:01:57.219222Z","steps":["trace[1573349843] 'read index received' (duration: 134.747838ms)","trace[1573349843] 'applied index is now lower than readState.Index' (duration: 301.815µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:01:57.219354Z","caller":"traceutil/trace.go:171","msg":"trace[201592624] transaction","detail":"{read_only:false; response_revision:5038; number_of_response:1; }","duration":"151.589002ms","start":"2026-07-16T16:01:57.067731Z","end":"2026-07-16T16:01:57.21932Z","steps":["trace[201592624] 'process raft request' (duration: 151.289277ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:01:57.21945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.251557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T16:01:57.219548Z","caller":"traceutil/trace.go:171","msg":"trace[2062307697] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5038; }","duration":"135.38726ms","start":"2026-07-16T16:01:57.084138Z","end":"2026-07-16T16:01:57.219525Z","steps":["trace[2062307697] 'agreement among raft nodes before linearized reading' (duration: 135.206227ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:01:57.219671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.731363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nm5rn\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-07-16T16:01:57.219762Z","caller":"traceutil/trace.go:171","msg":"trace[1211658228] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nm5rn; range_end:; response_count:1; response_revision:5038; }","duration":"111.864496ms","start":"2026-07-16T16:01:57.107878Z","end":"2026-07-16T16:01:57.219742Z","steps":["trace[1211658228] 'agreement among raft nodes before linearized reading' (duration: 111.569021ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:01:57.679201Z","caller":"traceutil/trace.go:171","msg":"trace[1232345582] transaction","detail":"{read_only:false; response_revision:5041; number_of_response:1; }","duration":"118.442134ms","start":"2026-07-16T16:01:57.560738Z","end":"2026-07-16T16:01:57.67918Z","steps":["trace[1232345582] 'process raft request' (duration: 118.229089ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:02:09.779412Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680221219996993477,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-16T16:02:09.849751Z","caller":"traceutil/trace.go:171","msg":"trace[895803795] transaction","detail":"{read_only:false; response_revision:5273; number_of_response:1; }","duration":"666.794466ms","start":"2026-07-16T16:02:09.182935Z","end":"2026-07-16T16:02:09.849729Z","steps":["trace[895803795] 'process raft request' (duration: 666.593402ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:02:09.849871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:02:09.182915Z","time spent":"666.895838ms","remote":"127.0.0.1:40284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":126895,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T16:02:09.850459Z","caller":"traceutil/trace.go:171","msg":"trace[484488907] transaction","detail":"{read_only:false; response_revision:5274; number_of_response:1; }","duration":"554.127234ms","start":"2026-07-16T16:02:09.296317Z","end":"2026-07-16T16:02:09.850444Z","steps":["trace[484488907] 'process raft request' (duration: 553.93079ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:02:09.850447Z","caller":"traceutil/trace.go:171","msg":"trace[598768374] linearizableReadLoop","detail":"{readStateIndex:5475; appliedIndex:5472; }","duration":"571.582581ms","start":"2026-07-16T16:02:09.278844Z","end":"2026-07-16T16:02:09.850426Z","steps":["trace[598768374] 'read index received' (duration: 570.724244ms)","trace[598768374] 'applied index is now lower than readState.Index' (duration: 857.357µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:02:09.850496Z","caller":"traceutil/trace.go:171","msg":"trace[1313173902] transaction","detail":"{read_only:false; response_revision:5275; number_of_response:1; }","duration":"131.827333ms","start":"2026-07-16T16:02:09.718646Z","end":"2026-07-16T16:02:09.850474Z","steps":["trace[1313173902] 'process raft request' (duration: 131.73266ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:02:09.850519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:02:09.296246Z","time spent":"554.245756ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:02:09.850644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.790775ms","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-16T16:02:09.850682Z","caller":"traceutil/trace.go:171","msg":"trace[885623663] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5275; }","duration":"571.865857ms","start":"2026-07-16T16:02:09.278805Z","end":"2026-07-16T16:02:09.850671Z","steps":["trace[885623663] 'agreement among raft nodes before linearized reading' (duration: 571.736014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:02:09.850707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.220206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-zwlhb\" ","response":"range_response_count:1 size:7817"} {"level":"warn","ts":"2026-07-16T16:02:09.850712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:02:09.278791Z","time spent":"571.913927ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-16T16:02:09.850731Z","caller":"traceutil/trace.go:171","msg":"trace[1163426201] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-zwlhb; range_end:; response_count:1; response_revision:5275; }","duration":"359.276558ms","start":"2026-07-16T16:02:09.491446Z","end":"2026-07-16T16:02:09.850723Z","steps":["trace[1163426201] 'agreement among raft nodes before linearized reading' (duration: 359.220816ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:02:09.85065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.782072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nm5rn\" ","response":"range_response_count:1 size:6527"} {"level":"warn","ts":"2026-07-16T16:02:09.850754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:02:09.491423Z","time spent":"359.326798ms","remote":"127.0.0.1:40416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":7839,"request content":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-zwlhb\" "} {"level":"warn","ts":"2026-07-16T16:02:09.850747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.165175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-16T16:02:09.850743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.438554ms","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-16T16:02:09.850796Z","caller":"traceutil/trace.go:171","msg":"trace[1800058502] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nm5rn; range_end:; response_count:1; response_revision:5275; }","duration":"561.922775ms","start":"2026-07-16T16:02:09.288839Z","end":"2026-07-16T16:02:09.850761Z","steps":["trace[1800058502] 'agreement among raft nodes before linearized reading' (duration: 561.720581ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:02:09.850828Z","caller":"traceutil/trace.go:171","msg":"trace[1339171441] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5275; }","duration":"104.567446ms","start":"2026-07-16T16:02:09.746244Z","end":"2026-07-16T16:02:09.850811Z","steps":["trace[1339171441] 'agreement among raft nodes before linearized reading' (duration: 104.346872ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:02:09.850855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:02:09.288825Z","time spent":"562.008537ms","remote":"127.0.0.1:40416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6549,"request content":"key:\"/registry/pods/openstack/keepalived-nm5rn\" "} {"level":"info","ts":"2026-07-16T16:02:09.850829Z","caller":"traceutil/trace.go:171","msg":"trace[463822237] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:5275; }","duration":"358.276258ms","start":"2026-07-16T16:02:09.492524Z","end":"2026-07-16T16:02:09.8508Z","steps":["trace[463822237] 'agreement among raft nodes before linearized reading' (duration: 358.147836ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:02:09.850974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:02:09.492503Z","time spent":"358.449651ms","remote":"127.0.0.1:50156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-16T16:02:18.111194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.344209ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T16:02:18.111347Z","caller":"traceutil/trace.go:171","msg":"trace[2098892313] transaction","detail":"{read_only:false; response_revision:5478; number_of_response:1; }","duration":"234.531822ms","start":"2026-07-16T16:02:17.876791Z","end":"2026-07-16T16:02:18.111323Z","steps":["trace[2098892313] 'process raft request' (duration: 126.980589ms)","trace[2098892313] 'compare' (duration: 107.229746ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:02:18.111651Z","caller":"traceutil/trace.go:171","msg":"trace[878754861] linearizableReadLoop","detail":"{readStateIndex:5684; appliedIndex:5681; }","duration":"208.853206ms","start":"2026-07-16T16:02:17.902739Z","end":"2026-07-16T16:02:18.111592Z","steps":["trace[878754861] 'read index received' (duration: 22.666447ms)","trace[878754861] 'applied index is now lower than readState.Index' (duration: 186.185609ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:02:18.11185Z","caller":"traceutil/trace.go:171","msg":"trace[1828820194] transaction","detail":"{read_only:false; response_revision:5479; number_of_response:1; }","duration":"219.655365ms","start":"2026-07-16T16:02:17.892179Z","end":"2026-07-16T16:02:18.111834Z","steps":["trace[1828820194] 'process raft request' (duration: 219.116375ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:02:18.111941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.778878ms","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-16T16:02:18.111981Z","caller":"traceutil/trace.go:171","msg":"trace[227028946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5479; }","duration":"205.863069ms","start":"2026-07-16T16:02:17.906109Z","end":"2026-07-16T16:02:18.111972Z","steps":["trace[227028946] 'agreement among raft nodes before linearized reading' (duration: 205.749937ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:02:18.112069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.308705ms","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-16T16:02:18.112169Z","caller":"traceutil/trace.go:171","msg":"trace[105245445] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5479; }","duration":"209.445648ms","start":"2026-07-16T16:02:17.902698Z","end":"2026-07-16T16:02:18.112144Z","steps":["trace[105245445] 'agreement among raft nodes before linearized reading' (duration: 209.158752ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:02:18.112218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.435684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nm5rn\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-07-16T16:02:18.112252Z","caller":"traceutil/trace.go:171","msg":"trace[616442356] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nm5rn; range_end:; response_count:1; response_revision:5479; }","duration":"200.500215ms","start":"2026-07-16T16:02:17.911742Z","end":"2026-07-16T16:02:18.112242Z","steps":["trace[616442356] 'agreement among raft nodes before linearized reading' (duration: 200.420904ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:02:18.112409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.516775ms","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-16T16:02:18.112433Z","caller":"traceutil/trace.go:171","msg":"trace[626173368] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5479; }","duration":"201.560516ms","start":"2026-07-16T16:02:17.910867Z","end":"2026-07-16T16:02:18.112427Z","steps":["trace[626173368] 'agreement among raft nodes before linearized reading' (duration: 201.495605ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:02:18.271932Z","caller":"traceutil/trace.go:171","msg":"trace[655691107] linearizableReadLoop","detail":"{readStateIndex:5685; appliedIndex:5684; }","duration":"155.360696ms","start":"2026-07-16T16:02:18.116537Z","end":"2026-07-16T16:02:18.271898Z","steps":["trace[655691107] 'read index received' (duration: 124.506891ms)","trace[655691107] 'applied index is now lower than readState.Index' (duration: 30.852605ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:02:18.271962Z","caller":"traceutil/trace.go:171","msg":"trace[898478138] transaction","detail":"{read_only:false; response_revision:5480; number_of_response:1; }","duration":"155.435797ms","start":"2026-07-16T16:02:18.116474Z","end":"2026-07-16T16:02:18.27191Z","steps":["trace[898478138] 'process raft request' (duration: 124.411139ms)","trace[898478138] 'compare' (duration: 30.776153ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:02:18.272307Z","caller":"traceutil/trace.go:171","msg":"trace[1269733012] transaction","detail":"{read_only:false; response_revision:5482; number_of_response:1; }","duration":"154.366687ms","start":"2026-07-16T16:02:18.117927Z","end":"2026-07-16T16:02:18.272294Z","steps":["trace[1269733012] 'process raft request' (duration: 154.218523ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:02:18.272494Z","caller":"traceutil/trace.go:171","msg":"trace[453000614] transaction","detail":"{read_only:false; response_revision:5481; number_of_response:1; }","duration":"155.644311ms","start":"2026-07-16T16:02:18.116804Z","end":"2026-07-16T16:02:18.272448Z","steps":["trace[453000614] 'process raft request' (duration: 155.051399ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:02:18.27283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.176202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80200"} {"level":"info","ts":"2026-07-16T16:02:18.272972Z","caller":"traceutil/trace.go:171","msg":"trace[1219512780] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5481; }","duration":"156.437536ms","start":"2026-07-16T16:02:18.116503Z","end":"2026-07-16T16:02:18.272941Z","steps":["trace[1219512780] 'agreement among raft nodes before linearized reading' (duration: 155.539878ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:03:32.022208Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3014} {"level":"info","ts":"2026-07-16T16:03:32.106692Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3014,"took":"83.009959ms","hash":877482929,"current-db-size-bytes":59056128,"current-db-size":"59 MB","current-db-size-in-use-bytes":32174080,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-16T16:03:32.10675Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":877482929,"revision":3014,"compact-revision":-1} {"level":"info","ts":"2026-07-16T16:08:27.743747Z","caller":"traceutil/trace.go:171","msg":"trace[1877447979] transaction","detail":"{read_only:false; response_revision:8294; number_of_response:1; }","duration":"228.844602ms","start":"2026-07-16T16:08:27.514866Z","end":"2026-07-16T16:08:27.743711Z","steps":["trace[1877447979] 'process raft request' (duration: 228.639587ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:08:27.826426Z","caller":"traceutil/trace.go:171","msg":"trace[2004217343] transaction","detail":"{read_only:false; response_revision:8295; number_of_response:1; }","duration":"308.267283ms","start":"2026-07-16T16:08:27.518123Z","end":"2026-07-16T16:08:27.82639Z","steps":["trace[2004217343] 'process raft request' (duration: 293.0486ms)","trace[2004217343] 'compare' (duration: 15.06203ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:08:27.826622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:08:27.518105Z","time spent":"308.425376ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T16:08:32.028442Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6121} {"level":"info","ts":"2026-07-16T16:08:32.123154Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6121,"took":"92.708327ms","hash":1162891560,"current-db-size-bytes":59056128,"current-db-size":"59 MB","current-db-size-in-use-bytes":23408640,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-07-16T16:08:32.12323Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1162891560,"revision":6121,"compact-revision":3014} {"level":"info","ts":"2026-07-16T16:08:40.107381Z","caller":"traceutil/trace.go:171","msg":"trace[679338612] linearizableReadLoop","detail":"{readStateIndex:8654; appliedIndex:8653; }","duration":"148.836969ms","start":"2026-07-16T16:08:39.958522Z","end":"2026-07-16T16:08:40.107359Z","steps":["trace[679338612] 'read index received' (duration: 136.609083ms)","trace[679338612] 'applied index is now lower than readState.Index' (duration: 12.226976ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:08:40.107559Z","caller":"traceutil/trace.go:171","msg":"trace[641575142] transaction","detail":"{read_only:false; response_revision:8357; number_of_response:1; }","duration":"237.10155ms","start":"2026-07-16T16:08:39.870448Z","end":"2026-07-16T16:08:40.10755Z","steps":["trace[641575142] 'process raft request' (duration: 224.67005ms)","trace[641575142] 'compare' (duration: 11.575173ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:08:40.10771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.194195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T16:08:40.107733Z","caller":"traceutil/trace.go:171","msg":"trace[909584826] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:8357; }","duration":"149.271186ms","start":"2026-07-16T16:08:39.958457Z","end":"2026-07-16T16:08:40.107728Z","steps":["trace[909584826] 'agreement among raft nodes before linearized reading' (duration: 149.207465ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:09:08.439254Z","caller":"traceutil/trace.go:171","msg":"trace[2137453291] transaction","detail":"{read_only:false; response_revision:8565; number_of_response:1; }","duration":"246.497749ms","start":"2026-07-16T16:09:08.192723Z","end":"2026-07-16T16:09:08.439221Z","steps":["trace[2137453291] 'process raft request' (duration: 246.230214ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:09:08.630063Z","caller":"traceutil/trace.go:171","msg":"trace[1759948431] linearizableReadLoop","detail":"{readStateIndex:8871; appliedIndex:8869; }","duration":"253.773349ms","start":"2026-07-16T16:09:08.376258Z","end":"2026-07-16T16:09:08.630031Z","steps":["trace[1759948431] 'read index received' (duration: 62.569096ms)","trace[1759948431] 'applied index is now lower than readState.Index' (duration: 191.203063ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:09:08.630178Z","caller":"traceutil/trace.go:171","msg":"trace[160840932] transaction","detail":"{read_only:false; response_revision:8566; number_of_response:1; }","duration":"419.378099ms","start":"2026-07-16T16:09:08.210777Z","end":"2026-07-16T16:09:08.630155Z","steps":["trace[160840932] 'process raft request' (duration: 419.077003ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:09:08.630345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.958442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-07-16T16:09:08.630365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:09:08.210753Z","time spent":"419.47485ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T16:09:08.630399Z","caller":"traceutil/trace.go:171","msg":"trace[288805555] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8566; }","duration":"254.089635ms","start":"2026-07-16T16:09:08.376295Z","end":"2026-07-16T16:09:08.630385Z","steps":["trace[288805555] 'agreement among raft nodes before linearized reading' (duration: 253.897771ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:09:08.630432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.134386ms","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":"warn","ts":"2026-07-16T16:09:08.630448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.193068ms","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-16T16:09:08.630502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.687561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-16T16:09:08.630513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.732616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nm5rn\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-07-16T16:09:08.630579Z","caller":"traceutil/trace.go:171","msg":"trace[1951573651] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8566; }","duration":"212.354062ms","start":"2026-07-16T16:09:08.418209Z","end":"2026-07-16T16:09:08.630563Z","steps":["trace[1951573651] 'agreement among raft nodes before linearized reading' (duration: 212.110206ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:09:08.630595Z","caller":"traceutil/trace.go:171","msg":"trace[188337156] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8566; }","duration":"248.809984ms","start":"2026-07-16T16:09:08.381767Z","end":"2026-07-16T16:09:08.630577Z","steps":["trace[188337156] 'agreement among raft nodes before linearized reading' (duration: 248.554688ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:09:08.630628Z","caller":"traceutil/trace.go:171","msg":"trace[1950833353] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nm5rn; range_end:; response_count:1; response_revision:8566; }","duration":"148.94067ms","start":"2026-07-16T16:09:08.481662Z","end":"2026-07-16T16:09:08.630602Z","steps":["trace[1950833353] 'agreement among raft nodes before linearized reading' (duration: 148.589673ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:09:08.630552Z","caller":"traceutil/trace.go:171","msg":"trace[976382756] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8566; }","duration":"254.3087ms","start":"2026-07-16T16:09:08.376217Z","end":"2026-07-16T16:09:08.630526Z","steps":["trace[976382756] 'agreement among raft nodes before linearized reading' (duration: 253.961362ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:09:08.630469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.214139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-16T16:09:08.630831Z","caller":"traceutil/trace.go:171","msg":"trace[927162527] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8566; }","duration":"104.606275ms","start":"2026-07-16T16:09:08.526208Z","end":"2026-07-16T16:09:08.630815Z","steps":["trace[927162527] 'agreement among raft nodes before linearized reading' (duration: 104.147756ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:09:12.855262Z","caller":"traceutil/trace.go:171","msg":"trace[1542388222] transaction","detail":"{read_only:false; response_revision:8589; number_of_response:1; }","duration":"163.957458ms","start":"2026-07-16T16:09:12.691273Z","end":"2026-07-16T16:09:12.855231Z","steps":["trace[1542388222] 'process raft request' (duration: 145.704887ms)","trace[1542388222] 'compare' (duration: 17.762722ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:09:12.855669Z","caller":"traceutil/trace.go:171","msg":"trace[982483138] transaction","detail":"{read_only:false; response_revision:8590; number_of_response:1; }","duration":"163.724534ms","start":"2026-07-16T16:09:12.691919Z","end":"2026-07-16T16:09:12.855644Z","steps":["trace[982483138] 'process raft request' (duration: 163.230635ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:09:12.855787Z","caller":"traceutil/trace.go:171","msg":"trace[1258106719] transaction","detail":"{read_only:false; response_revision:8592; number_of_response:1; }","duration":"162.278696ms","start":"2026-07-16T16:09:12.693474Z","end":"2026-07-16T16:09:12.855753Z","steps":["trace[1258106719] 'process raft request' (duration: 162.120323ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:09:12.855832Z","caller":"traceutil/trace.go:171","msg":"trace[2403186] transaction","detail":"{read_only:false; response_revision:8591; number_of_response:1; }","duration":"163.770745ms","start":"2026-07-16T16:09:12.691998Z","end":"2026-07-16T16:09:12.855769Z","steps":["trace[2403186] 'process raft request' (duration: 163.448699ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:09:21.031644Z","caller":"traceutil/trace.go:171","msg":"trace[519660056] transaction","detail":"{read_only:false; response_revision:8676; number_of_response:1; }","duration":"130.371572ms","start":"2026-07-16T16:09:20.901243Z","end":"2026-07-16T16:09:21.031615Z","steps":["trace[519660056] 'process raft request' (duration: 123.51586ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:09:21.032306Z","caller":"traceutil/trace.go:171","msg":"trace[1392123357] transaction","detail":"{read_only:false; response_revision:8677; number_of_response:1; }","duration":"130.930362ms","start":"2026-07-16T16:09:20.901341Z","end":"2026-07-16T16:09:21.032272Z","steps":["trace[1392123357] 'process raft request' (duration: 130.225399ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:09:21.162004Z","caller":"traceutil/trace.go:171","msg":"trace[1872008344] transaction","detail":"{read_only:false; response_revision:8678; number_of_response:1; }","duration":"132.806199ms","start":"2026-07-16T16:09:21.029151Z","end":"2026-07-16T16:09:21.161957Z","steps":["trace[1872008344] 'process raft request' (duration: 119.775307ms)","trace[1872008344] 'compare' (duration: 12.800308ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:09:21.175306Z","caller":"traceutil/trace.go:171","msg":"trace[932087659] transaction","detail":"{read_only:false; response_revision:8679; number_of_response:1; }","duration":"135.633003ms","start":"2026-07-16T16:09:21.039642Z","end":"2026-07-16T16:09:21.175275Z","steps":["trace[932087659] 'process raft request' (duration: 135.351178ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:09:36.616399Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023a7.wal"} {"level":"info","ts":"2026-07-16T16:11:11.477943Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"50e03cebfd94cbba","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-16T16:11:11.483884Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-16T16:11:11.48396Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-16T16:13:32.034904Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8318} {"level":"info","ts":"2026-07-16T16:13:32.113038Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8318,"took":"75.710203ms","hash":2538336771,"current-db-size-bytes":59056128,"current-db-size":"59 MB","current-db-size-in-use-bytes":24842240,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-07-16T16:13:32.113144Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2538336771,"revision":8318,"compact-revision":6121} {"level":"info","ts":"2026-07-16T16:16:15.886682Z","caller":"traceutil/trace.go:171","msg":"trace[672965914] transaction","detail":"{read_only:false; response_revision:11858; number_of_response:1; }","duration":"156.334048ms","start":"2026-07-16T16:16:15.730318Z","end":"2026-07-16T16:16:15.886652Z","steps":["trace[672965914] 'process raft request' (duration: 156.090733ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:18:32.043279Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10543} {"level":"info","ts":"2026-07-16T16:18:32.118218Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10543,"took":"72.346295ms","hash":480170393,"current-db-size-bytes":59056128,"current-db-size":"59 MB","current-db-size-in-use-bytes":26042368,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-07-16T16:18:32.118273Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":480170393,"revision":10543,"compact-revision":8318} {"level":"info","ts":"2026-07-16T16:22:20.898038Z","caller":"traceutil/trace.go:171","msg":"trace[689233983] linearizableReadLoop","detail":"{readStateIndex:14825; appliedIndex:14824; }","duration":"135.245751ms","start":"2026-07-16T16:22:20.762767Z","end":"2026-07-16T16:22:20.898012Z","steps":["trace[689233983] 'read index received' (duration: 135.019967ms)","trace[689233983] 'applied index is now lower than readState.Index' (duration: 224.744µs)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:22:20.898256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.464925ms","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-16T16:22:20.898288Z","caller":"traceutil/trace.go:171","msg":"trace[367957798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14330; }","duration":"135.542506ms","start":"2026-07-16T16:22:20.762735Z","end":"2026-07-16T16:22:20.898278Z","steps":["trace[367957798] 'agreement among raft nodes before linearized reading' (duration: 135.397654ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:22:20.898334Z","caller":"traceutil/trace.go:171","msg":"trace[881795125] transaction","detail":"{read_only:false; response_revision:14330; number_of_response:1; }","duration":"136.667558ms","start":"2026-07-16T16:22:20.761636Z","end":"2026-07-16T16:22:20.898303Z","steps":["trace[881795125] 'process raft request' (duration: 136.216909ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:22:54.980894Z","caller":"traceutil/trace.go:171","msg":"trace[309834205] transaction","detail":"{read_only:false; response_revision:14526; number_of_response:1; }","duration":"151.994442ms","start":"2026-07-16T16:22:54.828866Z","end":"2026-07-16T16:22:54.980861Z","steps":["trace[309834205] 'process raft request' (duration: 151.739507ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:22:55.230624Z","caller":"traceutil/trace.go:171","msg":"trace[684217090] linearizableReadLoop","detail":"{readStateIndex:15029; appliedIndex:15028; }","duration":"168.11244ms","start":"2026-07-16T16:22:55.06248Z","end":"2026-07-16T16:22:55.230593Z","steps":["trace[684217090] 'read index received' (duration: 119.437187ms)","trace[684217090] 'applied index is now lower than readState.Index' (duration: 48.674203ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:22:55.230725Z","caller":"traceutil/trace.go:171","msg":"trace[1942085209] transaction","detail":"{read_only:false; response_revision:14527; number_of_response:1; }","duration":"221.078866ms","start":"2026-07-16T16:22:55.009591Z","end":"2026-07-16T16:22:55.23067Z","steps":["trace[1942085209] 'process raft request' (duration: 172.395703ms)","trace[1942085209] 'compare' (duration: 48.452008ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:22:55.230902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.398036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-16T16:22:55.230938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.333667ms","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-16T16:22:55.230994Z","caller":"traceutil/trace.go:171","msg":"trace[1734210254] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14527; }","duration":"130.446999ms","start":"2026-07-16T16:22:55.100531Z","end":"2026-07-16T16:22:55.230978Z","steps":["trace[1734210254] 'agreement among raft nodes before linearized reading' (duration: 130.248396ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:22:55.231251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.736885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T16:22:55.231332Z","caller":"traceutil/trace.go:171","msg":"trace[1135480702] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:14527; }","duration":"117.842307ms","start":"2026-07-16T16:22:55.113471Z","end":"2026-07-16T16:22:55.231313Z","steps":["trace[1135480702] 'agreement among raft nodes before linearized reading' (duration: 117.714855ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:22:55.23224Z","caller":"traceutil/trace.go:171","msg":"trace[274294988] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14527; }","duration":"168.522698ms","start":"2026-07-16T16:22:55.062447Z","end":"2026-07-16T16:22:55.23097Z","steps":["trace[274294988] 'agreement among raft nodes before linearized reading' (duration: 168.267883ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:23:32.049508Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12790} {"level":"info","ts":"2026-07-16T16:23:32.132366Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12790,"took":"79.963132ms","hash":3949449103,"current-db-size-bytes":59056128,"current-db-size":"59 MB","current-db-size-in-use-bytes":29020160,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-16T16:23:32.132466Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3949449103,"revision":12790,"compact-revision":10543} {"level":"info","ts":"2026-07-16T16:24:41.975942Z","caller":"traceutil/trace.go:171","msg":"trace[1338988329] transaction","detail":"{read_only:false; response_revision:15639; number_of_response:1; }","duration":"146.378806ms","start":"2026-07-16T16:24:41.829499Z","end":"2026-07-16T16:24:41.975878Z","steps":["trace[1338988329] 'process raft request' (duration: 121.742274ms)","trace[1338988329] 'compare' (duration: 24.263895ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:28:32.055756Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14944} {"level":"info","ts":"2026-07-16T16:28:32.146103Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14944,"took":"87.358832ms","hash":1112368565,"current-db-size-bytes":59056128,"current-db-size":"59 MB","current-db-size-in-use-bytes":30449664,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-16T16:28:32.146171Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1112368565,"revision":14944,"compact-revision":12790} {"level":"info","ts":"2026-07-16T16:30:39.098461Z","caller":"traceutil/trace.go:171","msg":"trace[1147662602] linearizableReadLoop","detail":"{readStateIndex:18890; appliedIndex:18889; }","duration":"214.129677ms","start":"2026-07-16T16:30:38.884311Z","end":"2026-07-16T16:30:39.098441Z","steps":["trace[1147662602] 'read index received' (duration: 213.938264ms)","trace[1147662602] 'applied index is now lower than readState.Index' (duration: 190.473µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:30:39.098576Z","caller":"traceutil/trace.go:171","msg":"trace[549128736] transaction","detail":"{read_only:false; response_revision:18265; number_of_response:1; }","duration":"216.985533ms","start":"2026-07-16T16:30:38.881555Z","end":"2026-07-16T16:30:39.09854Z","steps":["trace[549128736] 'process raft request' (duration: 216.740288ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:30:39.098662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.339242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-16T16:30:39.098694Z","caller":"traceutil/trace.go:171","msg":"trace[1308640781] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18265; }","duration":"214.409833ms","start":"2026-07-16T16:30:38.884274Z","end":"2026-07-16T16:30:39.098684Z","steps":["trace[1308640781] 'agreement among raft nodes before linearized reading' (duration: 214.293671ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:30:39.098907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.08253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-07-16T16:30:39.098959Z","caller":"traceutil/trace.go:171","msg":"trace[457972246] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18265; }","duration":"212.167121ms","start":"2026-07-16T16:30:38.886775Z","end":"2026-07-16T16:30:39.098942Z","steps":["trace[457972246] 'agreement among raft nodes before linearized reading' (duration: 211.991567ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:30:45.689215Z","caller":"traceutil/trace.go:171","msg":"trace[1977975622] transaction","detail":"{read_only:false; response_revision:18306; number_of_response:1; }","duration":"167.18128ms","start":"2026-07-16T16:30:45.522014Z","end":"2026-07-16T16:30:45.689195Z","steps":["trace[1977975622] 'process raft request' (duration: 167.084439ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:30:45.742493Z","caller":"traceutil/trace.go:171","msg":"trace[432990504] transaction","detail":"{read_only:false; response_revision:18308; number_of_response:1; }","duration":"210.957708ms","start":"2026-07-16T16:30:45.53152Z","end":"2026-07-16T16:30:45.742477Z","steps":["trace[432990504] 'process raft request' (duration: 210.873726ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:30:45.742691Z","caller":"traceutil/trace.go:171","msg":"trace[1751238967] transaction","detail":"{read_only:false; response_revision:18307; number_of_response:1; }","duration":"220.365917ms","start":"2026-07-16T16:30:45.522315Z","end":"2026-07-16T16:30:45.742681Z","steps":["trace[1751238967] 'process raft request' (duration: 213.705789ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:30:46.134019Z","caller":"traceutil/trace.go:171","msg":"trace[910781826] linearizableReadLoop","detail":"{readStateIndex:18936; appliedIndex:18935; }","duration":"117.267063ms","start":"2026-07-16T16:30:46.016725Z","end":"2026-07-16T16:30:46.133992Z","steps":["trace[910781826] 'read index received' (duration: 117.07661ms)","trace[910781826] 'applied index is now lower than readState.Index' (duration: 189.373µs)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:30:46.134154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.412176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:30:46.134194Z","caller":"traceutil/trace.go:171","msg":"trace[1035062787] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:18309; }","duration":"117.52172ms","start":"2026-07-16T16:30:46.016662Z","end":"2026-07-16T16:30:46.134183Z","steps":["trace[1035062787] 'agreement among raft nodes before linearized reading' (duration: 117.430237ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:30:46.134192Z","caller":"traceutil/trace.go:171","msg":"trace[1422202391] transaction","detail":"{read_only:false; response_revision:18309; number_of_response:1; }","duration":"219.949419ms","start":"2026-07-16T16:30:45.914165Z","end":"2026-07-16T16:30:46.134115Z","steps":["trace[1422202391] 'process raft request' (duration: 219.651804ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:30:46.151592Z","caller":"traceutil/trace.go:171","msg":"trace[720452949] transaction","detail":"{read_only:false; response_revision:18310; number_of_response:1; }","duration":"132.640769ms","start":"2026-07-16T16:30:46.018921Z","end":"2026-07-16T16:30:46.151562Z","steps":["trace[720452949] 'process raft request' (duration: 132.503076ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:30:50.29013Z","caller":"traceutil/trace.go:171","msg":"trace[1143575625] linearizableReadLoop","detail":"{readStateIndex:18972; appliedIndex:18970; }","duration":"120.812422ms","start":"2026-07-16T16:30:50.169285Z","end":"2026-07-16T16:30:50.290097Z","steps":["trace[1143575625] 'read index received' (duration: 49.570389ms)","trace[1143575625] 'applied index is now lower than readState.Index' (duration: 71.238393ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:30:50.290675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.053118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" ","response":"range_response_count:1 size:1647"} {"level":"info","ts":"2026-07-16T16:30:50.290738Z","caller":"traceutil/trace.go:171","msg":"trace[871197486] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat; range_end:; response_count:1; response_revision:18345; }","duration":"119.161491ms","start":"2026-07-16T16:30:50.17156Z","end":"2026-07-16T16:30:50.290721Z","steps":["trace[871197486] 'agreement among raft nodes before linearized reading' (duration: 118.925866ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:30:50.290713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.399264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" ","response":"range_response_count:1 size:1647"} {"level":"info","ts":"2026-07-16T16:30:50.290818Z","caller":"traceutil/trace.go:171","msg":"trace[1592418267] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat; range_end:; response_count:1; response_revision:18345; }","duration":"121.511826ms","start":"2026-07-16T16:30:50.169277Z","end":"2026-07-16T16:30:50.290788Z","steps":["trace[1592418267] 'agreement among raft nodes before linearized reading' (duration: 121.103728ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:30:54.224026Z","caller":"traceutil/trace.go:171","msg":"trace[1689881940] transaction","detail":"{read_only:false; response_revision:18427; number_of_response:1; }","duration":"110.407092ms","start":"2026-07-16T16:30:54.113561Z","end":"2026-07-16T16:30:54.223968Z","steps":["trace[1689881940] 'process raft request' (duration: 110.162708ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:32:30.590361Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"50e03cebfd94cbba","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-16T16:32:30.595388Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-16T16:32:30.595559Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-16T16:33:32.06291Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17394} {"level":"info","ts":"2026-07-16T16:33:32.157858Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17394,"took":"91.397978ms","hash":2045139436,"current-db-size-bytes":59056128,"current-db-size":"59 MB","current-db-size-in-use-bytes":34017280,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-16T16:33:32.157931Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2045139436,"revision":17394,"compact-revision":14944} {"level":"info","ts":"2026-07-16T16:36:43.751851Z","caller":"traceutil/trace.go:171","msg":"trace[1954522702] transaction","detail":"{read_only:false; response_revision:21056; number_of_response:1; }","duration":"107.671349ms","start":"2026-07-16T16:36:43.644148Z","end":"2026-07-16T16:36:43.751819Z","steps":["trace[1954522702] 'process raft request' (duration: 107.468875ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:36:43.79525Z","caller":"traceutil/trace.go:171","msg":"trace[844086408] transaction","detail":"{read_only:false; response_revision:21057; number_of_response:1; }","duration":"150.760702ms","start":"2026-07-16T16:36:43.644456Z","end":"2026-07-16T16:36:43.795216Z","steps":["trace[844086408] 'process raft request' (duration: 150.576519ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:36:44.610771Z","caller":"traceutil/trace.go:171","msg":"trace[294740109] transaction","detail":"{read_only:false; response_revision:21059; number_of_response:1; }","duration":"203.617794ms","start":"2026-07-16T16:36:44.407126Z","end":"2026-07-16T16:36:44.610743Z","steps":["trace[294740109] 'process raft request' (duration: 203.444991ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:36:44.649967Z","caller":"traceutil/trace.go:171","msg":"trace[1173655750] transaction","detail":"{read_only:false; response_revision:21060; number_of_response:1; }","duration":"242.357593ms","start":"2026-07-16T16:36:44.407588Z","end":"2026-07-16T16:36:44.649946Z","steps":["trace[1173655750] 'process raft request' (duration: 242.210691ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:36:44.65017Z","caller":"traceutil/trace.go:171","msg":"trace[1235948372] transaction","detail":"{read_only:false; response_revision:21061; number_of_response:1; }","duration":"125.014209ms","start":"2026-07-16T16:36:44.525148Z","end":"2026-07-16T16:36:44.650162Z","steps":["trace[1235948372] 'process raft request' (duration: 124.761115ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:36:44.650215Z","caller":"traceutil/trace.go:171","msg":"trace[876837616] linearizableReadLoop","detail":"{readStateIndex:21777; appliedIndex:21775; }","duration":"157.315067ms","start":"2026-07-16T16:36:44.492841Z","end":"2026-07-16T16:36:44.650156Z","steps":["trace[876837616] 'read index received' (duration: 117.877063ms)","trace[876837616] 'applied index is now lower than readState.Index' (duration: 39.433064ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:36:44.65042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.546551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:36:44.650481Z","caller":"traceutil/trace.go:171","msg":"trace[408173059] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:21061; }","duration":"157.658104ms","start":"2026-07-16T16:36:44.492806Z","end":"2026-07-16T16:36:44.650464Z","steps":["trace[408173059] 'agreement among raft nodes before linearized reading' (duration: 157.519891ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:36:45.445199Z","caller":"traceutil/trace.go:171","msg":"trace[734267806] transaction","detail":"{read_only:false; response_revision:21064; number_of_response:1; }","duration":"214.302717ms","start":"2026-07-16T16:36:45.230861Z","end":"2026-07-16T16:36:45.445164Z","steps":["trace[734267806] 'process raft request' (duration: 199.784999ms)","trace[734267806] 'compare' (duration: 14.303075ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:38:32.06972Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19724} {"level":"info","ts":"2026-07-16T16:38:32.176817Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19724,"took":"103.903725ms","hash":1189289510,"current-db-size-bytes":59056128,"current-db-size":"59 MB","current-db-size-in-use-bytes":29741056,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-16T16:38:32.17689Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1189289510,"revision":19724,"compact-revision":17394} {"level":"info","ts":"2026-07-16T16:40:47.238678Z","caller":"traceutil/trace.go:171","msg":"trace[1287543806] transaction","detail":"{read_only:false; response_revision:23577; number_of_response:1; }","duration":"262.666611ms","start":"2026-07-16T16:40:46.975995Z","end":"2026-07-16T16:40:47.238661Z","steps":["trace[1287543806] 'process raft request' (duration: 262.382005ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:40:47.239058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.092056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-16T16:40:47.239199Z","caller":"traceutil/trace.go:171","msg":"trace[104843135] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23577; }","duration":"232.269069ms","start":"2026-07-16T16:40:47.006911Z","end":"2026-07-16T16:40:47.23918Z","steps":["trace[104843135] 'agreement among raft nodes before linearized reading' (duration: 231.998884ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:40:47.238598Z","caller":"traceutil/trace.go:171","msg":"trace[1894476988] linearizableReadLoop","detail":"{readStateIndex:24367; appliedIndex:24366; }","duration":"231.621157ms","start":"2026-07-16T16:40:47.006953Z","end":"2026-07-16T16:40:47.238574Z","steps":["trace[1894476988] 'read index received' (duration: 231.458524ms)","trace[1894476988] 'applied index is now lower than readState.Index' (duration: 161.273µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:40:47.349001Z","caller":"traceutil/trace.go:171","msg":"trace[1041373874] transaction","detail":"{read_only:false; response_revision:23578; number_of_response:1; }","duration":"115.387466ms","start":"2026-07-16T16:40:47.233584Z","end":"2026-07-16T16:40:47.348971Z","steps":["trace[1041373874] 'process raft request' (duration: 114.673122ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:40:47.349047Z","caller":"traceutil/trace.go:171","msg":"trace[1191345340] linearizableReadLoop","detail":"{readStateIndex:24368; appliedIndex:24367; }","duration":"109.679387ms","start":"2026-07-16T16:40:47.239349Z","end":"2026-07-16T16:40:47.349028Z","steps":["trace[1191345340] 'read index received' (duration: 108.937822ms)","trace[1191345340] 'applied index is now lower than readState.Index' (duration: 739.355µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:40:47.349042Z","caller":"traceutil/trace.go:171","msg":"trace[1100729412] transaction","detail":"{read_only:false; response_revision:23579; number_of_response:1; }","duration":"105.15894ms","start":"2026-07-16T16:40:47.243861Z","end":"2026-07-16T16:40:47.34902Z","steps":["trace[1100729412] 'process raft request' (duration: 105.071558ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:40:47.349241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.058713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-07-16T16:40:47.349216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.048355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:40:47.349276Z","caller":"traceutil/trace.go:171","msg":"trace[1308685767] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23579; }","duration":"335.140585ms","start":"2026-07-16T16:40:47.014126Z","end":"2026-07-16T16:40:47.349266Z","steps":["trace[1308685767] 'agreement among raft nodes before linearized reading' (duration: 334.983472ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:40:47.349307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:40:47.014107Z","time spent":"335.191576ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-16T16:40:47.349311Z","caller":"traceutil/trace.go:171","msg":"trace[2055417195] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23579; }","duration":"265.189928ms","start":"2026-07-16T16:40:47.084097Z","end":"2026-07-16T16:40:47.349287Z","steps":["trace[2055417195] 'agreement among raft nodes before linearized reading' (duration: 265.017005ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:43:32.076134Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21969} {"level":"info","ts":"2026-07-16T16:43:32.188147Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21969,"took":"108.032114ms","hash":3989695044,"current-db-size-bytes":59056128,"current-db-size":"59 MB","current-db-size-in-use-bytes":44470272,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-07-16T16:43:32.188212Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3989695044,"revision":21969,"compact-revision":19724} {"level":"info","ts":"2026-07-16T16:44:19.730347Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000678b.wal"} {"level":"info","ts":"2026-07-16T16:44:22.511319Z","caller":"traceutil/trace.go:171","msg":"trace[1441212479] transaction","detail":"{read_only:false; response_revision:25714; number_of_response:1; }","duration":"173.26529ms","start":"2026-07-16T16:44:22.338035Z","end":"2026-07-16T16:44:22.5113Z","steps":["trace[1441212479] 'process raft request' (duration: 173.228229ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:22.511576Z","caller":"traceutil/trace.go:171","msg":"trace[1346355050] transaction","detail":"{read_only:false; response_revision:25712; number_of_response:1; }","duration":"198.986702ms","start":"2026-07-16T16:44:22.312558Z","end":"2026-07-16T16:44:22.511545Z","steps":["trace[1346355050] 'process raft request' (duration: 180.836625ms)","trace[1346355050] 'compare' (duration: 17.604086ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:44:22.511602Z","caller":"traceutil/trace.go:171","msg":"trace[1854792643] transaction","detail":"{read_only:false; response_revision:25713; number_of_response:1; }","duration":"197.517564ms","start":"2026-07-16T16:44:22.314044Z","end":"2026-07-16T16:44:22.511561Z","steps":["trace[1854792643] 'process raft request' (duration: 197.180737ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:22.724434Z","caller":"traceutil/trace.go:171","msg":"trace[2071714128] transaction","detail":"{read_only:false; response_revision:25715; number_of_response:1; }","duration":"172.20346ms","start":"2026-07-16T16:44:22.552195Z","end":"2026-07-16T16:44:22.724398Z","steps":["trace[2071714128] 'process raft request' (duration: 144.586722ms)","trace[2071714128] 'compare' (duration: 27.188899ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:44:22.724619Z","caller":"traceutil/trace.go:171","msg":"trace[137078246] transaction","detail":"{read_only:false; response_revision:25716; number_of_response:1; }","duration":"170.999617ms","start":"2026-07-16T16:44:22.553596Z","end":"2026-07-16T16:44:22.724596Z","steps":["trace[137078246] 'process raft request' (duration: 170.842944ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:22.724923Z","caller":"traceutil/trace.go:171","msg":"trace[1697690139] transaction","detail":"{read_only:false; response_revision:25717; number_of_response:1; }","duration":"170.62078ms","start":"2026-07-16T16:44:22.554284Z","end":"2026-07-16T16:44:22.724905Z","steps":["trace[1697690139] 'process raft request' (duration: 170.273804ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:22.725054Z","caller":"traceutil/trace.go:171","msg":"trace[1024766274] transaction","detail":"{read_only:false; response_revision:25718; number_of_response:1; }","duration":"136.367505ms","start":"2026-07-16T16:44:22.588678Z","end":"2026-07-16T16:44:22.725046Z","steps":["trace[1024766274] 'process raft request' (duration: 136.159221ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:24.139207Z","caller":"traceutil/trace.go:171","msg":"trace[1055538991] transaction","detail":"{read_only:false; response_revision:25733; number_of_response:1; }","duration":"155.793126ms","start":"2026-07-16T16:44:23.983384Z","end":"2026-07-16T16:44:24.139177Z","steps":["trace[1055538991] 'process raft request' (duration: 155.599343ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:28.803129Z","caller":"traceutil/trace.go:171","msg":"trace[1394915715] transaction","detail":"{read_only:false; response_revision:25775; number_of_response:1; }","duration":"388.792569ms","start":"2026-07-16T16:44:28.414302Z","end":"2026-07-16T16:44:28.803095Z","steps":["trace[1394915715] 'process raft request' (duration: 388.585255ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:28.803306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:28.414272Z","time spent":"388.939641ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T16:44:28.833481Z","caller":"traceutil/trace.go:171","msg":"trace[196649740] linearizableReadLoop","detail":"{readStateIndex:26629; appliedIndex:26625; }","duration":"159.07674ms","start":"2026-07-16T16:44:28.674377Z","end":"2026-07-16T16:44:28.833454Z","steps":["trace[196649740] 'read index received' (duration: 128.534747ms)","trace[196649740] 'applied index is now lower than readState.Index' (duration: 30.540863ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:44:28.833645Z","caller":"traceutil/trace.go:171","msg":"trace[516101769] transaction","detail":"{read_only:false; response_revision:25776; number_of_response:1; }","duration":"305.911066ms","start":"2026-07-16T16:44:28.527715Z","end":"2026-07-16T16:44:28.833626Z","steps":["trace[516101769] 'process raft request' (duration: 305.438137ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:28.833808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:28.527698Z","time spent":"305.995387ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:44:28.834049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.660541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-16T16:44:28.834116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.63736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:44:28.834127Z","caller":"traceutil/trace.go:171","msg":"trace[449362301] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:25778; }","duration":"159.788224ms","start":"2026-07-16T16:44:28.674323Z","end":"2026-07-16T16:44:28.834111Z","steps":["trace[449362301] 'agreement among raft nodes before linearized reading' (duration: 159.662661ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:28.834157Z","caller":"traceutil/trace.go:171","msg":"trace[1133123912] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:25778; }","duration":"148.701781ms","start":"2026-07-16T16:44:28.685441Z","end":"2026-07-16T16:44:28.834143Z","steps":["trace[1133123912] 'agreement among raft nodes before linearized reading' (duration: 148.63165ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:28.834411Z","caller":"traceutil/trace.go:171","msg":"trace[1649846975] transaction","detail":"{read_only:false; response_revision:25777; number_of_response:1; }","duration":"304.854725ms","start":"2026-07-16T16:44:28.529545Z","end":"2026-07-16T16:44:28.8344Z","steps":["trace[1649846975] 'process raft request' (duration: 303.772664ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:28.834461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.206329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-16T16:44:28.834485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:28.529538Z","time spent":"304.900266ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T16:44:28.834494Z","caller":"traceutil/trace.go:171","msg":"trace[1541446432] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:25778; }","duration":"108.260749ms","start":"2026-07-16T16:44:28.726223Z","end":"2026-07-16T16:44:28.834484Z","steps":["trace[1541446432] 'agreement among raft nodes before linearized reading' (duration: 108.207928ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:28.834679Z","caller":"traceutil/trace.go:171","msg":"trace[985334504] transaction","detail":"{read_only:false; response_revision:25778; number_of_response:1; }","duration":"300.654265ms","start":"2026-07-16T16:44:28.534016Z","end":"2026-07-16T16:44:28.83467Z","steps":["trace[985334504] 'process raft request' (duration: 299.38189ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:28.834725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:28.534006Z","time spent":"300.692025ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:44:29.334703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.633619ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-16T16:44:29.334902Z","caller":"traceutil/trace.go:171","msg":"trace[1679656739] transaction","detail":"{read_only:false; response_revision:25779; number_of_response:1; }","duration":"495.521028ms","start":"2026-07-16T16:44:28.839356Z","end":"2026-07-16T16:44:29.334877Z","steps":["trace[1679656739] 'process raft request' (duration: 132.630324ms)","trace[1679656739] 'compare' (duration: 362.439666ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:44:29.334993Z","caller":"traceutil/trace.go:171","msg":"trace[923027322] transaction","detail":"{read_only:false; response_revision:25780; number_of_response:1; }","duration":"494.810364ms","start":"2026-07-16T16:44:28.840174Z","end":"2026-07-16T16:44:29.334984Z","steps":["trace[923027322] 'process raft request' (duration: 494.629751ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:29.335059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:28.840165Z","time spent":"494.858675ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:44:29.335062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:28.839337Z","time spent":"495.656321ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T16:44:29.334953Z","caller":"traceutil/trace.go:171","msg":"trace[342129451] transaction","detail":"{read_only:false; response_revision:25781; number_of_response:1; }","duration":"494.410256ms","start":"2026-07-16T16:44:28.840494Z","end":"2026-07-16T16:44:29.334904Z","steps":["trace[342129451] 'process raft request' (duration: 494.367256ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:29.335295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:28.840487Z","time spent":"494.767493ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T16:44:29.345248Z","caller":"traceutil/trace.go:171","msg":"trace[255899832] linearizableReadLoop","detail":"{readStateIndex:26633; appliedIndex:26629; }","duration":"262.206529ms","start":"2026-07-16T16:44:29.083025Z","end":"2026-07-16T16:44:29.345231Z","steps":["trace[255899832] 'read index received' (duration: 242.727597ms)","trace[255899832] 'applied index is now lower than readState.Index' (duration: 19.478212ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:44:29.345331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.315502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:44:29.345358Z","caller":"traceutil/trace.go:171","msg":"trace[1595483752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25782; }","duration":"262.384992ms","start":"2026-07-16T16:44:29.082965Z","end":"2026-07-16T16:44:29.34535Z","steps":["trace[1595483752] 'agreement among raft nodes before linearized reading' (duration: 262.317091ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:29.345354Z","caller":"traceutil/trace.go:171","msg":"trace[1573401355] transaction","detail":"{read_only:false; response_revision:25782; number_of_response:1; }","duration":"280.967618ms","start":"2026-07-16T16:44:29.064343Z","end":"2026-07-16T16:44:29.345311Z","steps":["trace[1573401355] 'process raft request' (duration: 280.818035ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:29.510265Z","caller":"traceutil/trace.go:171","msg":"trace[1775069851] linearizableReadLoop","detail":"{readStateIndex:26634; appliedIndex:26633; }","duration":"135.918957ms","start":"2026-07-16T16:44:29.374322Z","end":"2026-07-16T16:44:29.510241Z","steps":["trace[1775069851] 'read index received' (duration: 122.95035ms)","trace[1775069851] 'applied index is now lower than readState.Index' (duration: 12.967277ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:44:29.510383Z","caller":"traceutil/trace.go:171","msg":"trace[1438456246] transaction","detail":"{read_only:false; response_revision:25783; number_of_response:1; }","duration":"136.480267ms","start":"2026-07-16T16:44:29.373867Z","end":"2026-07-16T16:44:29.510347Z","steps":["trace[1438456246] 'process raft request' (duration: 123.436048ms)","trace[1438456246] 'compare' (duration: 12.790405ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:44:29.510487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.145441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-07-16T16:44:29.51052Z","caller":"traceutil/trace.go:171","msg":"trace[1181323739] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25783; }","duration":"136.228592ms","start":"2026-07-16T16:44:29.374282Z","end":"2026-07-16T16:44:29.51051Z","steps":["trace[1181323739] 'agreement among raft nodes before linearized reading' (duration: 136.142471ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:29.510532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.042458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-16T16:44:29.510602Z","caller":"traceutil/trace.go:171","msg":"trace[1299672982] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25783; }","duration":"126.152891ms","start":"2026-07-16T16:44:29.384432Z","end":"2026-07-16T16:44:29.510585Z","steps":["trace[1299672982] 'agreement among raft nodes before linearized reading' (duration: 126.029278ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:29.715818Z","caller":"traceutil/trace.go:171","msg":"trace[1352844415] transaction","detail":"{read_only:false; response_revision:25784; number_of_response:1; }","duration":"200.99297ms","start":"2026-07-16T16:44:29.514776Z","end":"2026-07-16T16:44:29.715769Z","steps":["trace[1352844415] 'process raft request' (duration: 120.021373ms)","trace[1352844415] 'compare' (duration: 80.781414ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:44:29.95868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.987815ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-16T16:44:29.958819Z","caller":"traceutil/trace.go:171","msg":"trace[729258481] linearizableReadLoop","detail":"{readStateIndex:26636; appliedIndex:26634; }","duration":"402.131534ms","start":"2026-07-16T16:44:29.556675Z","end":"2026-07-16T16:44:29.958806Z","steps":["trace[729258481] 'read index received' (duration: 78.137012ms)","trace[729258481] 'applied index is now lower than readState.Index' (duration: 323.993252ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:44:29.958876Z","caller":"traceutil/trace.go:171","msg":"trace[939593955] transaction","detail":"{read_only:false; response_revision:25785; number_of_response:1; }","duration":"444.028924ms","start":"2026-07-16T16:44:29.51484Z","end":"2026-07-16T16:44:29.958869Z","steps":["trace[939593955] 'process raft request' (duration: 325.770764ms)","trace[939593955] 'compare' (duration: 117.882672ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:44:29.958942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:29.514817Z","time spent":"444.075075ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T16:44:29.959034Z","caller":"traceutil/trace.go:171","msg":"trace[1442563122] transaction","detail":"{read_only:false; response_revision:25786; number_of_response:1; }","duration":"368.793527ms","start":"2026-07-16T16:44:29.590233Z","end":"2026-07-16T16:44:29.959027Z","steps":["trace[1442563122] 'process raft request' (duration: 368.526482ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:29.959065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:29.590204Z","time spent":"368.843608ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:44:29.959214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.518582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:44:29.959301Z","caller":"traceutil/trace.go:171","msg":"trace[976090456] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:25786; }","duration":"402.646963ms","start":"2026-07-16T16:44:29.556631Z","end":"2026-07-16T16:44:29.959278Z","steps":["trace[976090456] 'agreement among raft nodes before linearized reading' (duration: 402.395889ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:29.959344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:29.556613Z","time spent":"402.720895ms","remote":"127.0.0.1:50032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-07-16T16:44:29.961353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.976332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:44:29.961395Z","caller":"traceutil/trace.go:171","msg":"trace[1985698364] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:25788; }","duration":"186.055314ms","start":"2026-07-16T16:44:29.775329Z","end":"2026-07-16T16:44:29.961384Z","steps":["trace[1985698364] 'agreement among raft nodes before linearized reading' (duration: 185.963212ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:29.961377Z","caller":"traceutil/trace.go:171","msg":"trace[582571168] transaction","detail":"{read_only:false; response_revision:25787; number_of_response:1; }","duration":"178.833366ms","start":"2026-07-16T16:44:29.782515Z","end":"2026-07-16T16:44:29.961348Z","steps":["trace[582571168] 'process raft request' (duration: 178.694334ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:29.961409Z","caller":"traceutil/trace.go:171","msg":"trace[933013356] transaction","detail":"{read_only:false; response_revision:25788; number_of_response:1; }","duration":"151.880001ms","start":"2026-07-16T16:44:29.809507Z","end":"2026-07-16T16:44:29.961386Z","steps":["trace[933013356] 'process raft request' (duration: 151.755929ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:30.459385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.054896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:44:30.459472Z","caller":"traceutil/trace.go:171","msg":"trace[1126715210] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25788; }","duration":"375.185539ms","start":"2026-07-16T16:44:30.084267Z","end":"2026-07-16T16:44:30.459452Z","steps":["trace[1126715210] 'range keys from in-memory index tree' (duration: 374.980135ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:30.459545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:30.084251Z","time spent":"375.28572ms","remote":"127.0.0.1:40244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-16T16:44:30.713613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.306025ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-16T16:44:30.713716Z","caller":"traceutil/trace.go:171","msg":"trace[683326829] linearizableReadLoop","detail":"{readStateIndex:26640; appliedIndex:26639; }","duration":"252.988684ms","start":"2026-07-16T16:44:30.46071Z","end":"2026-07-16T16:44:30.713699Z","steps":["trace[683326829] 'read index received' (duration: 63.331µs)","trace[683326829] 'applied index is now lower than readState.Index' (duration: 252.923793ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:44:30.714504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.763398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:44:30.714583Z","caller":"traceutil/trace.go:171","msg":"trace[889425417] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25788; }","duration":"253.903421ms","start":"2026-07-16T16:44:30.460659Z","end":"2026-07-16T16:44:30.714562Z","steps":["trace[889425417] 'agreement among raft nodes before linearized reading' (duration: 253.761298ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:30.714671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.45994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-07-16T16:44:30.714791Z","caller":"traceutil/trace.go:171","msg":"trace[70272373] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25788; }","duration":"177.620564ms","start":"2026-07-16T16:44:30.537151Z","end":"2026-07-16T16:44:30.714772Z","steps":["trace[70272373] 'agreement among raft nodes before linearized reading' (duration: 177.337938ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:30.925712Z","caller":"traceutil/trace.go:171","msg":"trace[1473635558] transaction","detail":"{read_only:false; response_revision:25789; number_of_response:1; }","duration":"116.470985ms","start":"2026-07-16T16:44:30.809221Z","end":"2026-07-16T16:44:30.925692Z","steps":["trace[1473635558] 'process raft request' (duration: 116.286152ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:31.013072Z","caller":"traceutil/trace.go:171","msg":"trace[1219943483] transaction","detail":"{read_only:false; response_revision:25792; number_of_response:1; }","duration":"171.131411ms","start":"2026-07-16T16:44:30.841916Z","end":"2026-07-16T16:44:31.013048Z","steps":["trace[1219943483] 'process raft request' (duration: 171.08543ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:31.013137Z","caller":"traceutil/trace.go:171","msg":"trace[1257570033] transaction","detail":"{read_only:false; response_revision:25791; number_of_response:1; }","duration":"171.278743ms","start":"2026-07-16T16:44:30.841826Z","end":"2026-07-16T16:44:31.013105Z","steps":["trace[1257570033] 'process raft request' (duration: 171.13449ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:31.013114Z","caller":"traceutil/trace.go:171","msg":"trace[65228677] transaction","detail":"{read_only:false; response_revision:25790; number_of_response:1; }","duration":"171.727851ms","start":"2026-07-16T16:44:30.841341Z","end":"2026-07-16T16:44:31.013069Z","steps":["trace[65228677] 'process raft request' (duration: 171.443805ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:41.271572Z","caller":"traceutil/trace.go:171","msg":"trace[1191333411] linearizableReadLoop","detail":"{readStateIndex:26727; appliedIndex:26726; }","duration":"227.927534ms","start":"2026-07-16T16:44:41.043628Z","end":"2026-07-16T16:44:41.271555Z","steps":["trace[1191333411] 'read index received' (duration: 227.758111ms)","trace[1191333411] 'applied index is now lower than readState.Index' (duration: 169.033µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:44:41.27177Z","caller":"traceutil/trace.go:171","msg":"trace[256185173] transaction","detail":"{read_only:false; response_revision:25873; number_of_response:1; }","duration":"315.376536ms","start":"2026-07-16T16:44:40.956385Z","end":"2026-07-16T16:44:41.271761Z","steps":["trace[256185173] 'process raft request' (duration: 315.060789ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:41.271853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:40.956368Z","time spent":"315.423458ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:44:41.272003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.390003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:44:41.272025Z","caller":"traceutil/trace.go:171","msg":"trace[1743712829] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25873; }","duration":"228.455305ms","start":"2026-07-16T16:44:41.043564Z","end":"2026-07-16T16:44:41.27202Z","steps":["trace[1743712829] 'agreement among raft nodes before linearized reading' (duration: 228.415304ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:41.279814Z","caller":"traceutil/trace.go:171","msg":"trace[316710687] transaction","detail":"{read_only:false; response_revision:25874; number_of_response:1; }","duration":"225.816464ms","start":"2026-07-16T16:44:41.053978Z","end":"2026-07-16T16:44:41.279794Z","steps":["trace[316710687] 'process raft request' (duration: 225.439337ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:41.27998Z","caller":"traceutil/trace.go:171","msg":"trace[1946374441] transaction","detail":"{read_only:false; response_revision:25875; number_of_response:1; }","duration":"225.913606ms","start":"2026-07-16T16:44:41.05406Z","end":"2026-07-16T16:44:41.279974Z","steps":["trace[1946374441] 'process raft request' (duration: 225.478308ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:41.280082Z","caller":"traceutil/trace.go:171","msg":"trace[13569526] transaction","detail":"{read_only:false; response_revision:25876; number_of_response:1; }","duration":"224.343586ms","start":"2026-07-16T16:44:41.055733Z","end":"2026-07-16T16:44:41.280076Z","steps":["trace[13569526] 'process raft request' (duration: 223.840337ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:41.575304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.897321ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-16T16:44:41.575544Z","caller":"traceutil/trace.go:171","msg":"trace[655698524] linearizableReadLoop","detail":"{readStateIndex:26731; appliedIndex:26730; }","duration":"183.387275ms","start":"2026-07-16T16:44:41.392147Z","end":"2026-07-16T16:44:41.575534Z","steps":["trace[655698524] 'read index received' (duration: 40.157068ms)","trace[655698524] 'applied index is now lower than readState.Index' (duration: 143.229637ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:44:41.575537Z","caller":"traceutil/trace.go:171","msg":"trace[1261845084] transaction","detail":"{read_only:false; response_revision:25877; number_of_response:1; }","duration":"185.155067ms","start":"2026-07-16T16:44:41.390352Z","end":"2026-07-16T16:44:41.575507Z","steps":["trace[1261845084] 'process raft request' (duration: 41.968381ms)","trace[1261845084] 'compare' (duration: 142.695117ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:44:41.575701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.562439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-07-16T16:44:41.575725Z","caller":"traceutil/trace.go:171","msg":"trace[2147070137] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25878; }","duration":"183.62566ms","start":"2026-07-16T16:44:41.392093Z","end":"2026-07-16T16:44:41.575719Z","steps":["trace[2147070137] 'agreement among raft nodes before linearized reading' (duration: 183.542988ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:41.575814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.565591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-16T16:44:41.57583Z","caller":"traceutil/trace.go:171","msg":"trace[1607286161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25878; }","duration":"180.602531ms","start":"2026-07-16T16:44:41.395224Z","end":"2026-07-16T16:44:41.575827Z","steps":["trace[1607286161] 'agreement among raft nodes before linearized reading' (duration: 180.54834ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:41.575915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.239055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-16T16:44:41.575932Z","caller":"traceutil/trace.go:171","msg":"trace[1694234564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25878; }","duration":"180.290055ms","start":"2026-07-16T16:44:41.395638Z","end":"2026-07-16T16:44:41.575928Z","steps":["trace[1694234564] 'agreement among raft nodes before linearized reading' (duration: 180.248884ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:41.732932Z","caller":"traceutil/trace.go:171","msg":"trace[1695266500] transaction","detail":"{read_only:false; response_revision:25879; number_of_response:1; }","duration":"151.368542ms","start":"2026-07-16T16:44:41.581533Z","end":"2026-07-16T16:44:41.732902Z","steps":["trace[1695266500] 'process raft request' (duration: 151.167548ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:41.774916Z","caller":"traceutil/trace.go:171","msg":"trace[1399778300] transaction","detail":"{read_only:false; response_revision:25880; number_of_response:1; }","duration":"183.894903ms","start":"2026-07-16T16:44:41.591Z","end":"2026-07-16T16:44:41.774895Z","steps":["trace[1399778300] 'process raft request' (duration: 183.390464ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:41.775199Z","caller":"traceutil/trace.go:171","msg":"trace[1784136649] transaction","detail":"{read_only:false; response_revision:25881; number_of_response:1; }","duration":"184.172189ms","start":"2026-07-16T16:44:41.59101Z","end":"2026-07-16T16:44:41.775182Z","steps":["trace[1784136649] 'process raft request' (duration: 183.490296ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:41.958005Z","caller":"traceutil/trace.go:171","msg":"trace[361310435] transaction","detail":"{read_only:false; response_revision:25882; number_of_response:1; }","duration":"178.854358ms","start":"2026-07-16T16:44:41.779119Z","end":"2026-07-16T16:44:41.957973Z","steps":["trace[361310435] 'process raft request' (duration: 129.78649ms)","trace[361310435] 'compare' (duration: 48.822432ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:44:42.379746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.842018ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-16T16:44:42.379854Z","caller":"traceutil/trace.go:171","msg":"trace[1384594164] linearizableReadLoop","detail":"{readStateIndex:26738; appliedIndex:26736; }","duration":"364.967484ms","start":"2026-07-16T16:44:42.014867Z","end":"2026-07-16T16:44:42.379834Z","steps":["trace[1384594164] 'read index received' (duration: 59.728862ms)","trace[1384594164] 'applied index is now lower than readState.Index' (duration: 305.236922ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:44:42.379963Z","caller":"traceutil/trace.go:171","msg":"trace[374650693] transaction","detail":"{read_only:false; response_revision:25884; number_of_response:1; }","duration":"367.453441ms","start":"2026-07-16T16:44:42.012496Z","end":"2026-07-16T16:44:42.379949Z","steps":["trace[374650693] 'process raft request' (duration: 211.313227ms)","trace[374650693] 'compare' (duration: 155.447531ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:44:42.38002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:42.012469Z","time spent":"367.520412ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":605,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:44:42.380043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.988847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:44:42.380128Z","caller":"traceutil/trace.go:171","msg":"trace[353078310] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25884; }","duration":"294.11392ms","start":"2026-07-16T16:44:42.085996Z","end":"2026-07-16T16:44:42.38011Z","steps":["trace[353078310] 'agreement among raft nodes before linearized reading' (duration: 293.972907ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:42.380123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.236769ms","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-16T16:44:42.380194Z","caller":"traceutil/trace.go:171","msg":"trace[13323206] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25884; }","duration":"365.343261ms","start":"2026-07-16T16:44:42.014833Z","end":"2026-07-16T16:44:42.380176Z","steps":["trace[13323206] 'agreement among raft nodes before linearized reading' (duration: 365.147597ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:42.380245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:42.014821Z","time spent":"365.403532ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-16T16:44:42.926859Z","caller":"traceutil/trace.go:171","msg":"trace[1491280173] transaction","detail":"{read_only:false; response_revision:25887; number_of_response:1; }","duration":"177.898479ms","start":"2026-07-16T16:44:42.748932Z","end":"2026-07-16T16:44:42.926831Z","steps":["trace[1491280173] 'process raft request' (duration: 177.690635ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:43.196624Z","caller":"traceutil/trace.go:171","msg":"trace[216699401] transaction","detail":"{read_only:false; response_revision:25889; number_of_response:1; }","duration":"259.305964ms","start":"2026-07-16T16:44:42.937299Z","end":"2026-07-16T16:44:43.196605Z","steps":["trace[216699401] 'process raft request' (duration: 259.167292ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:43.685744Z","caller":"traceutil/trace.go:171","msg":"trace[1184950673] transaction","detail":"{read_only:false; response_revision:25890; number_of_response:1; }","duration":"409.193369ms","start":"2026-07-16T16:44:43.276509Z","end":"2026-07-16T16:44:43.685703Z","steps":["trace[1184950673] 'process raft request' (duration: 332.134577ms)","trace[1184950673] 'compare' (duration: 76.901968ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:44:43.685952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:43.276486Z","time spent":"409.359653ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T16:44:43.887604Z","caller":"traceutil/trace.go:171","msg":"trace[1777494578] transaction","detail":"{read_only:false; response_revision:25891; number_of_response:1; }","duration":"602.352819ms","start":"2026-07-16T16:44:43.285228Z","end":"2026-07-16T16:44:43.887581Z","steps":["trace[1777494578] 'process raft request' (duration: 601.491042ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:43.887748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:43.285174Z","time spent":"602.503072ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T16:44:43.887948Z","caller":"traceutil/trace.go:171","msg":"trace[642488777] linearizableReadLoop","detail":"{readStateIndex:26749; appliedIndex:26744; }","duration":"150.366283ms","start":"2026-07-16T16:44:43.737566Z","end":"2026-07-16T16:44:43.887932Z","steps":["trace[642488777] 'read index received' (duration: 149.120149ms)","trace[642488777] 'applied index is now lower than readState.Index' (duration: 1.245524ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:44:43.88803Z","caller":"traceutil/trace.go:171","msg":"trace[1350700722] transaction","detail":"{read_only:false; response_revision:25894; number_of_response:1; }","duration":"306.049237ms","start":"2026-07-16T16:44:43.58197Z","end":"2026-07-16T16:44:43.88802Z","steps":["trace[1350700722] 'process raft request' (duration: 305.800593ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:43.888023Z","caller":"traceutil/trace.go:171","msg":"trace[1371052437] transaction","detail":"{read_only:false; response_revision:25893; number_of_response:1; }","duration":"601.487243ms","start":"2026-07-16T16:44:43.286516Z","end":"2026-07-16T16:44:43.888003Z","steps":["trace[1371052437] 'process raft request' (duration: 601.213278ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:43.888102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:43.286505Z","time spent":"601.556444ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:44:43.888121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:43.581932Z","time spent":"306.12025ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:44:43.888218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.635177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-07-16T16:44:43.888241Z","caller":"traceutil/trace.go:171","msg":"trace[232902980] transaction","detail":"{read_only:false; response_revision:25895; number_of_response:1; }","duration":"305.66468ms","start":"2026-07-16T16:44:43.582554Z","end":"2026-07-16T16:44:43.888219Z","steps":["trace[232902980] 'process raft request' (duration: 305.338704ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:43.888287Z","caller":"traceutil/trace.go:171","msg":"trace[1789225187] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25895; }","duration":"150.709049ms","start":"2026-07-16T16:44:43.737557Z","end":"2026-07-16T16:44:43.888266Z","steps":["trace[1789225187] 'agreement among raft nodes before linearized reading' (duration: 150.511295ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:43.8883Z","caller":"traceutil/trace.go:171","msg":"trace[1692388492] transaction","detail":"{read_only:false; response_revision:25892; number_of_response:1; }","duration":"602.783337ms","start":"2026-07-16T16:44:43.285505Z","end":"2026-07-16T16:44:43.888289Z","steps":["trace[1692388492] 'process raft request' (duration: 602.001683ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:43.888357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:43.285497Z","time spent":"602.830998ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:44:43.888357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:43.582522Z","time spent":"305.776952ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:44:49.394372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.507451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:44:49.39445Z","caller":"traceutil/trace.go:171","msg":"trace[1490244565] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:25947; }","duration":"223.620164ms","start":"2026-07-16T16:44:49.170804Z","end":"2026-07-16T16:44:49.394425Z","steps":["trace[1490244565] 'count revisions from in-memory index tree' (duration: 223.42163ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:49.906324Z","caller":"traceutil/trace.go:171","msg":"trace[468808876] transaction","detail":"{read_only:false; response_revision:25948; number_of_response:1; }","duration":"202.930626ms","start":"2026-07-16T16:44:49.70337Z","end":"2026-07-16T16:44:49.9063Z","steps":["trace[468808876] 'process raft request' (duration: 202.409247ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:50.229415Z","caller":"traceutil/trace.go:171","msg":"trace[1445290970] transaction","detail":"{read_only:false; response_revision:25951; number_of_response:1; }","duration":"316.67872ms","start":"2026-07-16T16:44:49.912715Z","end":"2026-07-16T16:44:50.229393Z","steps":["trace[1445290970] 'process raft request' (duration: 316.613849ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:50.22944Z","caller":"traceutil/trace.go:171","msg":"trace[841329819] transaction","detail":"{read_only:false; response_revision:25950; number_of_response:1; }","duration":"318.419474ms","start":"2026-07-16T16:44:49.910989Z","end":"2026-07-16T16:44:50.229408Z","steps":["trace[841329819] 'process raft request' (duration: 318.19173ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:50.229537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:49.912708Z","time spent":"316.760342ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:44:50.229582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:49.910966Z","time spent":"318.537706ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T16:44:50.22969Z","caller":"traceutil/trace.go:171","msg":"trace[1104748430] transaction","detail":"{read_only:false; response_revision:25952; number_of_response:1; }","duration":"314.979118ms","start":"2026-07-16T16:44:49.914681Z","end":"2026-07-16T16:44:50.22966Z","steps":["trace[1104748430] 'process raft request' (duration: 314.681343ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:50.229765Z","caller":"traceutil/trace.go:171","msg":"trace[464076694] linearizableReadLoop","detail":"{readStateIndex:26808; appliedIndex:26803; }","duration":"306.191229ms","start":"2026-07-16T16:44:49.923564Z","end":"2026-07-16T16:44:50.229755Z","steps":["trace[464076694] 'read index received' (duration: 14.115149ms)","trace[464076694] 'applied index is now lower than readState.Index' (duration: 292.07535ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:44:50.229853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:49.914665Z","time spent":"315.10573ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T16:44:50.229881Z","caller":"traceutil/trace.go:171","msg":"trace[1290020072] transaction","detail":"{read_only:false; response_revision:25953; number_of_response:1; }","duration":"313.888978ms","start":"2026-07-16T16:44:49.915984Z","end":"2026-07-16T16:44:50.229873Z","steps":["trace[1290020072] 'process raft request' (duration: 313.563711ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:50.22993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:49.915976Z","time spent":"313.929049ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:44:50.230008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.440696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-16T16:44:50.230039Z","caller":"traceutil/trace.go:171","msg":"trace[1304794834] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25953; }","duration":"306.493496ms","start":"2026-07-16T16:44:49.923535Z","end":"2026-07-16T16:44:50.230029Z","steps":["trace[1304794834] 'agreement among raft nodes before linearized reading' (duration: 306.404085ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:50.230058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:49.92352Z","time spent":"306.532867ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-16T16:44:50.246688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.839962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-07-16T16:44:50.246708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.511117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-16T16:44:50.246811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.310226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-07-16T16:44:50.24681Z","caller":"traceutil/trace.go:171","msg":"trace[1831458262] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25955; }","duration":"161.69588ms","start":"2026-07-16T16:44:50.085099Z","end":"2026-07-16T16:44:50.246795Z","steps":["trace[1831458262] 'agreement among raft nodes before linearized reading' (duration: 161.497926ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:50.246835Z","caller":"traceutil/trace.go:171","msg":"trace[635235660] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25955; }","duration":"258.357087ms","start":"2026-07-16T16:44:49.988472Z","end":"2026-07-16T16:44:50.246829Z","steps":["trace[635235660] 'agreement among raft nodes before linearized reading' (duration: 258.298056ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:50.247026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.251184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:44:50.247054Z","caller":"traceutil/trace.go:171","msg":"trace[23472995] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:25955; }","duration":"281.312145ms","start":"2026-07-16T16:44:49.965734Z","end":"2026-07-16T16:44:50.247046Z","steps":["trace[23472995] 'agreement among raft nodes before linearized reading' (duration: 281.263085ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:50.247208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.953298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-16T16:44:50.247234Z","caller":"traceutil/trace.go:171","msg":"trace[1639805978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25955; }","duration":"303.009309ms","start":"2026-07-16T16:44:49.944218Z","end":"2026-07-16T16:44:50.247228Z","steps":["trace[1639805978] 'agreement among raft nodes before linearized reading' (duration: 302.943618ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:50.247254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:49.9442Z","time spent":"303.04733ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-16T16:44:50.246751Z","caller":"traceutil/trace.go:171","msg":"trace[1524742598] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25955; }","duration":"318.945795ms","start":"2026-07-16T16:44:49.927788Z","end":"2026-07-16T16:44:50.246734Z","steps":["trace[1524742598] 'agreement among raft nodes before linearized reading' (duration: 318.795011ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:50.24743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:49.927771Z","time spent":"319.651327ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-16T16:44:50.247489Z","caller":"traceutil/trace.go:171","msg":"trace[783220918] transaction","detail":"{read_only:false; response_revision:25954; number_of_response:1; }","duration":"216.518807ms","start":"2026-07-16T16:44:50.030962Z","end":"2026-07-16T16:44:50.247481Z","steps":["trace[783220918] 'process raft request' (duration: 215.491408ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:50.247552Z","caller":"traceutil/trace.go:171","msg":"trace[880005604] transaction","detail":"{read_only:false; response_revision:25955; number_of_response:1; }","duration":"144.4253ms","start":"2026-07-16T16:44:50.103119Z","end":"2026-07-16T16:44:50.247545Z","steps":["trace[880005604] 'process raft request' (duration: 143.42723ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:50.523559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.152911ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-16T16:44:50.523753Z","caller":"traceutil/trace.go:171","msg":"trace[1371292553] transaction","detail":"{read_only:false; response_revision:25958; number_of_response:1; }","duration":"268.625782ms","start":"2026-07-16T16:44:50.255105Z","end":"2026-07-16T16:44:50.523731Z","steps":["trace[1371292553] 'process raft request' (duration: 143.220147ms)","trace[1371292553] 'compare' (duration: 125.025758ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:44:50.523873Z","caller":"traceutil/trace.go:171","msg":"trace[125696569] transaction","detail":"{read_only:false; response_revision:25959; number_of_response:1; }","duration":"264.835861ms","start":"2026-07-16T16:44:50.25903Z","end":"2026-07-16T16:44:50.523866Z","steps":["trace[125696569] 'process raft request' (duration: 264.634026ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:50.523934Z","caller":"traceutil/trace.go:171","msg":"trace[1853891480] transaction","detail":"{read_only:false; response_revision:25960; number_of_response:1; }","duration":"211.098024ms","start":"2026-07-16T16:44:50.312828Z","end":"2026-07-16T16:44:50.523926Z","steps":["trace[1853891480] 'process raft request' (duration: 210.900729ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:50.757427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.625644ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-16T16:44:50.757696Z","caller":"traceutil/trace.go:171","msg":"trace[1160564330] linearizableReadLoop","detail":"{readStateIndex:26816; appliedIndex:26812; }","duration":"413.646824ms","start":"2026-07-16T16:44:50.34403Z","end":"2026-07-16T16:44:50.757677Z","steps":["trace[1160564330] 'read index received' (duration: 54.307788ms)","trace[1160564330] 'applied index is now lower than readState.Index' (duration: 359.337776ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:44:50.757861Z","caller":"traceutil/trace.go:171","msg":"trace[1645983467] transaction","detail":"{read_only:false; response_revision:25961; number_of_response:1; }","duration":"349.463387ms","start":"2026-07-16T16:44:50.408385Z","end":"2026-07-16T16:44:50.757848Z","steps":["trace[1645983467] 'process raft request' (duration: 349.164211ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:50.757995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:50.408358Z","time spent":"349.548189ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:44:50.874566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.519457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:44:50.874631Z","caller":"traceutil/trace.go:171","msg":"trace[711183432] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:25961; }","duration":"530.618458ms","start":"2026-07-16T16:44:50.343995Z","end":"2026-07-16T16:44:50.874613Z","steps":["trace[711183432] 'agreement among raft nodes before linearized reading' (duration: 413.804746ms)","trace[711183432] 'range keys from in-memory index tree' (duration: 116.719669ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:44:50.874661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:50.34398Z","time spent":"530.67369ms","remote":"127.0.0.1:33184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"warn","ts":"2026-07-16T16:44:50.874917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.449255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-16T16:44:50.874954Z","caller":"traceutil/trace.go:171","msg":"trace[210641131] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25961; }","duration":"418.516377ms","start":"2026-07-16T16:44:50.456427Z","end":"2026-07-16T16:44:50.874944Z","steps":["trace[210641131] 'agreement among raft nodes before linearized reading' (duration: 301.42181ms)","trace[210641131] 'range keys from in-memory index tree' (duration: 116.991014ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:44:50.874973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:44:50.456409Z","time spent":"418.559407ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-16T16:44:52.671344Z","caller":"traceutil/trace.go:171","msg":"trace[823619700] linearizableReadLoop","detail":"{readStateIndex:26885; appliedIndex:26884; }","duration":"214.738392ms","start":"2026-07-16T16:44:52.456582Z","end":"2026-07-16T16:44:52.671321Z","steps":["trace[823619700] 'read index received' (duration: 214.554959ms)","trace[823619700] 'applied index is now lower than readState.Index' (duration: 182.263µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:44:52.671377Z","caller":"traceutil/trace.go:171","msg":"trace[854758590] transaction","detail":"{read_only:false; response_revision:26029; number_of_response:1; }","duration":"220.215768ms","start":"2026-07-16T16:44:52.451138Z","end":"2026-07-16T16:44:52.671354Z","steps":["trace[854758590] 'process raft request' (duration: 220.040854ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:52.671613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.270616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-16T16:44:52.671654Z","caller":"traceutil/trace.go:171","msg":"trace[1103070426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26029; }","duration":"144.361169ms","start":"2026-07-16T16:44:52.527283Z","end":"2026-07-16T16:44:52.671644Z","steps":["trace[1103070426] 'agreement among raft nodes before linearized reading' (duration: 144.179535ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:52.671711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.200888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-07-16T16:44:52.671803Z","caller":"traceutil/trace.go:171","msg":"trace[1711502682] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26029; }","duration":"141.3352ms","start":"2026-07-16T16:44:52.530444Z","end":"2026-07-16T16:44:52.671779Z","steps":["trace[1711502682] 'agreement among raft nodes before linearized reading' (duration: 141.066794ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:52.67282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.217741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2224957"} {"level":"info","ts":"2026-07-16T16:44:52.672932Z","caller":"traceutil/trace.go:171","msg":"trace[291254848] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:26029; }","duration":"216.366173ms","start":"2026-07-16T16:44:52.456548Z","end":"2026-07-16T16:44:52.672914Z","steps":["trace[291254848] 'agreement among raft nodes before linearized reading' (duration: 214.900455ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:54.784296Z","caller":"traceutil/trace.go:171","msg":"trace[419665359] transaction","detail":"{read_only:false; response_revision:26049; number_of_response:1; }","duration":"101.353586ms","start":"2026-07-16T16:44:54.682919Z","end":"2026-07-16T16:44:54.784273Z","steps":["trace[419665359] 'process raft request' (duration: 101.219853ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:44:54.941359Z","caller":"traceutil/trace.go:171","msg":"trace[179188278] linearizableReadLoop","detail":"{readStateIndex:26906; appliedIndex:26904; }","duration":"224.389568ms","start":"2026-07-16T16:44:54.716943Z","end":"2026-07-16T16:44:54.941333Z","steps":["trace[179188278] 'read index received' (duration: 67.140063ms)","trace[179188278] 'applied index is now lower than readState.Index' (duration: 157.248065ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:44:54.941436Z","caller":"traceutil/trace.go:171","msg":"trace[70882634] transaction","detail":"{read_only:false; response_revision:26050; number_of_response:1; }","duration":"257.904678ms","start":"2026-07-16T16:44:54.683511Z","end":"2026-07-16T16:44:54.941416Z","steps":["trace[70882634] 'process raft request' (duration: 159.072569ms)","trace[70882634] 'compare' (duration: 98.526732ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:44:54.94143Z","caller":"traceutil/trace.go:171","msg":"trace[1822945103] transaction","detail":"{read_only:false; response_revision:26051; number_of_response:1; }","duration":"169.943327ms","start":"2026-07-16T16:44:54.77145Z","end":"2026-07-16T16:44:54.941393Z","steps":["trace[1822945103] 'process raft request' (duration: 169.804535ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:44:54.941524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.555761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/keypairs/\" range_end:\"/registry/openstack.k-orc.cloud/keypairs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:44:54.941733Z","caller":"traceutil/trace.go:171","msg":"trace[251428056] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/keypairs/; range_end:/registry/openstack.k-orc.cloud/keypairs0; response_count:0; response_revision:26051; }","duration":"224.651342ms","start":"2026-07-16T16:44:54.716903Z","end":"2026-07-16T16:44:54.941554Z","steps":["trace[251428056] 'agreement among raft nodes before linearized reading' (duration: 224.566131ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:00.173811Z","caller":"traceutil/trace.go:171","msg":"trace[1839309520] transaction","detail":"{read_only:false; response_revision:26107; number_of_response:1; }","duration":"198.964311ms","start":"2026-07-16T16:44:59.974823Z","end":"2026-07-16T16:45:00.173788Z","steps":["trace[1839309520] 'process raft request' (duration: 172.465175ms)","trace[1839309520] 'compare' (duration: 25.938625ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:45:00.448159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.74596ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:18"} {"level":"info","ts":"2026-07-16T16:45:00.448431Z","caller":"traceutil/trace.go:171","msg":"trace[179104926] transaction","detail":"{read_only:false; response_revision:26110; number_of_response:1; }","duration":"187.223447ms","start":"2026-07-16T16:45:00.26119Z","end":"2026-07-16T16:45:00.448413Z","steps":["trace[179104926] 'process raft request' (duration: 187.153536ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:00.448427Z","caller":"traceutil/trace.go:171","msg":"trace[1402706332] transaction","detail":"{read_only:false; response_revision:26109; number_of_response:1; }","duration":"189.659255ms","start":"2026-07-16T16:45:00.258734Z","end":"2026-07-16T16:45:00.448393Z","steps":["trace[1402706332] 'process raft request' (duration: 189.537812ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:00.448508Z","caller":"traceutil/trace.go:171","msg":"trace[1474319856] linearizableReadLoop","detail":"{readStateIndex:26965; appliedIndex:26964; }","duration":"274.177309ms","start":"2026-07-16T16:45:00.174294Z","end":"2026-07-16T16:45:00.448472Z","steps":["trace[1474319856] 'read index received' (duration: 122.007131ms)","trace[1474319856] 'applied index is now lower than readState.Index' (duration: 152.147578ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:45:00.448671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.351452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:45:00.448725Z","caller":"traceutil/trace.go:171","msg":"trace[1844375927] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:26111; }","duration":"274.449513ms","start":"2026-07-16T16:45:00.174262Z","end":"2026-07-16T16:45:00.448711Z","steps":["trace[1844375927] 'agreement among raft nodes before linearized reading' (duration: 274.322321ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:00.448799Z","caller":"traceutil/trace.go:171","msg":"trace[1079629115] transaction","detail":"{read_only:false; response_revision:26111; number_of_response:1; }","duration":"186.737677ms","start":"2026-07-16T16:45:00.262009Z","end":"2026-07-16T16:45:00.448747Z","steps":["trace[1079629115] 'process raft request' (duration: 186.37193ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:00.449122Z","caller":"traceutil/trace.go:171","msg":"trace[1148071704] transaction","detail":"{read_only:false; response_revision:26112; number_of_response:1; }","duration":"184.389412ms","start":"2026-07-16T16:45:00.264723Z","end":"2026-07-16T16:45:00.449112Z","steps":["trace[1148071704] 'process raft request' (duration: 183.892573ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:00.449568Z","caller":"traceutil/trace.go:171","msg":"trace[1191007198] transaction","detail":"{read_only:false; response_revision:26108; number_of_response:1; }","duration":"344.698196ms","start":"2026-07-16T16:45:00.103642Z","end":"2026-07-16T16:45:00.44834Z","steps":["trace[1191007198] 'process raft request' (duration: 192.696221ms)","trace[1191007198] 'compare' (duration: 151.560065ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:45:00.449684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:45:00.103625Z","time spent":"346.010141ms","remote":"127.0.0.1:40456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5415,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-16T16:45:00.450119Z","caller":"traceutil/trace.go:171","msg":"trace[351259118] transaction","detail":"{read_only:false; response_revision:26113; number_of_response:1; }","duration":"160.397995ms","start":"2026-07-16T16:45:00.289696Z","end":"2026-07-16T16:45:00.450094Z","steps":["trace[351259118] 'process raft request' (duration: 159.044239ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:45:00.47995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.052539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-16T16:45:00.480029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.307088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-07-16T16:45:00.480034Z","caller":"traceutil/trace.go:171","msg":"trace[1653869007] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:26113; }","duration":"125.159861ms","start":"2026-07-16T16:45:00.354852Z","end":"2026-07-16T16:45:00.480012Z","steps":["trace[1653869007] 'agreement among raft nodes before linearized reading' (duration: 125.039219ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:00.48006Z","caller":"traceutil/trace.go:171","msg":"trace[1921880493] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26113; }","duration":"144.370798ms","start":"2026-07-16T16:45:00.335681Z","end":"2026-07-16T16:45:00.480052Z","steps":["trace[1921880493] 'agreement among raft nodes before linearized reading' (duration: 144.256316ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:45:00.480281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.583963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-16T16:45:00.480308Z","caller":"traceutil/trace.go:171","msg":"trace[514001663] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26113; }","duration":"188.625215ms","start":"2026-07-16T16:45:00.291676Z","end":"2026-07-16T16:45:00.480301Z","steps":["trace[514001663] 'agreement among raft nodes before linearized reading' (duration: 188.569714ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:45:00.480425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.811074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:45:00.480449Z","caller":"traceutil/trace.go:171","msg":"trace[1492833858] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26113; }","duration":"304.360196ms","start":"2026-07-16T16:45:00.176082Z","end":"2026-07-16T16:45:00.480443Z","steps":["trace[1492833858] 'agreement among raft nodes before linearized reading' (duration: 303.792065ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:45:00.480464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:45:00.176077Z","time spent":"304.382757ms","remote":"127.0.0.1:40250","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-16T16:45:08.162023Z","caller":"traceutil/trace.go:171","msg":"trace[931657594] linearizableReadLoop","detail":"{readStateIndex:27063; appliedIndex:27062; }","duration":"263.599036ms","start":"2026-07-16T16:45:07.898406Z","end":"2026-07-16T16:45:08.162006Z","steps":["trace[931657594] 'read index received' (duration: 263.527515ms)","trace[931657594] 'applied index is now lower than readState.Index' (duration: 70.581µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:45:08.162132Z","caller":"traceutil/trace.go:171","msg":"trace[1384721883] transaction","detail":"{read_only:false; response_revision:26204; number_of_response:1; }","duration":"335.791356ms","start":"2026-07-16T16:45:07.826309Z","end":"2026-07-16T16:45:08.1621Z","steps":["trace[1384721883] 'process raft request' (duration: 335.574422ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:45:08.162186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.758279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:45:08.162206Z","caller":"traceutil/trace.go:171","msg":"trace[1236070094] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:26204; }","duration":"263.79882ms","start":"2026-07-16T16:45:07.8984Z","end":"2026-07-16T16:45:08.162199Z","steps":["trace[1236070094] 'agreement among raft nodes before linearized reading' (duration: 263.698938ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:45:08.162293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:45:07.82629Z","time spent":"335.907049ms","remote":"127.0.0.1:40416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4944,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T16:45:08.329565Z","caller":"traceutil/trace.go:171","msg":"trace[601202872] linearizableReadLoop","detail":"{readStateIndex:27065; appliedIndex:27063; }","duration":"167.467721ms","start":"2026-07-16T16:45:08.162078Z","end":"2026-07-16T16:45:08.329546Z","steps":["trace[601202872] 'read index received' (duration: 100.807896ms)","trace[601202872] 'applied index is now lower than readState.Index' (duration: 66.659325ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:45:08.329608Z","caller":"traceutil/trace.go:171","msg":"trace[1693657665] transaction","detail":"{read_only:false; response_revision:26205; number_of_response:1; }","duration":"298.281929ms","start":"2026-07-16T16:45:08.031291Z","end":"2026-07-16T16:45:08.329573Z","steps":["trace[1693657665] 'process raft request' (duration: 231.570114ms)","trace[1693657665] 'compare' (duration: 66.299746ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:45:08.329672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.740547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:45:08.329692Z","caller":"traceutil/trace.go:171","msg":"trace[1630237591] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26206; }","duration":"243.807658ms","start":"2026-07-16T16:45:08.085878Z","end":"2026-07-16T16:45:08.329686Z","steps":["trace[1630237591] 'agreement among raft nodes before linearized reading' (duration: 243.735777ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:08.329812Z","caller":"traceutil/trace.go:171","msg":"trace[657514178] transaction","detail":"{read_only:false; response_revision:26206; number_of_response:1; }","duration":"228.190609ms","start":"2026-07-16T16:45:08.101613Z","end":"2026-07-16T16:45:08.329804Z","steps":["trace[657514178] 'process raft request' (duration: 227.869973ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:08.519078Z","caller":"traceutil/trace.go:171","msg":"trace[1387529781] linearizableReadLoop","detail":"{readStateIndex:27067; appliedIndex:27065; }","duration":"188.518082ms","start":"2026-07-16T16:45:08.330547Z","end":"2026-07-16T16:45:08.519066Z","steps":["trace[1387529781] 'read index received' (duration: 185.375183ms)","trace[1387529781] 'applied index is now lower than readState.Index' (duration: 3.142469ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:45:08.519117Z","caller":"traceutil/trace.go:171","msg":"trace[1275252414] transaction","detail":"{read_only:false; response_revision:26207; number_of_response:1; }","duration":"336.5232ms","start":"2026-07-16T16:45:08.182577Z","end":"2026-07-16T16:45:08.5191Z","steps":["trace[1275252414] 'process raft request' (duration: 333.33615ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:08.519223Z","caller":"traceutil/trace.go:171","msg":"trace[1670118405] transaction","detail":"{read_only:false; response_revision:26208; number_of_response:1; }","duration":"317.70161ms","start":"2026-07-16T16:45:08.201514Z","end":"2026-07-16T16:45:08.519216Z","steps":["trace[1670118405] 'process raft request' (duration: 317.510677ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:45:08.519221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:45:08.182554Z","time spent":"336.601811ms","remote":"127.0.0.1:40680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3374,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:45:08.519264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:45:08.201495Z","time spent":"317.746842ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:45:08.519362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.818738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:45:08.519381Z","caller":"traceutil/trace.go:171","msg":"trace[1671885645] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26208; }","duration":"188.838058ms","start":"2026-07-16T16:45:08.330539Z","end":"2026-07-16T16:45:08.519377Z","steps":["trace[1671885645] 'agreement among raft nodes before linearized reading' (duration: 188.804527ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:45:08.525249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.183655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:45:08.52532Z","caller":"traceutil/trace.go:171","msg":"trace[86436592] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:26213; }","duration":"143.312148ms","start":"2026-07-16T16:45:08.381993Z","end":"2026-07-16T16:45:08.525305Z","steps":["trace[86436592] 'agreement among raft nodes before linearized reading' (duration: 143.163285ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:12.149285Z","caller":"traceutil/trace.go:171","msg":"trace[1744502768] transaction","detail":"{read_only:false; response_revision:26241; number_of_response:1; }","duration":"105.664389ms","start":"2026-07-16T16:45:12.043589Z","end":"2026-07-16T16:45:12.149253Z","steps":["trace[1744502768] 'process raft request' (duration: 105.491286ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:17.227678Z","caller":"traceutil/trace.go:171","msg":"trace[1518734509] transaction","detail":"{read_only:false; response_revision:26288; number_of_response:1; }","duration":"123.833767ms","start":"2026-07-16T16:45:17.1038Z","end":"2026-07-16T16:45:17.227634Z","steps":["trace[1518734509] 'process raft request' (duration: 123.426219ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:17.227477Z","caller":"traceutil/trace.go:171","msg":"trace[1361675830] linearizableReadLoop","detail":"{readStateIndex:27149; appliedIndex:27148; }","duration":"117.095747ms","start":"2026-07-16T16:45:17.110357Z","end":"2026-07-16T16:45:17.227452Z","steps":["trace[1361675830] 'read index received' (duration: 116.949665ms)","trace[1361675830] 'applied index is now lower than readState.Index' (duration: 145.022µs)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:45:17.228107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.706449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-07-16T16:45:17.228165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.483848ms","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-16T16:45:17.228385Z","caller":"traceutil/trace.go:171","msg":"trace[1881424712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26288; }","duration":"113.691632ms","start":"2026-07-16T16:45:17.11465Z","end":"2026-07-16T16:45:17.228342Z","steps":["trace[1881424712] 'agreement among raft nodes before linearized reading' (duration: 113.306905ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:17.238602Z","caller":"traceutil/trace.go:171","msg":"trace[1327356794] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26288; }","duration":"117.859522ms","start":"2026-07-16T16:45:17.110326Z","end":"2026-07-16T16:45:17.228186Z","steps":["trace[1327356794] 'agreement among raft nodes before linearized reading' (duration: 117.397563ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:17.337571Z","caller":"traceutil/trace.go:171","msg":"trace[959986948] transaction","detail":"{read_only:false; response_revision:26289; number_of_response:1; }","duration":"105.610857ms","start":"2026-07-16T16:45:17.231942Z","end":"2026-07-16T16:45:17.337553Z","steps":["trace[959986948] 'process raft request' (duration: 89.705094ms)","trace[959986948] 'compare' (duration: 15.809602ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:45:17.349874Z","caller":"traceutil/trace.go:171","msg":"trace[1136193147] transaction","detail":"{read_only:false; response_revision:26290; number_of_response:1; }","duration":"108.949681ms","start":"2026-07-16T16:45:17.240898Z","end":"2026-07-16T16:45:17.349847Z","steps":["trace[1136193147] 'process raft request' (duration: 108.688037ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:23.465937Z","caller":"traceutil/trace.go:171","msg":"trace[1116238590] transaction","detail":"{read_only:false; response_revision:26358; number_of_response:1; }","duration":"114.932526ms","start":"2026-07-16T16:45:23.350987Z","end":"2026-07-16T16:45:23.46592Z","steps":["trace[1116238590] 'process raft request' (duration: 75.147336ms)","trace[1116238590] 'compare' (duration: 39.637797ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:45:23.465926Z","caller":"traceutil/trace.go:171","msg":"trace[1883428116] linearizableReadLoop","detail":"{readStateIndex:27221; appliedIndex:27220; }","duration":"108.759467ms","start":"2026-07-16T16:45:23.357126Z","end":"2026-07-16T16:45:23.465885Z","steps":["trace[1883428116] 'read index received' (duration: 68.951627ms)","trace[1883428116] 'applied index is now lower than readState.Index' (duration: 39.80683ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T16:45:23.466081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.9389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-16T16:45:23.466118Z","caller":"traceutil/trace.go:171","msg":"trace[744306420] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26358; }","duration":"109.022772ms","start":"2026-07-16T16:45:23.357086Z","end":"2026-07-16T16:45:23.466109Z","steps":["trace[744306420] 'agreement among raft nodes before linearized reading' (duration: 108.88711ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:32.753245Z","caller":"traceutil/trace.go:171","msg":"trace[292241728] transaction","detail":"{read_only:false; response_revision:26425; number_of_response:1; }","duration":"157.933457ms","start":"2026-07-16T16:45:32.595289Z","end":"2026-07-16T16:45:32.753222Z","steps":["trace[292241728] 'process raft request' (duration: 157.793664ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:33.042076Z","caller":"traceutil/trace.go:171","msg":"trace[942728085] transaction","detail":"{read_only:false; response_revision:26426; number_of_response:1; }","duration":"444.486743ms","start":"2026-07-16T16:45:32.597545Z","end":"2026-07-16T16:45:33.042031Z","steps":["trace[942728085] 'process raft request' (duration: 383.370656ms)","trace[942728085] 'compare' (duration: 60.75103ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:45:33.042139Z","caller":"traceutil/trace.go:171","msg":"trace[835558811] transaction","detail":"{read_only:false; response_revision:26427; number_of_response:1; }","duration":"444.369921ms","start":"2026-07-16T16:45:32.59773Z","end":"2026-07-16T16:45:33.0421Z","steps":["trace[835558811] 'process raft request' (duration: 444.204438ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:45:33.042267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:45:32.597709Z","time spent":"444.494914ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:45:33.042266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:45:32.597519Z","time spent":"444.646576ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T16:45:33.04263Z","caller":"traceutil/trace.go:171","msg":"trace[622126786] transaction","detail":"{read_only:false; response_revision:26428; number_of_response:1; }","duration":"437.974238ms","start":"2026-07-16T16:45:32.604643Z","end":"2026-07-16T16:45:33.042617Z","steps":["trace[622126786] 'process raft request' (duration: 437.341287ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:33.042658Z","caller":"traceutil/trace.go:171","msg":"trace[1782067881] transaction","detail":"{read_only:false; response_revision:26429; number_of_response:1; }","duration":"437.964449ms","start":"2026-07-16T16:45:32.604687Z","end":"2026-07-16T16:45:33.042651Z","steps":["trace[1782067881] 'process raft request' (duration: 437.841517ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:33.042639Z","caller":"traceutil/trace.go:171","msg":"trace[579563671] linearizableReadLoop","detail":"{readStateIndex:27295; appliedIndex:27289; }","duration":"414.495839ms","start":"2026-07-16T16:45:32.628125Z","end":"2026-07-16T16:45:33.042621Z","steps":["trace[579563671] 'read index received' (duration: 125.024778ms)","trace[579563671] 'applied index is now lower than readState.Index' (duration: 289.469981ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:45:33.042664Z","caller":"traceutil/trace.go:171","msg":"trace[1051841623] transaction","detail":"{read_only:false; response_revision:26430; number_of_response:1; }","duration":"437.787194ms","start":"2026-07-16T16:45:32.604858Z","end":"2026-07-16T16:45:33.042645Z","steps":["trace[1051841623] 'process raft request' (duration: 437.698212ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:45:33.042695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:45:32.60466Z","time spent":"438.014779ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:45:33.042703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:45:32.604622Z","time spent":"438.04248ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T16:45:33.042749Z","caller":"traceutil/trace.go:171","msg":"trace[1793805271] transaction","detail":"{read_only:false; response_revision:26431; number_of_response:1; }","duration":"367.626613ms","start":"2026-07-16T16:45:32.675111Z","end":"2026-07-16T16:45:33.042737Z","steps":["trace[1793805271] 'process raft request' (duration: 367.479661ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:45:33.042755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:45:32.604842Z","time spent":"437.865476ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:45:33.042829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:45:32.67509Z","time spent":"367.680124ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T16:45:33.042864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.371809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-16T16:45:33.042884Z","caller":"traceutil/trace.go:171","msg":"trace[637494229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26431; }","duration":"412.420969ms","start":"2026-07-16T16:45:32.630457Z","end":"2026-07-16T16:45:33.042878Z","steps":["trace[637494229] 'agreement among raft nodes before linearized reading' (duration: 412.341468ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:45:33.042899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:45:32.630444Z","time spent":"412.45168ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-16T16:45:33.042968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.846616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-07-16T16:45:33.043017Z","caller":"traceutil/trace.go:171","msg":"trace[741182532] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26431; }","duration":"414.924027ms","start":"2026-07-16T16:45:32.62808Z","end":"2026-07-16T16:45:33.043004Z","steps":["trace[741182532] 'agreement among raft nodes before linearized reading' (duration: 414.784175ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:45:33.043049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T16:45:32.628068Z","time spent":"414.974158ms","remote":"127.0.0.1:40492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-16T16:45:33.329708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.766345ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-16T16:45:33.329895Z","caller":"traceutil/trace.go:171","msg":"trace[1982431591] linearizableReadLoop","detail":"{readStateIndex:27298; appliedIndex:27296; }","duration":"264.153267ms","start":"2026-07-16T16:45:33.065728Z","end":"2026-07-16T16:45:33.329881Z","steps":["trace[1982431591] 'read index received' (duration: 118.27996ms)","trace[1982431591] 'applied index is now lower than readState.Index' (duration: 145.872617ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:45:33.329968Z","caller":"traceutil/trace.go:171","msg":"trace[302156748] transaction","detail":"{read_only:false; response_revision:26432; number_of_response:1; }","duration":"284.115328ms","start":"2026-07-16T16:45:33.045842Z","end":"2026-07-16T16:45:33.329957Z","steps":["trace[302156748] 'process raft request' (duration: 138.028927ms)","trace[302156748] 'compare' (duration: 145.47809ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:45:33.330117Z","caller":"traceutil/trace.go:171","msg":"trace[214642033] transaction","detail":"{read_only:false; response_revision:26433; number_of_response:1; }","duration":"283.262553ms","start":"2026-07-16T16:45:33.046846Z","end":"2026-07-16T16:45:33.330109Z","steps":["trace[214642033] 'process raft request' (duration: 282.993137ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:45:33.330298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.565925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-16T16:45:33.330333Z","caller":"traceutil/trace.go:171","msg":"trace[1540075750] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26433; }","duration":"264.623766ms","start":"2026-07-16T16:45:33.065699Z","end":"2026-07-16T16:45:33.330323Z","steps":["trace[1540075750] 'agreement among raft nodes before linearized reading' (duration: 264.497054ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:35.226134Z","caller":"traceutil/trace.go:171","msg":"trace[762804227] transaction","detail":"{read_only:false; response_revision:26445; number_of_response:1; }","duration":"178.797676ms","start":"2026-07-16T16:45:35.047311Z","end":"2026-07-16T16:45:35.226109Z","steps":["trace[762804227] 'process raft request' (duration: 121.42506ms)","trace[762804227] 'compare' (duration: 57.162052ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:45:35.226289Z","caller":"traceutil/trace.go:171","msg":"trace[1309376467] linearizableReadLoop","detail":"{readStateIndex:27314; appliedIndex:27308; }","duration":"138.905983ms","start":"2026-07-16T16:45:35.087365Z","end":"2026-07-16T16:45:35.226271Z","steps":["trace[1309376467] 'read index received' (duration: 26.585468ms)","trace[1309376467] 'applied index is now lower than readState.Index' (duration: 112.319715ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:45:35.226375Z","caller":"traceutil/trace.go:171","msg":"trace[1559876517] transaction","detail":"{read_only:false; response_revision:26448; number_of_response:1; }","duration":"171.111119ms","start":"2026-07-16T16:45:35.055257Z","end":"2026-07-16T16:45:35.226368Z","steps":["trace[1559876517] 'process raft request' (duration: 170.954666ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:35.226393Z","caller":"traceutil/trace.go:171","msg":"trace[858800997] transaction","detail":"{read_only:false; response_revision:26449; number_of_response:1; }","duration":"163.507154ms","start":"2026-07-16T16:45:35.062878Z","end":"2026-07-16T16:45:35.226386Z","steps":["trace[858800997] 'process raft request' (duration: 163.359012ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:35.226438Z","caller":"traceutil/trace.go:171","msg":"trace[1612700623] transaction","detail":"{read_only:false; response_revision:26446; number_of_response:1; }","duration":"178.845817ms","start":"2026-07-16T16:45:35.047584Z","end":"2026-07-16T16:45:35.22643Z","steps":["trace[1612700623] 'process raft request' (duration: 178.43284ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:45:35.226547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.176009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-16T16:45:35.226575Z","caller":"traceutil/trace.go:171","msg":"trace[1621120926] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26449; }","duration":"139.24435ms","start":"2026-07-16T16:45:35.087324Z","end":"2026-07-16T16:45:35.226569Z","steps":["trace[1621120926] 'agreement among raft nodes before linearized reading' (duration: 139.182399ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:35.226581Z","caller":"traceutil/trace.go:171","msg":"trace[130301870] transaction","detail":"{read_only:false; response_revision:26447; number_of_response:1; }","duration":"178.861338ms","start":"2026-07-16T16:45:35.047676Z","end":"2026-07-16T16:45:35.226537Z","steps":["trace[130301870] 'process raft request' (duration: 178.373929ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T16:45:35.226806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.332564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-16T16:45:35.226891Z","caller":"traceutil/trace.go:171","msg":"trace[1529095] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:26449; }","duration":"103.462516ms","start":"2026-07-16T16:45:35.123408Z","end":"2026-07-16T16:45:35.226871Z","steps":["trace[1529095] 'agreement among raft nodes before linearized reading' (duration: 103.258543ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:35.980543Z","caller":"traceutil/trace.go:171","msg":"trace[675461411] transaction","detail":"{read_only:false; response_revision:26458; number_of_response:1; }","duration":"114.048279ms","start":"2026-07-16T16:45:35.866473Z","end":"2026-07-16T16:45:35.980521Z","steps":["trace[675461411] 'process raft request' (duration: 113.903946ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:36.921784Z","caller":"traceutil/trace.go:171","msg":"trace[429788022] transaction","detail":"{read_only:false; response_revision:26460; number_of_response:1; }","duration":"153.615205ms","start":"2026-07-16T16:45:36.768152Z","end":"2026-07-16T16:45:36.921767Z","steps":["trace[429788022] 'process raft request' (duration: 153.464892ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:37.026943Z","caller":"traceutil/trace.go:171","msg":"trace[989223308] transaction","detail":"{read_only:false; response_revision:26461; number_of_response:1; }","duration":"102.820744ms","start":"2026-07-16T16:45:36.924072Z","end":"2026-07-16T16:45:37.026893Z","steps":["trace[989223308] 'process raft request' (duration: 75.38722ms)","trace[989223308] 'compare' (duration: 27.265151ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:45:37.033232Z","caller":"traceutil/trace.go:171","msg":"trace[1219388635] transaction","detail":"{read_only:false; response_revision:26462; number_of_response:1; }","duration":"103.248482ms","start":"2026-07-16T16:45:36.929955Z","end":"2026-07-16T16:45:37.033203Z","steps":["trace[1219388635] 'process raft request' (duration: 102.925136ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:37.635979Z","caller":"traceutil/trace.go:171","msg":"trace[20981913] transaction","detail":"{read_only:false; response_revision:26471; number_of_response:1; }","duration":"132.330259ms","start":"2026-07-16T16:45:37.503626Z","end":"2026-07-16T16:45:37.635957Z","steps":["trace[20981913] 'process raft request' (duration: 76.618634ms)","trace[20981913] 'compare' (duration: 55.541342ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:45:42.917777Z","caller":"traceutil/trace.go:171","msg":"trace[1143841412] transaction","detail":"{read_only:false; response_revision:26504; number_of_response:1; }","duration":"114.299923ms","start":"2026-07-16T16:45:42.803456Z","end":"2026-07-16T16:45:42.917756Z","steps":["trace[1143841412] 'process raft request' (duration: 114.114289ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:45:43.102512Z","caller":"traceutil/trace.go:171","msg":"trace[1126497106] transaction","detail":"{read_only:false; response_revision:26505; number_of_response:1; }","duration":"155.034583ms","start":"2026-07-16T16:45:42.947445Z","end":"2026-07-16T16:45:43.10248Z","steps":["trace[1126497106] 'process raft request' (duration: 121.251917ms)","trace[1126497106] 'compare' (duration: 33.620933ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:47:31.848307Z","caller":"traceutil/trace.go:171","msg":"trace[1207176265] transaction","detail":"{read_only:false; response_revision:27623; number_of_response:1; }","duration":"162.610857ms","start":"2026-07-16T16:47:31.685667Z","end":"2026-07-16T16:47:31.848278Z","steps":["trace[1207176265] 'process raft request' (duration: 91.709663ms)","trace[1207176265] 'compare' (duration: 70.577428ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T16:47:31.848486Z","caller":"traceutil/trace.go:171","msg":"trace[371109337] transaction","detail":"{read_only:false; response_revision:27624; number_of_response:1; }","duration":"162.423574ms","start":"2026-07-16T16:47:31.686046Z","end":"2026-07-16T16:47:31.848469Z","steps":["trace[371109337] 'process raft request' (duration: 162.172429ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:47:31.848779Z","caller":"traceutil/trace.go:171","msg":"trace[1970959910] transaction","detail":"{read_only:false; response_revision:27625; number_of_response:1; }","duration":"162.641329ms","start":"2026-07-16T16:47:31.686061Z","end":"2026-07-16T16:47:31.848703Z","steps":["trace[1970959910] 'process raft request' (duration: 162.349583ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:47:31.848984Z","caller":"traceutil/trace.go:171","msg":"trace[396144968] transaction","detail":"{read_only:false; response_revision:27626; number_of_response:1; }","duration":"162.911574ms","start":"2026-07-16T16:47:31.686058Z","end":"2026-07-16T16:47:31.848969Z","steps":["trace[396144968] 'process raft request' (duration: 162.549117ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:47:31.849219Z","caller":"traceutil/trace.go:171","msg":"trace[579750067] transaction","detail":"{read_only:false; response_revision:27627; number_of_response:1; }","duration":"102.043859ms","start":"2026-07-16T16:47:31.747163Z","end":"2026-07-16T16:47:31.849207Z","steps":["trace[579750067] 'process raft request' (duration: 101.516819ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:47:41.702239Z","caller":"traceutil/trace.go:171","msg":"trace[1432109940] transaction","detail":"{read_only:false; response_revision:27696; number_of_response:1; }","duration":"161.75147ms","start":"2026-07-16T16:47:41.540455Z","end":"2026-07-16T16:47:41.702207Z","steps":["trace[1432109940] 'process raft request' (duration: 161.488905ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:48:32.085487Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25186} {"level":"info","ts":"2026-07-16T16:48:32.238327Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25186,"took":"148.489527ms","hash":4158324889,"current-db-size-bytes":60321792,"current-db-size":"60 MB","current-db-size-in-use-bytes":38379520,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-07-16T16:48:32.238379Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4158324889,"revision":25186,"compact-revision":21969} {"level":"info","ts":"2026-07-16T16:49:05.368205Z","caller":"traceutil/trace.go:171","msg":"trace[2125912192] transaction","detail":"{read_only:false; response_revision:28552; number_of_response:1; }","duration":"120.262948ms","start":"2026-07-16T16:49:05.247908Z","end":"2026-07-16T16:49:05.368171Z","steps":["trace[2125912192] 'process raft request' (duration: 119.907511ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T16:49:58.991692Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"50e03cebfd94cbba","local-member-applied-index":30004,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-16T16:49:58.997267Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30004} {"level":"info","ts":"2026-07-16T16:49:58.997401Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25004} {"level":"info","ts":"2026-07-16T16:53:32.092105Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28167} {"level":"info","ts":"2026-07-16T16:53:32.228193Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28167,"took":"130.880152ms","hash":1167315232,"current-db-size-bytes":60321792,"current-db-size":"60 MB","current-db-size-in-use-bytes":33480704,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-16T16:53:32.228359Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1167315232,"revision":28167,"compact-revision":25186} {"level":"info","ts":"2026-07-16T16:58:32.100956Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30696} {"level":"info","ts":"2026-07-16T16:58:32.255588Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30696,"took":"150.516446ms","hash":189886965,"current-db-size-bytes":60321792,"current-db-size":"60 MB","current-db-size-in-use-bytes":31641600,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-16T16:58:32.255685Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":189886965,"revision":30696,"compact-revision":28167} {"level":"info","ts":"2026-07-16T17:03:32.107269Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32971} {"level":"info","ts":"2026-07-16T17:03:32.250536Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32971,"took":"140.24831ms","hash":941389697,"current-db-size-bytes":61362176,"current-db-size":"61 MB","current-db-size-in-use-bytes":31584256,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-16T17:03:32.250601Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":941389697,"revision":32971,"compact-revision":30696} {"level":"info","ts":"2026-07-16T17:08:32.113206Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35285} {"level":"info","ts":"2026-07-16T17:08:32.258245Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35285,"took":"140.117748ms","hash":1017596627,"current-db-size-bytes":61362176,"current-db-size":"61 MB","current-db-size-in-use-bytes":31555584,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-16T17:08:32.258321Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1017596627,"revision":35285,"compact-revision":32971} {"level":"info","ts":"2026-07-16T17:10:59.120473Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"50e03cebfd94cbba","local-member-applied-index":40005,"local-member-snapshot-index":30004,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-16T17:10:59.126046Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40005} {"level":"info","ts":"2026-07-16T17:10:59.126148Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35005}