{"level":"warn","ts":"2026-08-11T14:55:27.837664Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T14:55:27.837792Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.137: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.19.213.137:2380","--initial-cluster=instance=https://199.19.213.137:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.137:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.137:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-11T14:55:27.837878Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T14:55:27.837895Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.137:2380"]} {"level":"info","ts":"2026-08-11T14:55:27.838093Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-11T14:55:27.839363Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.137:2379"]} {"level":"info","ts":"2026-08-11T14:55:27.839458Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.137:2380"],"listen-peer-urls":["https://199.19.213.137:2380"],"advertise-client-urls":["https://199.19.213.137:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.137:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.137:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-11T14:55:27.844641Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.918497ms"} {"level":"info","ts":"2026-08-11T14:55:27.853634Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2ba8e3c2b0588654","cluster-id":"97694c3f9947e4ca"} {"level":"info","ts":"2026-08-11T14:55:27.853803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 switched to configuration voters=()"} {"level":"info","ts":"2026-08-11T14:55:27.853846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became follower at term 0"} {"level":"info","ts":"2026-08-11T14:55:27.85388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2ba8e3c2b0588654 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-11T14:55:27.85391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became follower at term 1"} {"level":"info","ts":"2026-08-11T14:55:27.853972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 switched to configuration voters=(3146014765040043604)"} {"level":"warn","ts":"2026-08-11T14:55:27.861919Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-11T14:55:27.863484Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-11T14:55:27.866526Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-11T14:55:27.869421Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2ba8e3c2b0588654","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-11T14:55:27.869668Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2ba8e3c2b0588654","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-11T14:55:27.869797Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-11T14:55:27.872219Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-11T14:55:27.872413Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-11T14:55:27.873451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 switched to configuration voters=(3146014765040043604)"} {"level":"info","ts":"2026-08-11T14:55:27.873791Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"97694c3f9947e4ca","local-member-id":"2ba8e3c2b0588654","added-peer-id":"2ba8e3c2b0588654","added-peer-peer-urls":["https://199.19.213.137:2380"]} {"level":"info","ts":"2026-08-11T14:55:27.881699Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-11T14:55:27.881857Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2ba8e3c2b0588654","initial-advertise-peer-urls":["https://199.19.213.137:2380"],"listen-peer-urls":["https://199.19.213.137:2380"],"advertise-client-urls":["https://199.19.213.137:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.137:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-11T14:55:27.881893Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-11T14:55:27.881959Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.137:2380"} {"level":"info","ts":"2026-08-11T14:55:27.882089Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.137:2380"} {"level":"info","ts":"2026-08-11T14:55:28.455832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 is starting a new election at term 1"} {"level":"info","ts":"2026-08-11T14:55:28.455878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-11T14:55:28.455897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 received MsgPreVoteResp from 2ba8e3c2b0588654 at term 1"} {"level":"info","ts":"2026-08-11T14:55:28.455907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became candidate at term 2"} {"level":"info","ts":"2026-08-11T14:55:28.455915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 received MsgVoteResp from 2ba8e3c2b0588654 at term 2"} {"level":"info","ts":"2026-08-11T14:55:28.455923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2ba8e3c2b0588654 became leader at term 2"} {"level":"info","ts":"2026-08-11T14:55:28.455935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2ba8e3c2b0588654 elected leader 2ba8e3c2b0588654 at term 2"} {"level":"info","ts":"2026-08-11T14:55:28.464853Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T14:55:28.468103Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T14:55:28.468102Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2ba8e3c2b0588654","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.137:2379]}","request-path":"/0/members/2ba8e3c2b0588654/attributes","cluster-id":"97694c3f9947e4ca","publish-timeout":"7s"} {"level":"info","ts":"2026-08-11T14:55:28.468318Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T14:55:28.471387Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-11T14:55:28.471971Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.137:2379"} {"level":"info","ts":"2026-08-11T14:55:28.472156Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-11T14:55:28.472191Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-11T14:55:28.472281Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"97694c3f9947e4ca","local-member-id":"2ba8e3c2b0588654","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T14:55:28.480305Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T14:55:28.480909Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T14:56:05.091083Z","caller":"traceutil/trace.go:171","msg":"trace[528158200] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"125.816766ms","start":"2026-08-11T14:56:04.965244Z","end":"2026-08-11T14:56:05.091061Z","steps":["trace[528158200] 'process raft request' (duration: 111.157481ms)","trace[528158200] 'compare' (duration: 14.422633ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:56:05.091223Z","caller":"traceutil/trace.go:171","msg":"trace[991260458] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"123.211095ms","start":"2026-08-11T14:56:04.967989Z","end":"2026-08-11T14:56:05.0912Z","steps":["trace[991260458] 'process raft request' (duration: 122.971874ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:56:05.092177Z","caller":"traceutil/trace.go:171","msg":"trace[1356656516] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"114.201418ms","start":"2026-08-11T14:56:04.977946Z","end":"2026-08-11T14:56:05.092147Z","steps":["trace[1356656516] 'process raft request' (duration: 113.647792ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:56:05.092284Z","caller":"traceutil/trace.go:171","msg":"trace[1443706418] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"105.695524ms","start":"2026-08-11T14:56:04.986561Z","end":"2026-08-11T14:56:05.092256Z","steps":["trace[1443706418] 'process raft request' (duration: 105.499064ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:56:10.954209Z","caller":"traceutil/trace.go:171","msg":"trace[2146613122] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"158.539622ms","start":"2026-08-11T14:56:10.795643Z","end":"2026-08-11T14:56:10.954183Z","steps":["trace[2146613122] 'process raft request' (duration: 151.412626ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:56:11.255633Z","caller":"traceutil/trace.go:171","msg":"trace[2031826727] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"106.195632ms","start":"2026-08-11T14:56:11.149393Z","end":"2026-08-11T14:56:11.255589Z","steps":["trace[2031826727] 'read index received' (duration: 100.755754ms)","trace[2031826727] 'applied index is now lower than readState.Index' (duration: 5.439288ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:56:11.25594Z","caller":"traceutil/trace.go:171","msg":"trace[1868923873] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"146.4547ms","start":"2026-08-11T14:56:11.109457Z","end":"2026-08-11T14:56:11.255912Z","steps":["trace[1868923873] 'process raft request' (duration: 145.362422ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:56:11.255968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.560589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-11T14:56:11.256028Z","caller":"traceutil/trace.go:171","msg":"trace[791229510] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:632; }","duration":"106.674693ms","start":"2026-08-11T14:56:11.14934Z","end":"2026-08-11T14:56:11.256015Z","steps":["trace[791229510] 'agreement among raft nodes before linearized reading' (duration: 106.500096ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:56:12.154473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"850.682239ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T14:56:12.155536Z","caller":"traceutil/trace.go:171","msg":"trace[380285425] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:654; }","duration":"858.861076ms","start":"2026-08-11T14:56:11.296662Z","end":"2026-08-11T14:56:12.155523Z","steps":["trace[380285425] 'read index received' (duration: 6.104407ms)","trace[380285425] 'applied index is now lower than readState.Index' (duration: 852.755848ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:56:12.155535Z","caller":"traceutil/trace.go:171","msg":"trace[1034354319] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"895.801618ms","start":"2026-08-11T14:56:11.259709Z","end":"2026-08-11T14:56:12.15551Z","steps":["trace[1034354319] 'process raft request' (duration: 43.04787ms)","trace[1034354319] 'compare' (duration: 850.324023ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T14:56:12.155752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.060604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.137\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-11T14:56:12.155637Z","caller":"traceutil/trace.go:171","msg":"trace[1147767736] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"877.036974ms","start":"2026-08-11T14:56:11.278586Z","end":"2026-08-11T14:56:12.155623Z","steps":["trace[1147767736] 'process raft request' (duration: 876.855757ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:56:12.155851Z","caller":"traceutil/trace.go:171","msg":"trace[421989260] range","detail":"{range_begin:/registry/masterleases/199.19.213.137; range_end:; response_count:1; response_revision:634; }","duration":"859.205331ms","start":"2026-08-11T14:56:11.296633Z","end":"2026-08-11T14:56:12.155839Z","steps":["trace[421989260] 'agreement among raft nodes before linearized reading' (duration: 858.981132ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:56:12.155919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:56:11.296614Z","time spent":"859.269895ms","remote":"127.0.0.1:42340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.137\" "} {"level":"warn","ts":"2026-08-11T14:56:12.15594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:56:11.27855Z","time spent":"877.316967ms","remote":"127.0.0.1:42480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T14:56:12.156131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:56:11.259691Z","time spent":"896.412055ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T14:56:12.16852Z","caller":"traceutil/trace.go:171","msg":"trace[233875390] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"852.464692ms","start":"2026-08-11T14:56:11.316016Z","end":"2026-08-11T14:56:12.168481Z","steps":["trace[233875390] 'process raft request' (duration: 852.352057ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:56:12.168633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:56:11.315991Z","time spent":"852.580817ms","remote":"127.0.0.1:42788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T14:56:12.168678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.302517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T14:56:12.168646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.560688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-11T14:56:12.168771Z","caller":"traceutil/trace.go:171","msg":"trace[1332682579] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"127.404462ms","start":"2026-08-11T14:56:12.041338Z","end":"2026-08-11T14:56:12.168742Z","steps":["trace[1332682579] 'agreement among raft nodes before linearized reading' (duration: 127.303477ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:56:12.16882Z","caller":"traceutil/trace.go:171","msg":"trace[1448315395] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:635; }","duration":"609.769997ms","start":"2026-08-11T14:56:11.559042Z","end":"2026-08-11T14:56:12.168812Z","steps":["trace[1448315395] 'agreement among raft nodes before linearized reading' (duration: 609.434253ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:56:12.168885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:56:11.559023Z","time spent":"609.855349ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-11T14:56:12.168882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.25468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-11T14:56:12.16898Z","caller":"traceutil/trace.go:171","msg":"trace[1707208749] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:635; }","duration":"252.415147ms","start":"2026-08-11T14:56:11.916545Z","end":"2026-08-11T14:56:12.168961Z","steps":["trace[1707208749] 'agreement among raft nodes before linearized reading' (duration: 252.158566ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:56:13.590589Z","caller":"traceutil/trace.go:171","msg":"trace[1589536176] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"228.703134ms","start":"2026-08-11T14:56:13.361858Z","end":"2026-08-11T14:56:13.590561Z","steps":["trace[1589536176] 'process raft request' (duration: 171.610873ms)","trace[1589536176] 'compare' (duration: 56.930804ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:56:13.592553Z","caller":"traceutil/trace.go:171","msg":"trace[1350830529] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"225.162042ms","start":"2026-08-11T14:56:13.367368Z","end":"2026-08-11T14:56:13.59253Z","steps":["trace[1350830529] 'process raft request' (duration: 224.937182ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:56:13.592668Z","caller":"traceutil/trace.go:171","msg":"trace[73351933] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"224.661479ms","start":"2026-08-11T14:56:13.367977Z","end":"2026-08-11T14:56:13.592638Z","steps":["trace[73351933] 'process raft request' (duration: 224.495422ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:56:23.487388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.810268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-11T14:56:23.487507Z","caller":"traceutil/trace.go:171","msg":"trace[1802146262] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:777; }","duration":"102.986414ms","start":"2026-08-11T14:56:23.3845Z","end":"2026-08-11T14:56:23.487487Z","steps":["trace[1802146262] 'range keys from in-memory index tree' (duration: 102.580107ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:56:25.4277Z","caller":"traceutil/trace.go:171","msg":"trace[1736451869] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"387.276847ms","start":"2026-08-11T14:56:25.0404Z","end":"2026-08-11T14:56:25.427677Z","steps":["trace[1736451869] 'process raft request' (duration: 387.154503ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:56:25.427872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:56:25.040382Z","time spent":"387.395692ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T14:56:26.355301Z","caller":"traceutil/trace.go:171","msg":"trace[224237792] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:818; }","duration":"115.707716ms","start":"2026-08-11T14:56:26.239568Z","end":"2026-08-11T14:56:26.355276Z","steps":["trace[224237792] 'read index received' (duration: 115.526149ms)","trace[224237792] 'applied index is now lower than readState.Index' (duration: 180.547µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:56:26.35551Z","caller":"traceutil/trace.go:171","msg":"trace[1660892911] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"131.012181ms","start":"2026-08-11T14:56:26.224338Z","end":"2026-08-11T14:56:26.35535Z","steps":["trace[1660892911] 'process raft request' (duration: 130.761821ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:56:26.355618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.023808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-11T14:56:26.355897Z","caller":"traceutil/trace.go:171","msg":"trace[168033189] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:793; }","duration":"116.347821ms","start":"2026-08-11T14:56:26.239535Z","end":"2026-08-11T14:56:26.355883Z","steps":["trace[168033189] 'agreement among raft nodes before linearized reading' (duration: 115.895903ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:56:26.356073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.391814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-11T14:56:26.356136Z","caller":"traceutil/trace.go:171","msg":"trace[1099118364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:793; }","duration":"116.518628ms","start":"2026-08-11T14:56:26.239606Z","end":"2026-08-11T14:56:26.356125Z","steps":["trace[1099118364] 'agreement among raft nodes before linearized reading' (duration: 115.853822ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:56:27.831435Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.471507888s","expected-duration":"1s"} {"level":"info","ts":"2026-08-11T14:56:27.83207Z","caller":"traceutil/trace.go:171","msg":"trace[1596869599] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"1.472272519s","start":"2026-08-11T14:56:26.35978Z","end":"2026-08-11T14:56:27.832052Z","steps":["trace[1596869599] 'process raft request' (duration: 1.472122132s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:56:27.832178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:56:26.35976Z","time spent":"1.472359172s","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T14:56:27.837508Z","caller":"traceutil/trace.go:171","msg":"trace[1144981198] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"1.476824148s","start":"2026-08-11T14:56:26.360657Z","end":"2026-08-11T14:56:27.837482Z","steps":["trace[1144981198] 'process raft request' (duration: 1.476606649s)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:56:27.837549Z","caller":"traceutil/trace.go:171","msg":"trace[1276965142] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"1.476568488s","start":"2026-08-11T14:56:26.360953Z","end":"2026-08-11T14:56:27.837521Z","steps":["trace[1276965142] 'process raft request' (duration: 1.476459204s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:56:27.837652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:56:26.360636Z","time spent":"1.476939273s","remote":"127.0.0.1:42480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T14:56:27.837689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:56:26.360942Z","time spent":"1.476664261s","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T14:56:27.840378Z","caller":"traceutil/trace.go:171","msg":"trace[1656040390] linearizableReadLoop","detail":"{readStateIndex:823; appliedIndex:819; }","duration":"407.817096ms","start":"2026-08-11T14:56:27.432544Z","end":"2026-08-11T14:56:27.840361Z","steps":["trace[1656040390] 'read index received' (duration: 399.343073ms)","trace[1656040390] 'applied index is now lower than readState.Index' (duration: 8.472873ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T14:56:27.840538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.112198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-08-11T14:56:27.840547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.003903ms","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-08-11T14:56:27.840575Z","caller":"traceutil/trace.go:171","msg":"trace[1351569203] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:796; }","duration":"309.176659ms","start":"2026-08-11T14:56:27.53139Z","end":"2026-08-11T14:56:27.840567Z","steps":["trace[1351569203] 'agreement among raft nodes before linearized reading' (duration: 309.073995ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:56:27.840591Z","caller":"traceutil/trace.go:171","msg":"trace[1938728752] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:796; }","duration":"408.083366ms","start":"2026-08-11T14:56:27.432496Z","end":"2026-08-11T14:56:27.84058Z","steps":["trace[1938728752] 'agreement among raft nodes before linearized reading' (duration: 407.948321ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:56:27.840606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:56:27.531371Z","time spent":"309.228371ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-11T14:56:27.840624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:56:27.432476Z","time spent":"408.141308ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-11T14:57:45.861424Z","caller":"traceutil/trace.go:171","msg":"trace[319046017] linearizableReadLoop","detail":"{readStateIndex:1956; appliedIndex:1955; }","duration":"169.373659ms","start":"2026-08-11T14:57:45.692026Z","end":"2026-08-11T14:57:45.861399Z","steps":["trace[319046017] 'read index received' (duration: 169.157463ms)","trace[319046017] 'applied index is now lower than readState.Index' (duration: 215.376µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:57:45.861906Z","caller":"traceutil/trace.go:171","msg":"trace[1943467986] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"410.867405ms","start":"2026-08-11T14:57:45.450961Z","end":"2026-08-11T14:57:45.861828Z","steps":["trace[1943467986] 'process raft request' (duration: 410.31413ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:57:45.862032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.426178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-11T14:57:45.862129Z","caller":"traceutil/trace.go:171","msg":"trace[595364883] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1884; }","duration":"103.583623ms","start":"2026-08-11T14:57:45.758525Z","end":"2026-08-11T14:57:45.862109Z","steps":["trace[595364883] 'agreement among raft nodes before linearized reading' (duration: 103.273884ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:57:45.862023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:57:45.450936Z","time spent":"411.013579ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T14:57:45.862202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.158002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-362d2a58-1592-48fb-94b6-0e0e0e4b86a0\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-11T14:57:45.862311Z","caller":"traceutil/trace.go:171","msg":"trace[847023582] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-362d2a58-1592-48fb-94b6-0e0e0e4b86a0; range_end:; response_count:1; response_revision:1884; }","duration":"170.327018ms","start":"2026-08-11T14:57:45.69196Z","end":"2026-08-11T14:57:45.862287Z","steps":["trace[847023582] 'agreement among raft nodes before linearized reading' (duration: 170.020089ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:57:46.712266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.658783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-11T14:57:46.712349Z","caller":"traceutil/trace.go:171","msg":"trace[534949622] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1886; }","duration":"399.792076ms","start":"2026-08-11T14:57:46.312539Z","end":"2026-08-11T14:57:46.712331Z","steps":["trace[534949622] 'range keys from in-memory index tree' (duration: 399.449707ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:57:46.712384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:57:46.312522Z","time spent":"399.854449ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-11T14:57:46.71247Z","caller":"traceutil/trace.go:171","msg":"trace[404341078] linearizableReadLoop","detail":"{readStateIndex:1959; appliedIndex:1958; }","duration":"376.58157ms","start":"2026-08-11T14:57:46.33587Z","end":"2026-08-11T14:57:46.712451Z","steps":["trace[404341078] 'read index received' (duration: 355.869163ms)","trace[404341078] 'applied index is now lower than readState.Index' (duration: 20.711707ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T14:57:46.712477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.802605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-11T14:57:46.712552Z","caller":"traceutil/trace.go:171","msg":"trace[1341564029] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1886; }","duration":"386.930968ms","start":"2026-08-11T14:57:46.325602Z","end":"2026-08-11T14:57:46.712533Z","steps":["trace[1341564029] 'range keys from in-memory index tree' (duration: 386.62547ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:57:46.712589Z","caller":"traceutil/trace.go:171","msg":"trace[828410513] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"386.108065ms","start":"2026-08-11T14:57:46.326472Z","end":"2026-08-11T14:57:46.71258Z","steps":["trace[828410513] 'process raft request' (duration: 365.09748ms)","trace[828410513] 'compare' (duration: 20.480431ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T14:57:46.712591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:57:46.325578Z","time spent":"387.004879ms","remote":"127.0.0.1:42566","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":"warn","ts":"2026-08-11T14:57:46.712678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:57:46.326456Z","time spent":"386.155096ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T14:57:46.712757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.895268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-11T14:57:46.712785Z","caller":"traceutil/trace.go:171","msg":"trace[471834987] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1887; }","duration":"376.96355ms","start":"2026-08-11T14:57:46.335815Z","end":"2026-08-11T14:57:46.712778Z","steps":["trace[471834987] 'agreement among raft nodes before linearized reading' (duration: 376.889008ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:57:46.712804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:57:46.335775Z","time spent":"377.023882ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-11T14:57:46.72924Z","caller":"traceutil/trace.go:171","msg":"trace[1492536902] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"275.493334ms","start":"2026-08-11T14:57:46.453709Z","end":"2026-08-11T14:57:46.729202Z","steps":["trace[1492536902] 'process raft request' (duration: 275.33907ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:57:46.734278Z","caller":"traceutil/trace.go:171","msg":"trace[1642040576] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"110.524399ms","start":"2026-08-11T14:57:46.623719Z","end":"2026-08-11T14:57:46.734244Z","steps":["trace[1642040576] 'process raft request' (duration: 110.377655ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:57:46.734724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.642836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-11T14:57:46.734824Z","caller":"traceutil/trace.go:171","msg":"trace[675230715] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1890; }","duration":"397.772789ms","start":"2026-08-11T14:57:46.337034Z","end":"2026-08-11T14:57:46.734807Z","steps":["trace[675230715] 'agreement among raft nodes before linearized reading' (duration: 397.332047ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:57:46.734878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:57:46.337026Z","time spent":"397.841841ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-11T14:58:25.00185Z","caller":"traceutil/trace.go:171","msg":"trace[1192941474] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"138.490028ms","start":"2026-08-11T14:58:24.863344Z","end":"2026-08-11T14:58:25.001834Z","steps":["trace[1192941474] 'process raft request' (duration: 138.353335ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:58:25.054241Z","caller":"traceutil/trace.go:171","msg":"trace[1418943221] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"130.849689ms","start":"2026-08-11T14:58:24.923365Z","end":"2026-08-11T14:58:25.054215Z","steps":["trace[1418943221] 'process raft request' (duration: 130.695735ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:58:25.162775Z","caller":"traceutil/trace.go:171","msg":"trace[261250404] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"103.128053ms","start":"2026-08-11T14:58:25.059629Z","end":"2026-08-11T14:58:25.162757Z","steps":["trace[261250404] 'process raft request' (duration: 103.02603ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:58:25.162953Z","caller":"traceutil/trace.go:171","msg":"trace[2094367785] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"103.244897ms","start":"2026-08-11T14:58:25.059699Z","end":"2026-08-11T14:58:25.162944Z","steps":["trace[2094367785] 'process raft request' (duration: 103.029831ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:58:25.163182Z","caller":"traceutil/trace.go:171","msg":"trace[987451102] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"103.378639ms","start":"2026-08-11T14:58:25.059778Z","end":"2026-08-11T14:58:25.163157Z","steps":["trace[987451102] 'process raft request' (duration: 103.104973ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:58:25.163609Z","caller":"traceutil/trace.go:171","msg":"trace[391214967] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"103.719789ms","start":"2026-08-11T14:58:25.059876Z","end":"2026-08-11T14:58:25.163595Z","steps":["trace[391214967] 'process raft request' (duration: 103.238347ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:58:25.442127Z","caller":"traceutil/trace.go:171","msg":"trace[1751675024] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"177.672041ms","start":"2026-08-11T14:58:25.264426Z","end":"2026-08-11T14:58:25.442098Z","steps":["trace[1751675024] 'process raft request' (duration: 124.785581ms)","trace[1751675024] 'compare' (duration: 51.815713ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T14:58:26.832198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.512237ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-11T14:58:27.138949Z","caller":"traceutil/trace.go:171","msg":"trace[1013667269] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"131.783631ms","start":"2026-08-11T14:58:27.007129Z","end":"2026-08-11T14:58:27.138913Z","steps":["trace[1013667269] 'process raft request' (duration: 131.436722ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:58:27.450067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.013749ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T14:58:27.450138Z","caller":"traceutil/trace.go:171","msg":"trace[1698806571] linearizableReadLoop","detail":"{readStateIndex:2239; appliedIndex:2238; }","duration":"283.318028ms","start":"2026-08-11T14:58:27.166808Z","end":"2026-08-11T14:58:27.450126Z","steps":["trace[1698806571] 'read index received' (duration: 71.107544ms)","trace[1698806571] 'applied index is now lower than readState.Index' (duration: 212.209564ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:58:27.450185Z","caller":"traceutil/trace.go:171","msg":"trace[1967190156] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"287.781492ms","start":"2026-08-11T14:58:27.162396Z","end":"2026-08-11T14:58:27.450178Z","steps":["trace[1967190156] 'process raft request' (duration: 75.588289ms)","trace[1967190156] 'compare' (duration: 211.870495ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T14:58:27.450292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.468881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-11T14:58:27.45035Z","caller":"traceutil/trace.go:171","msg":"trace[1395695858] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2158; }","duration":"283.565875ms","start":"2026-08-11T14:58:27.166769Z","end":"2026-08-11T14:58:27.450335Z","steps":["trace[1395695858] 'agreement among raft nodes before linearized reading' (duration: 283.437361ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:58:27.450723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.734398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-11T14:58:27.450752Z","caller":"traceutil/trace.go:171","msg":"trace[217051183] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2159; }","duration":"283.798941ms","start":"2026-08-11T14:58:27.166945Z","end":"2026-08-11T14:58:27.450744Z","steps":["trace[217051183] 'agreement among raft nodes before linearized reading' (duration: 283.659697ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:58:27.450751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.383602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-11T14:58:27.450785Z","caller":"traceutil/trace.go:171","msg":"trace[155848512] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2159; }","duration":"273.444965ms","start":"2026-08-11T14:58:27.17733Z","end":"2026-08-11T14:58:27.450775Z","steps":["trace[155848512] 'agreement among raft nodes before linearized reading' (duration: 273.317692ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:58:27.450835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.646299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-11T14:58:27.450892Z","caller":"traceutil/trace.go:171","msg":"trace[1728461497] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2159; }","duration":"280.758582ms","start":"2026-08-11T14:58:27.17012Z","end":"2026-08-11T14:58:27.450879Z","steps":["trace[1728461497] 'agreement among raft nodes before linearized reading' (duration: 280.572047ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:58:27.450845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.981343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-11T14:58:27.451927Z","caller":"traceutil/trace.go:171","msg":"trace[1351953933] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2159; }","duration":"283.05437ms","start":"2026-08-11T14:58:27.168855Z","end":"2026-08-11T14:58:27.451909Z","steps":["trace[1351953933] 'agreement among raft nodes before linearized reading' (duration: 281.926452ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:58:55.875236Z","caller":"traceutil/trace.go:171","msg":"trace[571613076] transaction","detail":"{read_only:false; response_revision:2321; number_of_response:1; }","duration":"201.054763ms","start":"2026-08-11T14:58:55.674156Z","end":"2026-08-11T14:58:55.875211Z","steps":["trace[571613076] 'process raft request' (duration: 120.501306ms)","trace[571613076] 'compare' (duration: 80.376643ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:58:55.875606Z","caller":"traceutil/trace.go:171","msg":"trace[302048088] transaction","detail":"{read_only:false; response_revision:2322; number_of_response:1; }","duration":"200.706005ms","start":"2026-08-11T14:58:55.674857Z","end":"2026-08-11T14:58:55.875563Z","steps":["trace[302048088] 'process raft request' (duration: 200.307855ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:58:55.875675Z","caller":"traceutil/trace.go:171","msg":"trace[1171328421] transaction","detail":"{read_only:false; response_revision:2323; number_of_response:1; }","duration":"199.746891ms","start":"2026-08-11T14:58:55.675897Z","end":"2026-08-11T14:58:55.875644Z","steps":["trace[1171328421] 'process raft request' (duration: 199.554867ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:58:55.87575Z","caller":"traceutil/trace.go:171","msg":"trace[1782662217] linearizableReadLoop","detail":"{readStateIndex:2410; appliedIndex:2407; }","duration":"186.326018ms","start":"2026-08-11T14:58:55.689414Z","end":"2026-08-11T14:58:55.87574Z","steps":["trace[1782662217] 'read index received' (duration: 105.261439ms)","trace[1782662217] 'applied index is now lower than readState.Index' (duration: 81.063719ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:58:55.875682Z","caller":"traceutil/trace.go:171","msg":"trace[1786482031] transaction","detail":"{read_only:false; response_revision:2324; number_of_response:1; }","duration":"182.248407ms","start":"2026-08-11T14:58:55.693393Z","end":"2026-08-11T14:58:55.875642Z","steps":["trace[1786482031] 'process raft request' (duration: 182.186736ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:58:55.875958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.938672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5428"} {"level":"info","ts":"2026-08-11T14:58:55.876Z","caller":"traceutil/trace.go:171","msg":"trace[1843639279] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2324; }","duration":"193.032585ms","start":"2026-08-11T14:58:55.682954Z","end":"2026-08-11T14:58:55.875987Z","steps":["trace[1843639279] 'agreement among raft nodes before linearized reading' (duration: 192.85921ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:00.081679Z","caller":"traceutil/trace.go:171","msg":"trace[1257929638] linearizableReadLoop","detail":"{readStateIndex:2431; appliedIndex:2429; }","duration":"164.281574ms","start":"2026-08-11T14:58:59.917372Z","end":"2026-08-11T14:59:00.081653Z","steps":["trace[1257929638] 'read index received' (duration: 76.587431ms)","trace[1257929638] 'applied index is now lower than readState.Index' (duration: 87.693223ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:59:00.08183Z","caller":"traceutil/trace.go:171","msg":"trace[340415290] transaction","detail":"{read_only:false; response_revision:2343; number_of_response:1; }","duration":"180.057814ms","start":"2026-08-11T14:58:59.901736Z","end":"2026-08-11T14:59:00.081794Z","steps":["trace[340415290] 'process raft request' (duration: 114.449086ms)","trace[340415290] 'compare' (duration: 65.28047ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T14:59:00.081938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.559221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T14:59:00.08198Z","caller":"traceutil/trace.go:171","msg":"trace[765639975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2343; }","duration":"164.620532ms","start":"2026-08-11T14:58:59.917349Z","end":"2026-08-11T14:59:00.08197Z","steps":["trace[765639975] 'agreement among raft nodes before linearized reading' (duration: 164.443628ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:59:00.082182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.315394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-11T14:59:00.082214Z","caller":"traceutil/trace.go:171","msg":"trace[676547247] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2343; }","duration":"164.367267ms","start":"2026-08-11T14:58:59.917839Z","end":"2026-08-11T14:59:00.082206Z","steps":["trace[676547247] 'agreement among raft nodes before linearized reading' (duration: 164.283975ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:59:00.082343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.512609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5428"} {"level":"info","ts":"2026-08-11T14:59:00.08237Z","caller":"traceutil/trace.go:171","msg":"trace[1792331037] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2343; }","duration":"153.55908ms","start":"2026-08-11T14:58:59.928801Z","end":"2026-08-11T14:59:00.08236Z","steps":["trace[1792331037] 'agreement among raft nodes before linearized reading' (duration: 153.485958ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:02.375607Z","caller":"traceutil/trace.go:171","msg":"trace[1772877610] transaction","detail":"{read_only:false; response_revision:2360; number_of_response:1; }","duration":"126.158236ms","start":"2026-08-11T14:59:02.249425Z","end":"2026-08-11T14:59:02.375584Z","steps":["trace[1772877610] 'process raft request' (duration: 125.989252ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:02.375934Z","caller":"traceutil/trace.go:171","msg":"trace[2005950784] transaction","detail":"{read_only:false; response_revision:2361; number_of_response:1; }","duration":"125.541321ms","start":"2026-08-11T14:59:02.250365Z","end":"2026-08-11T14:59:02.375906Z","steps":["trace[2005950784] 'process raft request' (duration: 125.163462ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:02.376134Z","caller":"traceutil/trace.go:171","msg":"trace[743118586] transaction","detail":"{read_only:false; response_revision:2362; number_of_response:1; }","duration":"125.193503ms","start":"2026-08-11T14:59:02.250914Z","end":"2026-08-11T14:59:02.376107Z","steps":["trace[743118586] 'process raft request' (duration: 124.855224ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:02.376376Z","caller":"traceutil/trace.go:171","msg":"trace[1249103694] transaction","detail":"{read_only:false; response_revision:2363; number_of_response:1; }","duration":"119.288817ms","start":"2026-08-11T14:59:02.257072Z","end":"2026-08-11T14:59:02.376361Z","steps":["trace[1249103694] 'process raft request' (duration: 118.958769ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:04.387514Z","caller":"traceutil/trace.go:171","msg":"trace[937499332] transaction","detail":"{read_only:false; response_revision:2374; number_of_response:1; }","duration":"137.727875ms","start":"2026-08-11T14:59:04.249762Z","end":"2026-08-11T14:59:04.38749Z","steps":["trace[937499332] 'process raft request' (duration: 137.596952ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:04.417148Z","caller":"traceutil/trace.go:171","msg":"trace[663768379] transaction","detail":"{read_only:false; response_revision:2375; number_of_response:1; }","duration":"165.648511ms","start":"2026-08-11T14:59:04.251464Z","end":"2026-08-11T14:59:04.417113Z","steps":["trace[663768379] 'process raft request' (duration: 165.19153ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:04.975217Z","caller":"traceutil/trace.go:171","msg":"trace[1280513408] linearizableReadLoop","detail":"{readStateIndex:2468; appliedIndex:2467; }","duration":"150.379646ms","start":"2026-08-11T14:59:04.824807Z","end":"2026-08-11T14:59:04.975187Z","steps":["trace[1280513408] 'read index received' (duration: 148.302975ms)","trace[1280513408] 'applied index is now lower than readState.Index' (duration: 2.075321ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:59:04.975234Z","caller":"traceutil/trace.go:171","msg":"trace[160975190] transaction","detail":"{read_only:false; response_revision:2379; number_of_response:1; }","duration":"151.887834ms","start":"2026-08-11T14:59:04.823318Z","end":"2026-08-11T14:59:04.975206Z","steps":["trace[160975190] 'process raft request' (duration: 149.937166ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:59:04.975443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.607691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-08-11T14:59:04.975488Z","caller":"traceutil/trace.go:171","msg":"trace[2126489429] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2379; }","duration":"150.725554ms","start":"2026-08-11T14:59:04.824755Z","end":"2026-08-11T14:59:04.975481Z","steps":["trace[2126489429] 'agreement among raft nodes before linearized reading' (duration: 150.528419ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:05.102882Z","caller":"traceutil/trace.go:171","msg":"trace[635234874] linearizableReadLoop","detail":"{readStateIndex:2469; appliedIndex:2468; }","duration":"115.343983ms","start":"2026-08-11T14:59:04.987511Z","end":"2026-08-11T14:59:05.102855Z","steps":["trace[635234874] 'read index received' (duration: 98.050118ms)","trace[635234874] 'applied index is now lower than readState.Index' (duration: 17.292775ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:59:05.103006Z","caller":"traceutil/trace.go:171","msg":"trace[2076553871] transaction","detail":"{read_only:false; response_revision:2380; number_of_response:1; }","duration":"122.96259ms","start":"2026-08-11T14:59:04.980031Z","end":"2026-08-11T14:59:05.102994Z","steps":["trace[2076553871] 'process raft request' (duration: 105.593214ms)","trace[2076553871] 'compare' (duration: 17.073459ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T14:59:05.103261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.741432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-08-11T14:59:05.103293Z","caller":"traceutil/trace.go:171","msg":"trace[959015037] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2380; }","duration":"115.787964ms","start":"2026-08-11T14:59:04.987495Z","end":"2026-08-11T14:59:05.103283Z","steps":["trace[959015037] 'agreement among raft nodes before linearized reading' (duration: 115.612949ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:05.623402Z","caller":"traceutil/trace.go:171","msg":"trace[573560134] transaction","detail":"{read_only:false; response_revision:2384; number_of_response:1; }","duration":"175.325736ms","start":"2026-08-11T14:59:05.448055Z","end":"2026-08-11T14:59:05.623381Z","steps":["trace[573560134] 'process raft request' (duration: 175.168642ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:06.243638Z","caller":"traceutil/trace.go:171","msg":"trace[868722030] transaction","detail":"{read_only:false; response_revision:2389; number_of_response:1; }","duration":"105.98749ms","start":"2026-08-11T14:59:06.137618Z","end":"2026-08-11T14:59:06.243606Z","steps":["trace[868722030] 'process raft request' (duration: 105.828987ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:06.356433Z","caller":"traceutil/trace.go:171","msg":"trace[1512429945] transaction","detail":"{read_only:false; response_revision:2390; number_of_response:1; }","duration":"107.349494ms","start":"2026-08-11T14:59:06.249054Z","end":"2026-08-11T14:59:06.356403Z","steps":["trace[1512429945] 'process raft request' (duration: 42.222355ms)","trace[1512429945] 'compare' (duration: 64.992986ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:59:07.339947Z","caller":"traceutil/trace.go:171","msg":"trace[1708239899] transaction","detail":"{read_only:false; response_revision:2393; number_of_response:1; }","duration":"103.242191ms","start":"2026-08-11T14:59:07.236652Z","end":"2026-08-11T14:59:07.339895Z","steps":["trace[1708239899] 'process raft request' (duration: 102.798221ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:07.51347Z","caller":"traceutil/trace.go:171","msg":"trace[501283514] transaction","detail":"{read_only:false; response_revision:2396; number_of_response:1; }","duration":"110.862379ms","start":"2026-08-11T14:59:07.402585Z","end":"2026-08-11T14:59:07.513448Z","steps":["trace[501283514] 'process raft request' (duration: 110.800697ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:07.513528Z","caller":"traceutil/trace.go:171","msg":"trace[111947863] transaction","detail":"{read_only:false; response_revision:2395; number_of_response:1; }","duration":"128.686876ms","start":"2026-08-11T14:59:07.38481Z","end":"2026-08-11T14:59:07.513496Z","steps":["trace[111947863] 'process raft request' (duration: 107.295851ms)","trace[111947863] 'compare' (duration: 21.117397ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:59:07.739629Z","caller":"traceutil/trace.go:171","msg":"trace[1654983988] transaction","detail":"{read_only:false; response_revision:2399; number_of_response:1; }","duration":"111.302468ms","start":"2026-08-11T14:59:07.628293Z","end":"2026-08-11T14:59:07.739595Z","steps":["trace[1654983988] 'process raft request' (duration: 111.122995ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:07.799847Z","caller":"traceutil/trace.go:171","msg":"trace[1497472127] transaction","detail":"{read_only:false; response_revision:2400; number_of_response:1; }","duration":"112.395295ms","start":"2026-08-11T14:59:07.687421Z","end":"2026-08-11T14:59:07.799816Z","steps":["trace[1497472127] 'process raft request' (duration: 112.106838ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:07.969305Z","caller":"traceutil/trace.go:171","msg":"trace[645761973] transaction","detail":"{read_only:false; response_revision:2404; number_of_response:1; }","duration":"162.744429ms","start":"2026-08-11T14:59:07.80653Z","end":"2026-08-11T14:59:07.969275Z","steps":["trace[645761973] 'process raft request' (duration: 81.858776ms)","trace[645761973] 'compare' (duration: 80.73474ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:59:08.009408Z","caller":"traceutil/trace.go:171","msg":"trace[429526456] transaction","detail":"{read_only:false; response_revision:2405; number_of_response:1; }","duration":"201.483319ms","start":"2026-08-11T14:59:07.80789Z","end":"2026-08-11T14:59:08.009373Z","steps":["trace[429526456] 'process raft request' (duration: 201.260244ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:08.009462Z","caller":"traceutil/trace.go:171","msg":"trace[59430572] transaction","detail":"{read_only:false; response_revision:2406; number_of_response:1; }","duration":"169.461744ms","start":"2026-08-11T14:59:07.839983Z","end":"2026-08-11T14:59:08.009445Z","steps":["trace[59430572] 'process raft request' (duration: 169.317661ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:59:08.009873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.038556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-11T14:59:08.009915Z","caller":"traceutil/trace.go:171","msg":"trace[1970207380] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2406; }","duration":"112.127819ms","start":"2026-08-11T14:59:07.897777Z","end":"2026-08-11T14:59:08.009904Z","steps":["trace[1970207380] 'agreement among raft nodes before linearized reading' (duration: 111.980346ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:08.009372Z","caller":"traceutil/trace.go:171","msg":"trace[110230405] linearizableReadLoop","detail":"{readStateIndex:2497; appliedIndex:2495; }","duration":"111.521224ms","start":"2026-08-11T14:59:07.897828Z","end":"2026-08-11T14:59:08.009349Z","steps":["trace[110230405] 'read index received' (duration: 111.281348ms)","trace[110230405] 'applied index is now lower than readState.Index' (duration: 238.816µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:59:08.275318Z","caller":"traceutil/trace.go:171","msg":"trace[2116870154] transaction","detail":"{read_only:false; response_revision:2413; number_of_response:1; }","duration":"143.983598ms","start":"2026-08-11T14:59:08.131303Z","end":"2026-08-11T14:59:08.275286Z","steps":["trace[2116870154] 'process raft request' (duration: 126.474868ms)","trace[2116870154] 'compare' (duration: 17.258683ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:59:08.275573Z","caller":"traceutil/trace.go:171","msg":"trace[2120426988] transaction","detail":"{read_only:false; response_revision:2414; number_of_response:1; }","duration":"141.533497ms","start":"2026-08-11T14:59:08.134019Z","end":"2026-08-11T14:59:08.275553Z","steps":["trace[2120426988] 'process raft request' (duration: 141.186708ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:08.275893Z","caller":"traceutil/trace.go:171","msg":"trace[918471854] transaction","detail":"{read_only:false; response_revision:2415; number_of_response:1; }","duration":"139.901887ms","start":"2026-08-11T14:59:08.135968Z","end":"2026-08-11T14:59:08.275869Z","steps":["trace[918471854] 'process raft request' (duration: 139.478106ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:59:08.667364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.39929ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T14:59:08.667622Z","caller":"traceutil/trace.go:171","msg":"trace[1587478878] transaction","detail":"{read_only:false; response_revision:2417; number_of_response:1; }","duration":"383.171876ms","start":"2026-08-11T14:59:08.284425Z","end":"2026-08-11T14:59:08.667597Z","steps":["trace[1587478878] 'process raft request' (duration: 253.466689ms)","trace[1587478878] 'compare' (duration: 129.02675ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:59:08.667736Z","caller":"traceutil/trace.go:171","msg":"trace[1895696041] transaction","detail":"{read_only:false; response_revision:2418; number_of_response:1; }","duration":"381.596918ms","start":"2026-08-11T14:59:08.286123Z","end":"2026-08-11T14:59:08.66772Z","steps":["trace[1895696041] 'process raft request' (duration: 381.406063ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:59:08.66786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:59:08.286115Z","time spent":"381.708401ms","remote":"127.0.0.1:42764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6815,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T14:59:08.667919Z","caller":"traceutil/trace.go:171","msg":"trace[971323310] transaction","detail":"{read_only:false; response_revision:2419; number_of_response:1; }","duration":"376.716348ms","start":"2026-08-11T14:59:08.291182Z","end":"2026-08-11T14:59:08.667898Z","steps":["trace[971323310] 'process raft request' (duration: 376.452812ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:08.667954Z","caller":"traceutil/trace.go:171","msg":"trace[282663504] transaction","detail":"{read_only:false; response_revision:2420; number_of_response:1; }","duration":"236.804391ms","start":"2026-08-11T14:59:08.431141Z","end":"2026-08-11T14:59:08.667945Z","steps":["trace[282663504] 'process raft request' (duration: 236.696558ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:08.667897Z","caller":"traceutil/trace.go:171","msg":"trace[1085501756] linearizableReadLoop","detail":"{readStateIndex:2510; appliedIndex:2507; }","duration":"300.125122ms","start":"2026-08-11T14:59:08.367761Z","end":"2026-08-11T14:59:08.667886Z","steps":["trace[1085501756] 'read index received' (duration: 170.142868ms)","trace[1085501756] 'applied index is now lower than readState.Index' (duration: 129.981584ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T14:59:08.668019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:59:08.291173Z","time spent":"376.79697ms","remote":"127.0.0.1:42480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7651,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T14:59:08.668105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.355117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-11T14:59:08.668137Z","caller":"traceutil/trace.go:171","msg":"trace[15492380] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2420; }","duration":"300.436239ms","start":"2026-08-11T14:59:08.367693Z","end":"2026-08-11T14:59:08.66813Z","steps":["trace[15492380] 'agreement among raft nodes before linearized reading' (duration: 300.228794ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:59:08.668164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:59:08.367657Z","time spent":"300.500761ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-11T14:59:08.668345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.788566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/memcached-memcached\" ","response":"range_response_count:1 size:543"} {"level":"warn","ts":"2026-08-11T14:59:08.667733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:59:08.284407Z","time spent":"383.263489ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T14:59:08.668336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.043465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-11T14:59:08.66843Z","caller":"traceutil/trace.go:171","msg":"trace[1579133849] range","detail":"{range_begin:/registry/serviceaccounts/openstack/memcached-memcached; range_end:; response_count:1; response_revision:2420; }","duration":"204.9086ms","start":"2026-08-11T14:59:08.4635Z","end":"2026-08-11T14:59:08.668408Z","steps":["trace[1579133849] 'agreement among raft nodes before linearized reading' (duration: 204.654384ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:08.668474Z","caller":"traceutil/trace.go:171","msg":"trace[2093611859] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2420; }","duration":"221.227509ms","start":"2026-08-11T14:59:08.447232Z","end":"2026-08-11T14:59:08.668459Z","steps":["trace[2093611859] 'agreement among raft nodes before linearized reading' (duration: 220.928672ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:08.823524Z","caller":"traceutil/trace.go:171","msg":"trace[1385710057] transaction","detail":"{read_only:false; response_revision:2423; number_of_response:1; }","duration":"144.793576ms","start":"2026-08-11T14:59:08.678708Z","end":"2026-08-11T14:59:08.823502Z","steps":["trace[1385710057] 'process raft request' (duration: 144.690624ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:08.823602Z","caller":"traceutil/trace.go:171","msg":"trace[700291743] transaction","detail":"{read_only:false; response_revision:2422; number_of_response:1; }","duration":"144.873849ms","start":"2026-08-11T14:59:08.678708Z","end":"2026-08-11T14:59:08.823582Z","steps":["trace[700291743] 'process raft request' (duration: 123.345891ms)","trace[700291743] 'compare' (duration: 21.21202ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:59:09.124593Z","caller":"traceutil/trace.go:171","msg":"trace[1510103509] transaction","detail":"{read_only:false; response_revision:2424; number_of_response:1; }","duration":"113.57665ms","start":"2026-08-11T14:59:09.010979Z","end":"2026-08-11T14:59:09.124555Z","steps":["trace[1510103509] 'process raft request' (duration: 113.118838ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:59:09.35988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.204216ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-11T14:59:09.360114Z","caller":"traceutil/trace.go:171","msg":"trace[311578316] transaction","detail":"{read_only:false; response_revision:2427; number_of_response:1; }","duration":"159.853943ms","start":"2026-08-11T14:59:09.20024Z","end":"2026-08-11T14:59:09.360093Z","steps":["trace[311578316] 'process raft request' (duration: 159.767881ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:09.360202Z","caller":"traceutil/trace.go:171","msg":"trace[1078366714] linearizableReadLoop","detail":"{readStateIndex:2517; appliedIndex:2516; }","duration":"160.249712ms","start":"2026-08-11T14:59:09.199911Z","end":"2026-08-11T14:59:09.36016Z","steps":["trace[1078366714] 'read index received' (duration: 45.672728ms)","trace[1078366714] 'applied index is now lower than readState.Index' (duration: 114.574424ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:59:09.360391Z","caller":"traceutil/trace.go:171","msg":"trace[2073307365] transaction","detail":"{read_only:false; response_revision:2426; number_of_response:1; }","duration":"160.98126ms","start":"2026-08-11T14:59:09.199386Z","end":"2026-08-11T14:59:09.360367Z","steps":["trace[2073307365] 'process raft request' (duration: 46.18718ms)","trace[2073307365] 'compare' (duration: 113.881208ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T14:59:09.360443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.512169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:8574"} {"level":"info","ts":"2026-08-11T14:59:09.360479Z","caller":"traceutil/trace.go:171","msg":"trace[1787245134] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:2427; }","duration":"160.600601ms","start":"2026-08-11T14:59:09.199868Z","end":"2026-08-11T14:59:09.360468Z","steps":["trace[1787245134] 'agreement among raft nodes before linearized reading' (duration: 160.393816ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:09.424994Z","caller":"traceutil/trace.go:171","msg":"trace[858299872] transaction","detail":"{read_only:false; response_revision:2428; number_of_response:1; }","duration":"145.979243ms","start":"2026-08-11T14:59:09.27899Z","end":"2026-08-11T14:59:09.42497Z","steps":["trace[858299872] 'process raft request' (duration: 145.85624ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:59:09.595105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.210933ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T14:59:09.595319Z","caller":"traceutil/trace.go:171","msg":"trace[906864778] transaction","detail":"{read_only:false; response_revision:2430; number_of_response:1; }","duration":"160.069179ms","start":"2026-08-11T14:59:09.435232Z","end":"2026-08-11T14:59:09.595301Z","steps":["trace[906864778] 'process raft request' (duration: 159.989097ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:09.595398Z","caller":"traceutil/trace.go:171","msg":"trace[1891645287] linearizableReadLoop","detail":"{readStateIndex:2520; appliedIndex:2518; }","duration":"180.580819ms","start":"2026-08-11T14:59:09.414796Z","end":"2026-08-11T14:59:09.595377Z","steps":["trace[1891645287] 'read index received' (duration: 10.111017ms)","trace[1891645287] 'applied index is now lower than readState.Index' (duration: 170.468502ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:59:09.595478Z","caller":"traceutil/trace.go:171","msg":"trace[675722974] transaction","detail":"{read_only:false; response_revision:2429; number_of_response:1; }","duration":"185.391607ms","start":"2026-08-11T14:59:09.410071Z","end":"2026-08-11T14:59:09.595463Z","steps":["trace[675722974] 'process raft request' (duration: 66.722733ms)","trace[675722974] 'compare' (duration: 118.0719ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T14:59:09.595505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.691622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T14:59:09.595529Z","caller":"traceutil/trace.go:171","msg":"trace[2106343316] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2430; }","duration":"180.754184ms","start":"2026-08-11T14:59:09.414768Z","end":"2026-08-11T14:59:09.595522Z","steps":["trace[2106343316] 'agreement among raft nodes before linearized reading' (duration: 180.680382ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:09.63525Z","caller":"traceutil/trace.go:171","msg":"trace[1508263257] transaction","detail":"{read_only:false; response_revision:2431; number_of_response:1; }","duration":"115.071546ms","start":"2026-08-11T14:59:09.520151Z","end":"2026-08-11T14:59:09.635222Z","steps":["trace[1508263257] 'process raft request' (duration: 114.848421ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:11.457275Z","caller":"traceutil/trace.go:171","msg":"trace[1035785416] transaction","detail":"{read_only:false; response_revision:2441; number_of_response:1; }","duration":"132.176601ms","start":"2026-08-11T14:59:11.325068Z","end":"2026-08-11T14:59:11.457245Z","steps":["trace[1035785416] 'process raft request' (duration: 70.146215ms)","trace[1035785416] 'compare' (duration: 61.889992ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:59:11.94298Z","caller":"traceutil/trace.go:171","msg":"trace[559723892] transaction","detail":"{read_only:false; response_revision:2443; number_of_response:1; }","duration":"139.715715ms","start":"2026-08-11T14:59:11.803221Z","end":"2026-08-11T14:59:11.942936Z","steps":["trace[559723892] 'process raft request' (duration: 139.467848ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:12.293821Z","caller":"traceutil/trace.go:171","msg":"trace[1464293939] transaction","detail":"{read_only:false; response_revision:2446; number_of_response:1; }","duration":"115.02678ms","start":"2026-08-11T14:59:12.178763Z","end":"2026-08-11T14:59:12.29379Z","steps":["trace[1464293939] 'process raft request' (duration: 60.55475ms)","trace[1464293939] 'compare' (duration: 54.316906ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:59:13.328117Z","caller":"traceutil/trace.go:171","msg":"trace[125795705] transaction","detail":"{read_only:false; response_revision:2456; number_of_response:1; }","duration":"221.7195ms","start":"2026-08-11T14:59:13.10638Z","end":"2026-08-11T14:59:13.328099Z","steps":["trace[125795705] 'process raft request' (duration: 221.394812ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:13.32815Z","caller":"traceutil/trace.go:171","msg":"trace[807735912] transaction","detail":"{read_only:false; response_revision:2458; number_of_response:1; }","duration":"220.566052ms","start":"2026-08-11T14:59:13.10756Z","end":"2026-08-11T14:59:13.328126Z","steps":["trace[807735912] 'process raft request' (duration: 220.50924ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:13.328202Z","caller":"traceutil/trace.go:171","msg":"trace[315549067] transaction","detail":"{read_only:false; response_revision:2457; number_of_response:1; }","duration":"221.448803ms","start":"2026-08-11T14:59:13.106737Z","end":"2026-08-11T14:59:13.328186Z","steps":["trace[315549067] 'process raft request' (duration: 221.211188ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:19.097414Z","caller":"traceutil/trace.go:171","msg":"trace[611496335] linearizableReadLoop","detail":"{readStateIndex:2629; appliedIndex:2628; }","duration":"201.497537ms","start":"2026-08-11T14:59:18.895892Z","end":"2026-08-11T14:59:19.097389Z","steps":["trace[611496335] 'read index received' (duration: 200.544284ms)","trace[611496335] 'applied index is now lower than readState.Index' (duration: 952.032µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:59:19.097447Z","caller":"traceutil/trace.go:171","msg":"trace[250261616] transaction","detail":"{read_only:false; response_revision:2536; number_of_response:1; }","duration":"203.901175ms","start":"2026-08-11T14:59:18.89352Z","end":"2026-08-11T14:59:19.097421Z","steps":["trace[250261616] 'process raft request' (duration: 202.915212ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:59:19.097675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.766323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T14:59:19.097765Z","caller":"traceutil/trace.go:171","msg":"trace[1145973610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2536; }","duration":"201.886215ms","start":"2026-08-11T14:59:18.895868Z","end":"2026-08-11T14:59:19.097754Z","steps":["trace[1145973610] 'agreement among raft nodes before linearized reading' (duration: 201.64327ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:19.666093Z","caller":"traceutil/trace.go:171","msg":"trace[1141026387] transaction","detail":"{read_only:false; response_revision:2544; number_of_response:1; }","duration":"272.443189ms","start":"2026-08-11T14:59:19.393632Z","end":"2026-08-11T14:59:19.666075Z","steps":["trace[1141026387] 'process raft request' (duration: 272.342647ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:59:55.417505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.833294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T14:59:55.417574Z","caller":"traceutil/trace.go:171","msg":"trace[1744625920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2741; }","duration":"153.033031ms","start":"2026-08-11T14:59:55.264527Z","end":"2026-08-11T14:59:55.41756Z","steps":["trace[1744625920] 'range keys from in-memory index tree' (duration: 152.736411ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:59:55.417894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.141734ms","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-08-11T14:59:55.417961Z","caller":"traceutil/trace.go:171","msg":"trace[1189419115] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2741; }","duration":"104.244308ms","start":"2026-08-11T14:59:55.313706Z","end":"2026-08-11T14:59:55.41795Z","steps":["trace[1189419115] 'range keys from in-memory index tree' (duration: 103.869915ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:55.658892Z","caller":"traceutil/trace.go:171","msg":"trace[727390923] linearizableReadLoop","detail":"{readStateIndex:2843; appliedIndex:2842; }","duration":"238.48549ms","start":"2026-08-11T14:59:55.42038Z","end":"2026-08-11T14:59:55.658866Z","steps":["trace[727390923] 'read index received' (duration: 238.343576ms)","trace[727390923] 'applied index is now lower than readState.Index' (duration: 140.614µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T14:59:55.65924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.718988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-08-11T14:59:55.659338Z","caller":"traceutil/trace.go:171","msg":"trace[614500618] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2742; }","duration":"238.959937ms","start":"2026-08-11T14:59:55.420361Z","end":"2026-08-11T14:59:55.659321Z","steps":["trace[614500618] 'agreement among raft nodes before linearized reading' (duration: 238.611915ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:55.659636Z","caller":"traceutil/trace.go:171","msg":"trace[1229948340] transaction","detail":"{read_only:false; response_revision:2742; number_of_response:1; }","duration":"239.428853ms","start":"2026-08-11T14:59:55.420189Z","end":"2026-08-11T14:59:55.659618Z","steps":["trace[1229948340] 'process raft request' (duration: 238.506851ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T14:59:55.796944Z","caller":"traceutil/trace.go:171","msg":"trace[799072508] linearizableReadLoop","detail":"{readStateIndex:2844; appliedIndex:2843; }","duration":"137.946661ms","start":"2026-08-11T14:59:55.658972Z","end":"2026-08-11T14:59:55.796918Z","steps":["trace[799072508] 'read index received' (duration: 137.831907ms)","trace[799072508] 'applied index is now lower than readState.Index' (duration: 108.714µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T14:59:55.796985Z","caller":"traceutil/trace.go:171","msg":"trace[1028409310] transaction","detail":"{read_only:false; response_revision:2743; number_of_response:1; }","duration":"189.058284ms","start":"2026-08-11T14:59:55.607907Z","end":"2026-08-11T14:59:55.796966Z","steps":["trace[1028409310] 'process raft request' (duration: 188.866359ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:59:55.797386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.594504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9371"} {"level":"info","ts":"2026-08-11T14:59:55.797473Z","caller":"traceutil/trace.go:171","msg":"trace[361474094] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:2743; }","duration":"136.697968ms","start":"2026-08-11T14:59:55.660763Z","end":"2026-08-11T14:59:55.797461Z","steps":["trace[361474094] 'agreement among raft nodes before linearized reading' (duration: 136.387277ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:59:55.797364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.715831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1443"} {"level":"info","ts":"2026-08-11T14:59:55.797682Z","caller":"traceutil/trace.go:171","msg":"trace[311720974] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:2743; }","duration":"377.024831ms","start":"2026-08-11T14:59:55.420595Z","end":"2026-08-11T14:59:55.79762Z","steps":["trace[311720974] 'agreement among raft nodes before linearized reading' (duration: 376.436911ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T14:59:55.79784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T14:59:55.42059Z","time spent":"377.188387ms","remote":"127.0.0.1:42486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":1466,"request content":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" "} {"level":"warn","ts":"2026-08-11T15:00:26.542032Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9679537357942064750,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T15:00:27.042375Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9679537357942064750,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T15:00:27.43938Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.442078374s","expected-duration":"1s"} {"level":"info","ts":"2026-08-11T15:00:27.439778Z","caller":"traceutil/trace.go:171","msg":"trace[1256641793] transaction","detail":"{read_only:false; response_revision:2901; number_of_response:1; }","duration":"1.442617333s","start":"2026-08-11T15:00:25.997124Z","end":"2026-08-11T15:00:27.439742Z","steps":["trace[1256641793] 'process raft request' (duration: 1.442439707s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:00:27.439924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:00:25.997094Z","time spent":"1.442760677s","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T15:00:27.442198Z","caller":"traceutil/trace.go:171","msg":"trace[1056488289] transaction","detail":"{read_only:false; response_revision:2904; number_of_response:1; }","duration":"1.063389781s","start":"2026-08-11T15:00:26.378795Z","end":"2026-08-11T15:00:27.442185Z","steps":["trace[1056488289] 'process raft request' (duration: 1.063009649s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:00:27.442317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:00:26.378772Z","time spent":"1.063500434s","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T15:00:27.442206Z","caller":"traceutil/trace.go:171","msg":"trace[1897812795] transaction","detail":"{read_only:false; response_revision:2903; number_of_response:1; }","duration":"1.236329821s","start":"2026-08-11T15:00:26.205859Z","end":"2026-08-11T15:00:27.442189Z","steps":["trace[1897812795] 'process raft request' (duration: 1.235886017s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:00:27.442515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:00:26.205823Z","time spent":"1.236591049s","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T15:00:27.442191Z","caller":"traceutil/trace.go:171","msg":"trace[1514866991] transaction","detail":"{read_only:false; response_revision:2902; number_of_response:1; }","duration":"1.314065729s","start":"2026-08-11T15:00:26.128095Z","end":"2026-08-11T15:00:27.442161Z","steps":["trace[1514866991] 'process raft request' (duration: 1.313477741s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:00:27.442661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:00:26.128071Z","time spent":"1.314552714s","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T15:00:27.45753Z","caller":"traceutil/trace.go:171","msg":"trace[1770729458] linearizableReadLoop","detail":"{readStateIndex:3012; appliedIndex:3007; }","duration":"1.416535677s","start":"2026-08-11T15:00:26.040974Z","end":"2026-08-11T15:00:27.45751Z","steps":["trace[1770729458] 'read index received' (duration: 1.398670059s)","trace[1770729458] 'applied index is now lower than readState.Index' (duration: 17.864488ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:00:27.457658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.416684091s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T15:00:27.457684Z","caller":"traceutil/trace.go:171","msg":"trace[572409252] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2904; }","duration":"1.416822866s","start":"2026-08-11T15:00:26.040851Z","end":"2026-08-11T15:00:27.457674Z","steps":["trace[572409252] 'agreement among raft nodes before linearized reading' (duration: 1.416764423s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:00:27.457718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:00:26.040832Z","time spent":"1.416877386s","remote":"127.0.0.1:42302","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-08-11T15:00:27.457964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156064471s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-08-11T15:00:27.458296Z","caller":"traceutil/trace.go:171","msg":"trace[285631810] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2904; }","duration":"1.156433933s","start":"2026-08-11T15:00:26.30185Z","end":"2026-08-11T15:00:27.458284Z","steps":["trace[285631810] 'agreement among raft nodes before linearized reading' (duration: 1.155985848s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:00:27.4584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:00:26.30183Z","time spent":"1.156558767s","remote":"127.0.0.1:42480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-08-11T15:00:27.458098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"915.024444ms","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-08-11T15:00:27.458624Z","caller":"traceutil/trace.go:171","msg":"trace[626393435] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2904; }","duration":"915.563603ms","start":"2026-08-11T15:00:26.543052Z","end":"2026-08-11T15:00:27.458616Z","steps":["trace[626393435] 'agreement among raft nodes before linearized reading' (duration: 915.006326ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:00:27.458649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:00:26.543043Z","time spent":"915.598824ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-11T15:00:27.458134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.084587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T15:00:27.458723Z","caller":"traceutil/trace.go:171","msg":"trace[358324524] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:2904; }","duration":"827.691458ms","start":"2026-08-11T15:00:26.631026Z","end":"2026-08-11T15:00:27.458717Z","steps":["trace[358324524] 'agreement among raft nodes before linearized reading' (duration: 827.083648ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:00:27.458741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:00:26.631013Z","time spent":"827.722338ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":14,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-08-11T15:00:27.458128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.083432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-11T15:00:27.458825Z","caller":"traceutil/trace.go:171","msg":"trace[629995468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2904; }","duration":"825.801506ms","start":"2026-08-11T15:00:26.633018Z","end":"2026-08-11T15:00:27.458819Z","steps":["trace[629995468] 'agreement among raft nodes before linearized reading' (duration: 825.02089ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:00:27.458846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:00:26.633011Z","time spent":"825.826316ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-11T15:00:27.458188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.272133ms","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-08-11T15:00:27.458953Z","caller":"traceutil/trace.go:171","msg":"trace[1226606827] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2904; }","duration":"145.061889ms","start":"2026-08-11T15:00:27.313886Z","end":"2026-08-11T15:00:27.458947Z","steps":["trace[1226606827] 'agreement among raft nodes before linearized reading' (duration: 144.265333ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:00:27.458177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.163181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T15:00:27.459055Z","caller":"traceutil/trace.go:171","msg":"trace[1666453574] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2904; }","duration":"585.0826ms","start":"2026-08-11T15:00:26.873964Z","end":"2026-08-11T15:00:27.459047Z","steps":["trace[1666453574] 'agreement among raft nodes before linearized reading' (duration: 584.189721ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:00:27.459073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:00:26.87394Z","time spent":"585.126052ms","remote":"127.0.0.1:42520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-08-11T15:00:27.458227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"935.469527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T15:00:27.459172Z","caller":"traceutil/trace.go:171","msg":"trace[1971998009] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:2904; }","duration":"936.447298ms","start":"2026-08-11T15:00:26.522719Z","end":"2026-08-11T15:00:27.459166Z","steps":["trace[1971998009] 'agreement among raft nodes before linearized reading' (duration: 935.483747ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:00:27.459189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:00:26.522702Z","time spent":"936.48151ms","remote":"127.0.0.1:42624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":5,"response size":30,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-08-11T15:02:52.042456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.549656ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T15:02:52.042546Z","caller":"traceutil/trace.go:171","msg":"trace[1396957] transaction","detail":"{read_only:false; response_revision:3810; number_of_response:1; }","duration":"215.965298ms","start":"2026-08-11T15:02:51.826569Z","end":"2026-08-11T15:02:52.042534Z","steps":["trace[1396957] 'process raft request' (duration: 69.279249ms)","trace[1396957] 'compare' (duration: 146.399551ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:02:52.069822Z","caller":"traceutil/trace.go:171","msg":"trace[433019524] transaction","detail":"{read_only:false; response_revision:3811; number_of_response:1; }","duration":"209.524224ms","start":"2026-08-11T15:02:51.860253Z","end":"2026-08-11T15:02:52.069777Z","steps":["trace[433019524] 'process raft request' (duration: 208.689361ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:02:52.102833Z","caller":"traceutil/trace.go:171","msg":"trace[1283078010] transaction","detail":"{read_only:false; response_revision:3812; number_of_response:1; }","duration":"175.658234ms","start":"2026-08-11T15:02:51.927153Z","end":"2026-08-11T15:02:52.102811Z","steps":["trace[1283078010] 'process raft request' (duration: 175.299894ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:02:52.103182Z","caller":"traceutil/trace.go:171","msg":"trace[705065833] transaction","detail":"{read_only:false; response_revision:3813; number_of_response:1; }","duration":"168.417738ms","start":"2026-08-11T15:02:51.934729Z","end":"2026-08-11T15:02:52.103147Z","steps":["trace[705065833] 'process raft request' (duration: 168.032047ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:02:52.103277Z","caller":"traceutil/trace.go:171","msg":"trace[1623756797] transaction","detail":"{read_only:false; response_revision:3815; number_of_response:1; }","duration":"131.357712ms","start":"2026-08-11T15:02:51.971912Z","end":"2026-08-11T15:02:52.10327Z","steps":["trace[1623756797] 'process raft request' (duration: 131.253289ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:02:52.103334Z","caller":"traceutil/trace.go:171","msg":"trace[574657602] transaction","detail":"{read_only:false; response_revision:3814; number_of_response:1; }","duration":"132.3487ms","start":"2026-08-11T15:02:51.970938Z","end":"2026-08-11T15:02:52.103287Z","steps":["trace[574657602] 'process raft request' (duration: 132.084383ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:02:52.192167Z","caller":"traceutil/trace.go:171","msg":"trace[1218181739] transaction","detail":"{read_only:false; response_revision:3816; number_of_response:1; }","duration":"100.274829ms","start":"2026-08-11T15:02:52.09187Z","end":"2026-08-11T15:02:52.192144Z","steps":["trace[1218181739] 'process raft request' (duration: 87.472101ms)","trace[1218181739] 'compare' (duration: 12.622462ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:03:43.544477Z","caller":"traceutil/trace.go:171","msg":"trace[1454373115] transaction","detail":"{read_only:false; response_revision:4568; number_of_response:1; }","duration":"102.294351ms","start":"2026-08-11T15:03:43.442154Z","end":"2026-08-11T15:03:43.544449Z","steps":["trace[1454373115] 'process raft request' (duration: 98.79334ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:03:45.719575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.013239ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:2161"} {"level":"info","ts":"2026-08-11T15:03:45.719864Z","caller":"traceutil/trace.go:171","msg":"trace[615353027] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4633; }","duration":"179.127387ms","start":"2026-08-11T15:03:45.540685Z","end":"2026-08-11T15:03:45.719813Z","steps":["trace[615353027] 'process raft request' (duration: 65.772509ms)","trace[615353027] 'compare' (duration: 112.858886ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:03:45.719977Z","caller":"traceutil/trace.go:171","msg":"trace[1812135633] transaction","detail":"{read_only:false; response_revision:4635; number_of_response:1; }","duration":"147.438113ms","start":"2026-08-11T15:03:45.57252Z","end":"2026-08-11T15:03:45.719958Z","steps":["trace[1812135633] 'process raft request' (duration: 147.384952ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:03:45.720035Z","caller":"traceutil/trace.go:171","msg":"trace[1024469947] transaction","detail":"{read_only:false; response_revision:4634; number_of_response:1; }","duration":"172.709707ms","start":"2026-08-11T15:03:45.547293Z","end":"2026-08-11T15:03:45.720003Z","steps":["trace[1024469947] 'process raft request' (duration: 172.399679ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:03:45.720187Z","caller":"traceutil/trace.go:171","msg":"trace[1757703288] linearizableReadLoop","detail":"{readStateIndex:4808; appliedIndex:4806; }","duration":"178.546061ms","start":"2026-08-11T15:03:45.541625Z","end":"2026-08-11T15:03:45.720171Z","steps":["trace[1757703288] 'read index received' (duration: 25.794237ms)","trace[1757703288] 'applied index is now lower than readState.Index' (duration: 152.749584ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:03:45.720389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.755108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-08-11T15:03:45.720422Z","caller":"traceutil/trace.go:171","msg":"trace[1183233593] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4635; }","duration":"178.827998ms","start":"2026-08-11T15:03:45.541584Z","end":"2026-08-11T15:03:45.720412Z","steps":["trace[1183233593] 'agreement among raft nodes before linearized reading' (duration: 178.678545ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:03:45.720441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.82356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-6t96d-tls-g7m2d\" ","response":"range_response_count:1 size:2625"} {"level":"info","ts":"2026-08-11T15:03:45.720496Z","caller":"traceutil/trace.go:171","msg":"trace[412345275] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-6t96d-tls-g7m2d; range_end:; response_count:1; response_revision:4635; }","duration":"148.918913ms","start":"2026-08-11T15:03:45.571562Z","end":"2026-08-11T15:03:45.72048Z","steps":["trace[412345275] 'agreement among raft nodes before linearized reading' (duration: 148.723138ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:03:46.906968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.3438ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T15:03:46.907067Z","caller":"traceutil/trace.go:171","msg":"trace[1128272057] linearizableReadLoop","detail":"{readStateIndex:4826; appliedIndex:4825; }","duration":"204.262135ms","start":"2026-08-11T15:03:46.702787Z","end":"2026-08-11T15:03:46.907049Z","steps":["trace[1128272057] 'read index received' (duration: 64.780811ms)","trace[1128272057] 'applied index is now lower than readState.Index' (duration: 139.480244ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:03:46.907151Z","caller":"traceutil/trace.go:171","msg":"trace[705826776] transaction","detail":"{read_only:false; response_revision:4649; number_of_response:1; }","duration":"222.353039ms","start":"2026-08-11T15:03:46.684786Z","end":"2026-08-11T15:03:46.907139Z","steps":["trace[705826776] 'process raft request' (duration: 82.760573ms)","trace[705826776] 'compare' (duration: 139.206707ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:03:46.907284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.49689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-11T15:03:46.907325Z","caller":"traceutil/trace.go:171","msg":"trace[1374744125] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4649; }","duration":"204.558132ms","start":"2026-08-11T15:03:46.702755Z","end":"2026-08-11T15:03:46.907313Z","steps":["trace[1374744125] 'agreement among raft nodes before linearized reading' (duration: 204.414959ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:03:52.806208Z","caller":"traceutil/trace.go:171","msg":"trace[467320621] transaction","detail":"{read_only:false; response_revision:4753; number_of_response:1; }","duration":"284.386408ms","start":"2026-08-11T15:03:52.521793Z","end":"2026-08-11T15:03:52.80618Z","steps":["trace[467320621] 'process raft request' (duration: 221.592783ms)","trace[467320621] 'compare' (duration: 61.928943ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:03:52.987357Z","caller":"traceutil/trace.go:171","msg":"trace[871853969] linearizableReadLoop","detail":"{readStateIndex:4933; appliedIndex:4931; }","duration":"336.578305ms","start":"2026-08-11T15:03:52.650761Z","end":"2026-08-11T15:03:52.987339Z","steps":["trace[871853969] 'read index received' (duration: 92.637656ms)","trace[871853969] 'applied index is now lower than readState.Index' (duration: 243.939889ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:03:52.987675Z","caller":"traceutil/trace.go:171","msg":"trace[205575289] transaction","detail":"{read_only:false; response_revision:4754; number_of_response:1; }","duration":"368.499851ms","start":"2026-08-11T15:03:52.619166Z","end":"2026-08-11T15:03:52.987666Z","steps":["trace[205575289] 'process raft request' (duration: 301.077855ms)","trace[205575289] 'compare' (duration: 67.008915ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:03:52.987805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:03:52.619139Z","time spent":"368.591003ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:03:52.988058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.337737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T15:03:52.98811Z","caller":"traceutil/trace.go:171","msg":"trace[2089131489] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:4754; }","duration":"258.407718ms","start":"2026-08-11T15:03:52.729695Z","end":"2026-08-11T15:03:52.988102Z","steps":["trace[2089131489] 'agreement among raft nodes before linearized reading' (duration: 258.320295ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:03:52.98829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.514239ms","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-08-11T15:03:52.988366Z","caller":"traceutil/trace.go:171","msg":"trace[286732227] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4754; }","duration":"337.625793ms","start":"2026-08-11T15:03:52.650723Z","end":"2026-08-11T15:03:52.988349Z","steps":["trace[286732227] 'agreement among raft nodes before linearized reading' (duration: 337.484888ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:03:52.988405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:03:52.650708Z","time spent":"337.688944ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-11T15:03:52.989159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.553242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-11T15:03:52.989225Z","caller":"traceutil/trace.go:171","msg":"trace[1984734805] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4754; }","duration":"334.637505ms","start":"2026-08-11T15:03:52.654575Z","end":"2026-08-11T15:03:52.989213Z","steps":["trace[1984734805] 'agreement among raft nodes before linearized reading' (duration: 333.099454ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:03:52.989279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:03:52.654569Z","time spent":"334.698916ms","remote":"127.0.0.1:42566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-11T15:03:52.989695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.566717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-08-11T15:03:52.989786Z","caller":"traceutil/trace.go:171","msg":"trace[1086171227] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4754; }","duration":"262.69381ms","start":"2026-08-11T15:03:52.727084Z","end":"2026-08-11T15:03:52.989777Z","steps":["trace[1086171227] 'agreement among raft nodes before linearized reading' (duration: 261.536959ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:03:53.307451Z","caller":"traceutil/trace.go:171","msg":"trace[1172766741] linearizableReadLoop","detail":"{readStateIndex:4940; appliedIndex:4938; }","duration":"215.978263ms","start":"2026-08-11T15:03:53.091448Z","end":"2026-08-11T15:03:53.307426Z","steps":["trace[1172766741] 'read index received' (duration: 33.860516ms)","trace[1172766741] 'applied index is now lower than readState.Index' (duration: 182.116727ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:03:53.30762Z","caller":"traceutil/trace.go:171","msg":"trace[306392687] transaction","detail":"{read_only:false; response_revision:4761; number_of_response:1; }","duration":"216.290283ms","start":"2026-08-11T15:03:53.091276Z","end":"2026-08-11T15:03:53.307566Z","steps":["trace[306392687] 'process raft request' (duration: 172.323851ms)","trace[306392687] 'compare' (duration: 43.719175ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T15:03:53.307874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.396704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T15:03:53.308038Z","caller":"traceutil/trace.go:171","msg":"trace[52250503] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:4761; }","duration":"216.586189ms","start":"2026-08-11T15:03:53.091429Z","end":"2026-08-11T15:03:53.308016Z","steps":["trace[52250503] 'agreement among raft nodes before linearized reading' (duration: 216.314122ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:03:53.531467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.587415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-84b85954f8-kplrf.18cac87ae89fbcb4\" ","response":"range_response_count:1 size:896"} {"level":"info","ts":"2026-08-11T15:03:53.531561Z","caller":"traceutil/trace.go:171","msg":"trace[674666271] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-84b85954f8-kplrf.18cac87ae89fbcb4; range_end:; response_count:1; response_revision:4761; }","duration":"102.75403ms","start":"2026-08-11T15:03:53.428788Z","end":"2026-08-11T15:03:53.531542Z","steps":["trace[674666271] 'range keys from in-memory index tree' (duration: 102.355468ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:04:03.742763Z","caller":"traceutil/trace.go:171","msg":"trace[700694760] linearizableReadLoop","detail":"{readStateIndex:5085; appliedIndex:5084; }","duration":"193.714468ms","start":"2026-08-11T15:04:03.549017Z","end":"2026-08-11T15:04:03.742732Z","steps":["trace[700694760] 'read index received' (duration: 193.515974ms)","trace[700694760] 'applied index is now lower than readState.Index' (duration: 197.274µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:04:03.742833Z","caller":"traceutil/trace.go:171","msg":"trace[1798116158] transaction","detail":"{read_only:false; response_revision:4901; number_of_response:1; }","duration":"197.359564ms","start":"2026-08-11T15:04:03.545435Z","end":"2026-08-11T15:04:03.742794Z","steps":["trace[1798116158] 'process raft request' (duration: 197.150519ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:04:03.743009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.964685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-11T15:04:03.743041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.222433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-08-11T15:04:03.743095Z","caller":"traceutil/trace.go:171","msg":"trace[180736846] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4901; }","duration":"158.280275ms","start":"2026-08-11T15:04:03.584797Z","end":"2026-08-11T15:04:03.743078Z","steps":["trace[180736846] 'agreement among raft nodes before linearized reading' (duration: 158.09642ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:04:03.743084Z","caller":"traceutil/trace.go:171","msg":"trace[886924760] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4901; }","duration":"194.09763ms","start":"2026-08-11T15:04:03.548965Z","end":"2026-08-11T15:04:03.743063Z","steps":["trace[886924760] 'agreement among raft nodes before linearized reading' (duration: 193.874883ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:04:04.088548Z","caller":"traceutil/trace.go:171","msg":"trace[849635859] linearizableReadLoop","detail":"{readStateIndex:5086; appliedIndex:5085; }","duration":"183.069249ms","start":"2026-08-11T15:04:03.905464Z","end":"2026-08-11T15:04:04.088533Z","steps":["trace[849635859] 'read index received' (duration: 183.042569ms)","trace[849635859] 'applied index is now lower than readState.Index' (duration: 26.09µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:04:04.088624Z","caller":"traceutil/trace.go:171","msg":"trace[1397817692] transaction","detail":"{read_only:false; response_revision:4902; number_of_response:1; }","duration":"315.959013ms","start":"2026-08-11T15:04:03.772655Z","end":"2026-08-11T15:04:04.088614Z","steps":["trace[1397817692] 'process raft request' (duration: 315.768528ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:04:04.088692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T15:04:03.77263Z","time spent":"316.009445ms","remote":"127.0.0.1:42478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11858,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T15:04:04.088701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.240676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T15:04:04.088743Z","caller":"traceutil/trace.go:171","msg":"trace[1003179456] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:4902; }","duration":"183.327426ms","start":"2026-08-11T15:04:03.9054Z","end":"2026-08-11T15:04:04.088728Z","steps":["trace[1003179456] 'agreement among raft nodes before linearized reading' (duration: 183.220353ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:04:04.094414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.972344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T15:04:04.094455Z","caller":"traceutil/trace.go:171","msg":"trace[1284153796] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:4903; }","duration":"123.043075ms","start":"2026-08-11T15:04:03.971402Z","end":"2026-08-11T15:04:04.094445Z","steps":["trace[1284153796] 'agreement among raft nodes before linearized reading' (duration: 122.965404ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:04:07.306063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.617405ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T15:04:07.306233Z","caller":"traceutil/trace.go:171","msg":"trace[765340363] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"222.272704ms","start":"2026-08-11T15:04:07.083941Z","end":"2026-08-11T15:04:07.306214Z","steps":["trace[765340363] 'process raft request' (duration: 80.423013ms)","trace[765340363] 'compare' (duration: 141.498972ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:04:07.306452Z","caller":"traceutil/trace.go:171","msg":"trace[611709987] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"221.907693ms","start":"2026-08-11T15:04:07.084525Z","end":"2026-08-11T15:04:07.306433Z","steps":["trace[611709987] 'process raft request' (duration: 221.638727ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:04:07.306828Z","caller":"traceutil/trace.go:171","msg":"trace[1868634295] linearizableReadLoop","detail":"{readStateIndex:5133; appliedIndex:5129; }","duration":"105.884575ms","start":"2026-08-11T15:04:07.200928Z","end":"2026-08-11T15:04:07.306813Z","steps":["trace[1868634295] 'read index received' (duration: 41.97µs)","trace[1868634295] 'applied index is now lower than readState.Index' (duration: 105.841725ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T15:04:07.306859Z","caller":"traceutil/trace.go:171","msg":"trace[304845292] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"219.613424ms","start":"2026-08-11T15:04:07.087229Z","end":"2026-08-11T15:04:07.306842Z","steps":["trace[304845292] 'process raft request' (duration: 219.507202ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T15:04:07.307017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.077661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-08-11T15:04:07.307024Z","caller":"traceutil/trace.go:171","msg":"trace[1796721839] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"221.164855ms","start":"2026-08-11T15:04:07.085845Z","end":"2026-08-11T15:04:07.30701Z","steps":["trace[1796721839] 'process raft request' (duration: 220.527758ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:04:07.307059Z","caller":"traceutil/trace.go:171","msg":"trace[81590489] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4948; }","duration":"106.187284ms","start":"2026-08-11T15:04:07.200862Z","end":"2026-08-11T15:04:07.307049Z","steps":["trace[81590489] 'agreement among raft nodes before linearized reading' (duration: 106.018419ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:05:28.524585Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2911} {"level":"info","ts":"2026-08-11T15:05:28.61939Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2911,"took":"92.980739ms","hash":813882384,"current-db-size-bytes":54829056,"current-db-size":"55 MB","current-db-size-in-use-bytes":29655040,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-11T15:05:28.619801Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":813882384,"revision":2911,"compact-revision":-1} {"level":"info","ts":"2026-08-11T15:07:39.364525Z","caller":"traceutil/trace.go:171","msg":"trace[603216708] transaction","detail":"{read_only:false; response_revision:6515; number_of_response:1; }","duration":"121.491206ms","start":"2026-08-11T15:07:39.243005Z","end":"2026-08-11T15:07:39.364496Z","steps":["trace[603216708] 'process raft request' (duration: 116.350238ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:07:43.404118Z","caller":"traceutil/trace.go:171","msg":"trace[233025623] transaction","detail":"{read_only:false; response_revision:6533; number_of_response:1; }","duration":"151.713459ms","start":"2026-08-11T15:07:43.252377Z","end":"2026-08-11T15:07:43.40409Z","steps":["trace[233025623] 'process raft request' (duration: 151.563965ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:07:43.405729Z","caller":"traceutil/trace.go:171","msg":"trace[1547238069] transaction","detail":"{read_only:false; response_revision:6534; number_of_response:1; }","duration":"116.691037ms","start":"2026-08-11T15:07:43.28901Z","end":"2026-08-11T15:07:43.405701Z","steps":["trace[1547238069] 'process raft request' (duration: 116.510082ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T15:10:28.531844Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5633} {"level":"info","ts":"2026-08-11T15:10:28.610464Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5633,"took":"77.081101ms","hash":980693270,"current-db-size-bytes":54829056,"current-db-size":"55 MB","current-db-size-in-use-bytes":18460672,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-11T15:10:28.610529Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":980693270,"revision":5633,"compact-revision":2911}