{"level":"warn","ts":"2026-10-14T15:45:14.168727Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-14T15:45:14.168847Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.218: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://162.253.55.218:2380","--initial-cluster=instance=https://162.253.55.218:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.218:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.218: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-10-14T15:45:14.168933Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-14T15:45:14.168945Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.218:2380"]} {"level":"info","ts":"2026-10-14T15:45:14.168969Z","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-10-14T15:45:14.169845Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"]} {"level":"info","ts":"2026-10-14T15:45:14.169939Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.218:2380"],"listen-peer-urls":["https://162.253.55.218:2380"],"advertise-client-urls":["https://162.253.55.218:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.218: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-10-14T15:45:14.178728Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.514711ms"} {"level":"info","ts":"2026-10-14T15:45:14.196558Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"bb7d59f4041c8abe","cluster-id":"5330ca29224af3c4"} {"level":"info","ts":"2026-10-14T15:45:14.196692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=()"} {"level":"info","ts":"2026-10-14T15:45:14.196717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became follower at term 0"} {"level":"info","ts":"2026-10-14T15:45:14.196728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft bb7d59f4041c8abe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-14T15:45:14.196749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became follower at term 1"} {"level":"info","ts":"2026-10-14T15:45:14.19679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=(13510053361757227710)"} {"level":"warn","ts":"2026-10-14T15:45:14.209013Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-14T15:45:14.212417Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-14T15:45:14.214873Z","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-10-14T15:45:14.217536Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"bb7d59f4041c8abe","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-14T15:45:14.217803Z","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-10-14T15:45:14.217875Z","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-10-14T15:45:14.217894Z","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-10-14T15:45:14.217861Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"bb7d59f4041c8abe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-14T15:45:14.219021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=(13510053361757227710)"} {"level":"info","ts":"2026-10-14T15:45:14.219198Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5330ca29224af3c4","local-member-id":"bb7d59f4041c8abe","added-peer-id":"bb7d59f4041c8abe","added-peer-peer-urls":["https://162.253.55.218:2380"]} {"level":"info","ts":"2026-10-14T15:45:14.220529Z","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-10-14T15:45:14.220656Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.218:2380"} {"level":"info","ts":"2026-10-14T15:45:14.220694Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.218:2380"} {"level":"info","ts":"2026-10-14T15:45:14.220951Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"bb7d59f4041c8abe","initial-advertise-peer-urls":["https://162.253.55.218:2380"],"listen-peer-urls":["https://162.253.55.218:2380"],"advertise-client-urls":["https://162.253.55.218:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-14T15:45:14.221007Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-14T15:45:14.697902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe is starting a new election at term 1"} {"level":"info","ts":"2026-10-14T15:45:14.698001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became pre-candidate at term 1"} {"level":"info","ts":"2026-10-14T15:45:14.698085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe received MsgPreVoteResp from bb7d59f4041c8abe at term 1"} {"level":"info","ts":"2026-10-14T15:45:14.698113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became candidate at term 2"} {"level":"info","ts":"2026-10-14T15:45:14.698129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe received MsgVoteResp from bb7d59f4041c8abe at term 2"} {"level":"info","ts":"2026-10-14T15:45:14.698179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became leader at term 2"} {"level":"info","ts":"2026-10-14T15:45:14.698223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: bb7d59f4041c8abe elected leader bb7d59f4041c8abe at term 2"} {"level":"info","ts":"2026-10-14T15:45:14.711571Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T15:45:14.712466Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"bb7d59f4041c8abe","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.218:2379]}","request-path":"/0/members/bb7d59f4041c8abe/attributes","cluster-id":"5330ca29224af3c4","publish-timeout":"7s"} {"level":"info","ts":"2026-10-14T15:45:14.712517Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T15:45:14.712561Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T15:45:14.712882Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-14T15:45:14.71291Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-14T15:45:14.71305Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5330ca29224af3c4","local-member-id":"bb7d59f4041c8abe","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T15:45:14.713115Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T15:45:14.713134Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T15:45:14.714632Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.218:2379"} {"level":"info","ts":"2026-10-14T15:45:14.716481Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-14T15:45:38.951703Z","caller":"traceutil/trace.go:171","msg":"trace[2081238852] linearizableReadLoop","detail":"{readStateIndex:445; appliedIndex:444; }","duration":"116.142559ms","start":"2026-10-14T15:45:38.835526Z","end":"2026-10-14T15:45:38.951668Z","steps":["trace[2081238852] 'read index received' (duration: 115.916164ms)","trace[2081238852] 'applied index is now lower than readState.Index' (duration: 224.975µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:45:38.951772Z","caller":"traceutil/trace.go:171","msg":"trace[1912350986] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"192.034342ms","start":"2026-10-14T15:45:38.759687Z","end":"2026-10-14T15:45:38.951722Z","steps":["trace[1912350986] 'process raft request' (duration: 191.766406ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:45:38.951903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.289752ms","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-10-14T15:45:38.952779Z","caller":"traceutil/trace.go:171","msg":"trace[1518693869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:429; }","duration":"117.301197ms","start":"2026-10-14T15:45:38.835459Z","end":"2026-10-14T15:45:38.95276Z","steps":["trace[1518693869] 'agreement among raft nodes before linearized reading' (duration: 116.294213ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:00.194051Z","caller":"traceutil/trace.go:171","msg":"trace[1513832625] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"110.33535ms","start":"2026-10-14T15:46:00.083682Z","end":"2026-10-14T15:46:00.194018Z","steps":["trace[1513832625] 'process raft request' (duration: 102.784205ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:46:03.45147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.782759ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T15:46:03.451633Z","caller":"traceutil/trace.go:171","msg":"trace[996948231] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"632.134477ms","start":"2026-10-14T15:46:02.819476Z","end":"2026-10-14T15:46:03.45161Z","steps":["trace[996948231] 'process raft request' (duration: 382.237682ms)","trace[996948231] 'compare' (duration: 248.121934ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:46:03.451708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:46:02.819447Z","time spent":"632.223469ms","remote":"127.0.0.1:47582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5162,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T15:46:03.45406Z","caller":"traceutil/trace.go:171","msg":"trace[1607145205] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"471.682809ms","start":"2026-10-14T15:46:02.982346Z","end":"2026-10-14T15:46:03.454029Z","steps":["trace[1607145205] 'process raft request' (duration: 471.353871ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:46:03.454149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:46:02.982318Z","time spent":"471.793802ms","remote":"127.0.0.1:47582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T15:46:03.454565Z","caller":"traceutil/trace.go:171","msg":"trace[2014558747] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:661; }","duration":"355.150897ms","start":"2026-10-14T15:46:03.0994Z","end":"2026-10-14T15:46:03.454551Z","steps":["trace[2014558747] 'read index received' (duration: 102.432257ms)","trace[2014558747] 'applied index is now lower than readState.Index' (duration: 252.71738ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:46:03.454622Z","caller":"traceutil/trace.go:171","msg":"trace[1567054868] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"452.506686ms","start":"2026-10-14T15:46:03.002101Z","end":"2026-10-14T15:46:03.454608Z","steps":["trace[1567054868] 'process raft request' (duration: 451.874651ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:03.454639Z","caller":"traceutil/trace.go:171","msg":"trace[944452291] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"271.565925ms","start":"2026-10-14T15:46:03.183064Z","end":"2026-10-14T15:46:03.45463Z","steps":["trace[944452291] 'process raft request' (duration: 271.436262ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:46:03.454686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:46:03.002062Z","time spent":"452.587078ms","remote":"127.0.0.1:47582","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T15:46:03.454956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.527845ms","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-10-14T15:46:03.455086Z","caller":"traceutil/trace.go:171","msg":"trace[1271963724] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:639; }","duration":"355.711509ms","start":"2026-10-14T15:46:03.099342Z","end":"2026-10-14T15:46:03.455053Z","steps":["trace[1271963724] 'agreement among raft nodes before linearized reading' (duration: 355.336961ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:46:03.455171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:46:03.099311Z","time spent":"355.844163ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-14T15:46:03.4895Z","caller":"traceutil/trace.go:171","msg":"trace[1567278729] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"104.780841ms","start":"2026-10-14T15:46:03.384665Z","end":"2026-10-14T15:46:03.489446Z","steps":["trace[1567278729] 'process raft request' (duration: 104.538266ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:46:03.489632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.021484ms","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-10-14T15:46:03.49018Z","caller":"traceutil/trace.go:171","msg":"trace[1247359764] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:641; }","duration":"352.604528ms","start":"2026-10-14T15:46:03.137547Z","end":"2026-10-14T15:46:03.490151Z","steps":["trace[1247359764] 'agreement among raft nodes before linearized reading' (duration: 351.935822ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:46:03.489858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.106399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-10-14T15:46:03.490327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:46:03.137525Z","time spent":"352.739361ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-14T15:46:03.490334Z","caller":"traceutil/trace.go:171","msg":"trace[77171468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:642; }","duration":"150.647701ms","start":"2026-10-14T15:46:03.339663Z","end":"2026-10-14T15:46:03.490311Z","steps":["trace[77171468] 'agreement among raft nodes before linearized reading' (duration: 149.912344ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:46:09.155547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.712412ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-14T15:46:09.155717Z","caller":"traceutil/trace.go:171","msg":"trace[1242541329] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"169.073237ms","start":"2026-10-14T15:46:08.986613Z","end":"2026-10-14T15:46:09.155687Z","steps":["trace[1242541329] 'process raft request' (duration: 41.09736ms)","trace[1242541329] 'compare' (duration: 127.464095ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:46:12.316508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.842878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T15:46:12.316637Z","caller":"traceutil/trace.go:171","msg":"trace[587247399] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:720; }","duration":"110.037932ms","start":"2026-10-14T15:46:12.206574Z","end":"2026-10-14T15:46:12.316611Z","steps":["trace[587247399] 'range keys from in-memory index tree' (duration: 109.732125ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:28.518258Z","caller":"traceutil/trace.go:171","msg":"trace[215774689] linearizableReadLoop","detail":"{readStateIndex:865; appliedIndex:864; }","duration":"226.910593ms","start":"2026-10-14T15:46:28.291293Z","end":"2026-10-14T15:46:28.518204Z","steps":["trace[215774689] 'read index received' (duration: 225.512481ms)","trace[215774689] 'applied index is now lower than readState.Index' (duration: 1.396772ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:46:28.51836Z","caller":"traceutil/trace.go:171","msg":"trace[961583736] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"308.051138ms","start":"2026-10-14T15:46:28.21026Z","end":"2026-10-14T15:46:28.518311Z","steps":["trace[961583736] 'process raft request' (duration: 306.523763ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:46:28.518431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.105908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T15:46:28.518502Z","caller":"traceutil/trace.go:171","msg":"trace[2100470593] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:831; }","duration":"227.20939ms","start":"2026-10-14T15:46:28.291262Z","end":"2026-10-14T15:46:28.518471Z","steps":["trace[2100470593] 'agreement among raft nodes before linearized reading' (duration: 227.105108ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:46:28.518619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:46:28.210202Z","time spent":"308.286733ms","remote":"127.0.0.1:47768","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-10-14T15:46:28.519621Z","caller":"traceutil/trace.go:171","msg":"trace[1359993472] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"228.183863ms","start":"2026-10-14T15:46:28.291409Z","end":"2026-10-14T15:46:28.519593Z","steps":["trace[1359993472] 'process raft request' (duration: 228.003519ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:45.532293Z","caller":"traceutil/trace.go:171","msg":"trace[455370009] transaction","detail":"{read_only:false; response_revision:1112; number_of_response:1; }","duration":"112.645342ms","start":"2026-10-14T15:46:45.41961Z","end":"2026-10-14T15:46:45.532255Z","steps":["trace[455370009] 'process raft request' (duration: 97.39611ms)","trace[455370009] 'compare' (duration: 14.765031ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:46:45.532706Z","caller":"traceutil/trace.go:171","msg":"trace[1193369248] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"112.823846ms","start":"2026-10-14T15:46:45.419862Z","end":"2026-10-14T15:46:45.532686Z","steps":["trace[1193369248] 'process raft request' (duration: 112.287134ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:45.532771Z","caller":"traceutil/trace.go:171","msg":"trace[406047399] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"111.773262ms","start":"2026-10-14T15:46:45.420958Z","end":"2026-10-14T15:46:45.532731Z","steps":["trace[406047399] 'process raft request' (duration: 111.339642ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:45.532858Z","caller":"traceutil/trace.go:171","msg":"trace[1377109274] transaction","detail":"{read_only:false; response_revision:1115; number_of_response:1; }","duration":"110.266668ms","start":"2026-10-14T15:46:45.422535Z","end":"2026-10-14T15:46:45.532801Z","steps":["trace[1377109274] 'process raft request' (duration: 109.828948ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:45.532909Z","caller":"traceutil/trace.go:171","msg":"trace[583692174] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"109.888689ms","start":"2026-10-14T15:46:45.423006Z","end":"2026-10-14T15:46:45.532895Z","steps":["trace[583692174] 'process raft request' (duration: 109.469889ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:45.533291Z","caller":"traceutil/trace.go:171","msg":"trace[912908042] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"109.881219ms","start":"2026-10-14T15:46:45.423386Z","end":"2026-10-14T15:46:45.533267Z","steps":["trace[912908042] 'process raft request' (duration: 109.164972ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:45.533381Z","caller":"traceutil/trace.go:171","msg":"trace[1873177088] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"108.281412ms","start":"2026-10-14T15:46:45.425086Z","end":"2026-10-14T15:46:45.533367Z","steps":["trace[1873177088] 'process raft request' (duration: 108.121868ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:45.533325Z","caller":"traceutil/trace.go:171","msg":"trace[1886403729] linearizableReadLoop","detail":"{readStateIndex:1151; appliedIndex:1148; }","duration":"111.004984ms","start":"2026-10-14T15:46:45.422291Z","end":"2026-10-14T15:46:45.533296Z","steps":["trace[1886403729] 'read index received' (duration: 20.748749ms)","trace[1886403729] 'applied index is now lower than readState.Index' (duration: 90.255315ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:46:45.533684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.364173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/cert-manager/cert-manager-cainjector-64b59ddb75-z7mgk\" ","response":"range_response_count:1 size:2702"} {"level":"info","ts":"2026-10-14T15:46:45.533739Z","caller":"traceutil/trace.go:171","msg":"trace[90102138] range","detail":"{range_begin:/registry/pods/cert-manager/cert-manager-cainjector-64b59ddb75-z7mgk; range_end:; response_count:1; response_revision:1118; }","duration":"111.466195ms","start":"2026-10-14T15:46:45.42225Z","end":"2026-10-14T15:46:45.533716Z","steps":["trace[90102138] 'agreement among raft nodes before linearized reading' (duration: 111.272581ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:47:51.444653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.329998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-10-14T15:47:51.444849Z","caller":"traceutil/trace.go:171","msg":"trace[615588698] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1924; }","duration":"376.596164ms","start":"2026-10-14T15:47:51.068219Z","end":"2026-10-14T15:47:51.444815Z","steps":["trace[615588698] 'range keys from in-memory index tree' (duration: 376.110143ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:47:51.444913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:47:51.06814Z","time spent":"376.755018ms","remote":"127.0.0.1:47458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-10-14T15:47:51.444899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.409683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8c252a42-f689-4335-9424-90cb9f0766ec\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-10-14T15:47:51.444653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.452537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-10-14T15:47:51.444988Z","caller":"traceutil/trace.go:171","msg":"trace[161774736] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8c252a42-f689-4335-9424-90cb9f0766ec; range_end:; response_count:1; response_revision:1924; }","duration":"292.564216ms","start":"2026-10-14T15:47:51.1524Z","end":"2026-10-14T15:47:51.444964Z","steps":["trace[161774736] 'range keys from in-memory index tree' (duration: 292.205788ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:47:51.445111Z","caller":"traceutil/trace.go:171","msg":"trace[1891067168] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1924; }","duration":"355.971019ms","start":"2026-10-14T15:47:51.089104Z","end":"2026-10-14T15:47:51.445075Z","steps":["trace[1891067168] 'range keys from in-memory index tree' (duration: 355.184671ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:47:51.445182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:47:51.089078Z","time spent":"356.06352ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-14T15:47:51.578878Z","caller":"traceutil/trace.go:171","msg":"trace[1358991951] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"129.140628ms","start":"2026-10-14T15:47:51.449706Z","end":"2026-10-14T15:47:51.578847Z","steps":["trace[1358991951] 'process raft request' (duration: 128.956753ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:47:51.66603Z","caller":"traceutil/trace.go:171","msg":"trace[429666775] linearizableReadLoop","detail":"{readStateIndex:2003; appliedIndex:2001; }","duration":"134.88188ms","start":"2026-10-14T15:47:51.531113Z","end":"2026-10-14T15:47:51.665995Z","steps":["trace[429666775] 'read index received' (duration: 47.642608ms)","trace[429666775] 'applied index is now lower than readState.Index' (duration: 87.238262ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:47:51.666138Z","caller":"traceutil/trace.go:171","msg":"trace[986205320] transaction","detail":"{read_only:false; response_revision:1926; number_of_response:1; }","duration":"213.389091ms","start":"2026-10-14T15:47:51.452709Z","end":"2026-10-14T15:47:51.666098Z","steps":["trace[986205320] 'process raft request' (duration: 204.190598ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:47:51.666322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.185858ms","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-10-14T15:47:51.666371Z","caller":"traceutil/trace.go:171","msg":"trace[1907106390] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1926; }","duration":"135.303641ms","start":"2026-10-14T15:47:51.531053Z","end":"2026-10-14T15:47:51.666357Z","steps":["trace[1907106390] 'agreement among raft nodes before linearized reading' (duration: 135.055715ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:47:51.894945Z","caller":"traceutil/trace.go:171","msg":"trace[1184426163] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"211.660761ms","start":"2026-10-14T15:47:51.683244Z","end":"2026-10-14T15:47:51.894904Z","steps":["trace[1184426163] 'process raft request' (duration: 183.89ms)","trace[1184426163] 'compare' (duration: 27.448263ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:47:51.898102Z","caller":"traceutil/trace.go:171","msg":"trace[1739511054] transaction","detail":"{read_only:false; response_revision:1929; number_of_response:1; }","duration":"177.261227ms","start":"2026-10-14T15:47:51.720796Z","end":"2026-10-14T15:47:51.898057Z","steps":["trace[1739511054] 'process raft request' (duration: 176.4831ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:48:30.89202Z","caller":"traceutil/trace.go:171","msg":"trace[144244662] linearizableReadLoop","detail":"{readStateIndex:2277; appliedIndex:2276; }","duration":"248.02243ms","start":"2026-10-14T15:48:30.643969Z","end":"2026-10-14T15:48:30.891991Z","steps":["trace[144244662] 'read index received' (duration: 247.778374ms)","trace[144244662] 'applied index is now lower than readState.Index' (duration: 242.766µs)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:48:30.892359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.364098ms","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-10-14T15:48:30.892442Z","caller":"traceutil/trace.go:171","msg":"trace[1877915782] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2190; }","duration":"248.477541ms","start":"2026-10-14T15:48:30.643948Z","end":"2026-10-14T15:48:30.892426Z","steps":["trace[1877915782] 'agreement among raft nodes before linearized reading' (duration: 248.225055ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:48:30.892446Z","caller":"traceutil/trace.go:171","msg":"trace[860524190] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"312.447617ms","start":"2026-10-14T15:48:30.579954Z","end":"2026-10-14T15:48:30.892402Z","steps":["trace[860524190] 'process raft request' (duration: 311.817812ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:48:30.892817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:48:30.579919Z","time spent":"312.780256ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T15:48:30.900452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.487049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-10-14T15:48:30.900441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.269346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-10-14T15:48:30.900451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.001534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T15:48:30.900503Z","caller":"traceutil/trace.go:171","msg":"trace[1586901987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2191; }","duration":"227.586451ms","start":"2026-10-14T15:48:30.672905Z","end":"2026-10-14T15:48:30.900492Z","steps":["trace[1586901987] 'agreement among raft nodes before linearized reading' (duration: 227.450378ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:48:30.900538Z","caller":"traceutil/trace.go:171","msg":"trace[1460779717] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2191; }","duration":"230.400069ms","start":"2026-10-14T15:48:30.670111Z","end":"2026-10-14T15:48:30.900511Z","steps":["trace[1460779717] 'agreement among raft nodes before linearized reading' (duration: 230.128532ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:48:30.90054Z","caller":"traceutil/trace.go:171","msg":"trace[1261966156] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:2191; }","duration":"226.151577ms","start":"2026-10-14T15:48:30.674369Z","end":"2026-10-14T15:48:30.900521Z","steps":["trace[1261966156] 'agreement among raft nodes before linearized reading' (duration: 225.937272ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:48:30.900454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.060725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-10-14T15:48:30.900682Z","caller":"traceutil/trace.go:171","msg":"trace[308520649] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2191; }","duration":"143.30364ms","start":"2026-10-14T15:48:30.757356Z","end":"2026-10-14T15:48:30.90066Z","steps":["trace[308520649] 'agreement among raft nodes before linearized reading' (duration: 142.908871ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:48:37.019768Z","caller":"traceutil/trace.go:171","msg":"trace[1152039523] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"106.189964ms","start":"2026-10-14T15:48:36.913537Z","end":"2026-10-14T15:48:37.019727Z","steps":["trace[1152039523] 'process raft request' (duration: 105.829445ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:48:37.236797Z","caller":"traceutil/trace.go:171","msg":"trace[536049450] transaction","detail":"{read_only:false; response_revision:2224; number_of_response:1; }","duration":"212.684426ms","start":"2026-10-14T15:48:37.024096Z","end":"2026-10-14T15:48:37.23678Z","steps":["trace[536049450] 'process raft request' (duration: 209.48513ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:48:37.236817Z","caller":"traceutil/trace.go:171","msg":"trace[351824452] transaction","detail":"{read_only:false; response_revision:2226; number_of_response:1; }","duration":"211.733033ms","start":"2026-10-14T15:48:37.025054Z","end":"2026-10-14T15:48:37.236787Z","steps":["trace[351824452] 'process raft request' (duration: 211.378565ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:48:37.2372Z","caller":"traceutil/trace.go:171","msg":"trace[214417369] linearizableReadLoop","detail":"{readStateIndex:2315; appliedIndex:2311; }","duration":"208.302171ms","start":"2026-10-14T15:48:37.028863Z","end":"2026-10-14T15:48:37.237165Z","steps":["trace[214417369] 'read index received' (duration: 204.735586ms)","trace[214417369] 'applied index is now lower than readState.Index' (duration: 3.535485ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:48:37.237324Z","caller":"traceutil/trace.go:171","msg":"trace[91169628] transaction","detail":"{read_only:false; response_revision:2227; number_of_response:1; }","duration":"211.649481ms","start":"2026-10-14T15:48:37.025585Z","end":"2026-10-14T15:48:37.237234Z","steps":["trace[91169628] 'process raft request' (duration: 211.104308ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:48:37.237477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.585428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-10-14T15:48:37.237476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.840363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T15:48:37.237537Z","caller":"traceutil/trace.go:171","msg":"trace[1485021039] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2227; }","duration":"208.690621ms","start":"2026-10-14T15:48:37.02883Z","end":"2026-10-14T15:48:37.237521Z","steps":["trace[1485021039] 'agreement among raft nodes before linearized reading' (duration: 208.509537ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:48:37.237546Z","caller":"traceutil/trace.go:171","msg":"trace[2107611788] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:2227; }","duration":"112.966526ms","start":"2026-10-14T15:48:37.124563Z","end":"2026-10-14T15:48:37.237529Z","steps":["trace[2107611788] 'agreement among raft nodes before linearized reading' (duration: 112.817393ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:48:37.236577Z","caller":"traceutil/trace.go:171","msg":"trace[934196729] transaction","detail":"{read_only:false; response_revision:2225; number_of_response:1; }","duration":"211.778124ms","start":"2026-10-14T15:48:37.02472Z","end":"2026-10-14T15:48:37.236498Z","steps":["trace[934196729] 'process raft request' (duration: 211.649581ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:48:37.364002Z","caller":"traceutil/trace.go:171","msg":"trace[1956322705] transaction","detail":"{read_only:false; response_revision:2228; number_of_response:1; }","duration":"121.269065ms","start":"2026-10-14T15:48:37.242693Z","end":"2026-10-14T15:48:37.363962Z","steps":["trace[1956322705] 'process raft request' (duration: 117.151027ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:49:31.806922Z","caller":"traceutil/trace.go:171","msg":"trace[1485372478] linearizableReadLoop","detail":"{readStateIndex:2794; appliedIndex:2793; }","duration":"218.614888ms","start":"2026-10-14T15:49:31.588275Z","end":"2026-10-14T15:49:31.806889Z","steps":["trace[1485372478] 'read index received' (duration: 161.789544ms)","trace[1485372478] 'applied index is now lower than readState.Index' (duration: 56.824024ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:49:31.807035Z","caller":"traceutil/trace.go:171","msg":"trace[1431433397] transaction","detail":"{read_only:false; response_revision:2687; number_of_response:1; }","duration":"230.969412ms","start":"2026-10-14T15:49:31.576012Z","end":"2026-10-14T15:49:31.806981Z","steps":["trace[1431433397] 'process raft request' (duration: 174.19828ms)","trace[1431433397] 'compare' (duration: 55.745308ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:49:31.807278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.981258ms","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-10-14T15:49:31.807322Z","caller":"traceutil/trace.go:171","msg":"trace[433570047] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2687; }","duration":"219.08466ms","start":"2026-10-14T15:49:31.588227Z","end":"2026-10-14T15:49:31.807312Z","steps":["trace[433570047] 'agreement among raft nodes before linearized reading' (duration: 218.852975ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:49:31.807551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.920613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-10-14T15:49:31.807564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.107657ms","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-10-14T15:49:31.807609Z","caller":"traceutil/trace.go:171","msg":"trace[1258221771] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2687; }","duration":"212.994855ms","start":"2026-10-14T15:49:31.5946Z","end":"2026-10-14T15:49:31.807595Z","steps":["trace[1258221771] 'agreement among raft nodes before linearized reading' (duration: 212.862782ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:49:31.807633Z","caller":"traceutil/trace.go:171","msg":"trace[1715571894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2687; }","duration":"213.247611ms","start":"2026-10-14T15:49:31.594367Z","end":"2026-10-14T15:49:31.807615Z","steps":["trace[1715571894] 'agreement among raft nodes before linearized reading' (duration: 213.011425ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:49:31.807894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.916247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-10-14T15:49:31.808076Z","caller":"traceutil/trace.go:171","msg":"trace[1543789819] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2687; }","duration":"133.446859ms","start":"2026-10-14T15:49:31.674616Z","end":"2026-10-14T15:49:31.808063Z","steps":["trace[1543789819] 'agreement among raft nodes before linearized reading' (duration: 132.861465ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:50:04.788718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.856432ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T15:50:04.788839Z","caller":"traceutil/trace.go:171","msg":"trace[1230221631] transaction","detail":"{read_only:false; response_revision:2890; number_of_response:1; }","duration":"346.344101ms","start":"2026-10-14T15:50:04.442473Z","end":"2026-10-14T15:50:04.788817Z","steps":["trace[1230221631] 'process raft request' (duration: 49.267634ms)","trace[1230221631] 'compare' (duration: 296.450832ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:50:04.788911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:50:04.442444Z","time spent":"346.428613ms","remote":"127.0.0.1:47768","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-10-14T15:50:05.390216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.506886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-10-14T15:50:05.390335Z","caller":"traceutil/trace.go:171","msg":"trace[1180311188] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2890; }","duration":"482.68948ms","start":"2026-10-14T15:50:04.907615Z","end":"2026-10-14T15:50:05.390304Z","steps":["trace[1180311188] 'range keys from in-memory index tree' (duration: 482.318742ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:50:05.390351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.748514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-14T15:50:05.390391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:50:04.907587Z","time spent":"482.788433ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-10-14T15:50:05.390407Z","caller":"traceutil/trace.go:171","msg":"trace[252218518] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:2890; }","duration":"101.940698ms","start":"2026-10-14T15:50:05.288448Z","end":"2026-10-14T15:50:05.390388Z","steps":["trace[252218518] 'count revisions from in-memory index tree' (duration: 101.623411ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:50:05.390571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.255118ms","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-10-14T15:50:05.390716Z","caller":"traceutil/trace.go:171","msg":"trace[346134032] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2890; }","duration":"118.448712ms","start":"2026-10-14T15:50:05.272233Z","end":"2026-10-14T15:50:05.390682Z","steps":["trace[346134032] 'range keys from in-memory index tree' (duration: 117.825947ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:50:05.627005Z","caller":"traceutil/trace.go:171","msg":"trace[1734319618] transaction","detail":"{read_only:false; response_revision:2891; number_of_response:1; }","duration":"233.517804ms","start":"2026-10-14T15:50:05.393452Z","end":"2026-10-14T15:50:05.62697Z","steps":["trace[1734319618] 'process raft request' (duration: 233.303049ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:50:05.812865Z","caller":"traceutil/trace.go:171","msg":"trace[500998728] transaction","detail":"{read_only:false; response_revision:2892; number_of_response:1; }","duration":"416.753339ms","start":"2026-10-14T15:50:05.396083Z","end":"2026-10-14T15:50:05.812836Z","steps":["trace[500998728] 'process raft request' (duration: 368.390857ms)","trace[500998728] 'compare' (duration: 48.129477ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:50:05.81317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:50:05.396063Z","time spent":"416.881462ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T15:50:05.813396Z","caller":"traceutil/trace.go:171","msg":"trace[1211824598] transaction","detail":"{read_only:false; response_revision:2893; number_of_response:1; }","duration":"378.58618ms","start":"2026-10-14T15:50:05.434704Z","end":"2026-10-14T15:50:05.813291Z","steps":["trace[1211824598] 'process raft request' (duration: 378.085958ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:50:05.813437Z","caller":"traceutil/trace.go:171","msg":"trace[920911773] linearizableReadLoop","detail":"{readStateIndex:3006; appliedIndex:3004; }","duration":"416.671127ms","start":"2026-10-14T15:50:05.396746Z","end":"2026-10-14T15:50:05.813417Z","steps":["trace[920911773] 'read index received' (duration: 230.059341ms)","trace[920911773] 'applied index is now lower than readState.Index' (duration: 186.610556ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:50:05.813589Z","caller":"traceutil/trace.go:171","msg":"trace[2062894310] transaction","detail":"{read_only:false; response_revision:2894; number_of_response:1; }","duration":"267.527484ms","start":"2026-10-14T15:50:05.54602Z","end":"2026-10-14T15:50:05.813548Z","steps":["trace[2062894310] 'process raft request' (duration: 267.041033ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:50:05.813667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:50:05.434681Z","time spent":"378.812025ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T15:50:05.813608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.863671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1449"} {"level":"warn","ts":"2026-10-14T15:50:05.813841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.25985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T15:50:05.81382Z","caller":"traceutil/trace.go:171","msg":"trace[1161168494] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:2894; }","duration":"417.058107ms","start":"2026-10-14T15:50:05.39668Z","end":"2026-10-14T15:50:05.813738Z","steps":["trace[1161168494] 'agreement among raft nodes before linearized reading' (duration: 416.78993ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:50:05.813885Z","caller":"traceutil/trace.go:171","msg":"trace[551145582] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:2894; }","duration":"137.349102ms","start":"2026-10-14T15:50:05.676522Z","end":"2026-10-14T15:50:05.813871Z","steps":["trace[551145582] 'agreement among raft nodes before linearized reading' (duration: 137.286931ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:50:05.813892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.465818ms","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-10-14T15:50:05.813977Z","caller":"traceutil/trace.go:171","msg":"trace[1041750002] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2894; }","duration":"360.624162ms","start":"2026-10-14T15:50:05.453325Z","end":"2026-10-14T15:50:05.813949Z","steps":["trace[1041750002] 'agreement among raft nodes before linearized reading' (duration: 360.439248ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:50:05.814058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:50:05.453305Z","time spent":"360.740945ms","remote":"127.0.0.1:36572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-10-14T15:50:05.814002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:50:05.396651Z","time spent":"417.262641ms","remote":"127.0.0.1:47692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":1472,"request content":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" "} {"level":"info","ts":"2026-10-14T15:52:56.33528Z","caller":"traceutil/trace.go:171","msg":"trace[2070756066] linearizableReadLoop","detail":"{readStateIndex:4085; appliedIndex:4084; }","duration":"130.476537ms","start":"2026-10-14T15:52:56.204779Z","end":"2026-10-14T15:52:56.335256Z","steps":["trace[2070756066] 'read index received' (duration: 119.495896ms)","trace[2070756066] 'applied index is now lower than readState.Index' (duration: 10.979131ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:52:56.335291Z","caller":"traceutil/trace.go:171","msg":"trace[280521146] transaction","detail":"{read_only:false; response_revision:3931; number_of_response:1; }","duration":"128.739265ms","start":"2026-10-14T15:52:56.206514Z","end":"2026-10-14T15:52:56.335253Z","steps":["trace[280521146] 'process raft request' (duration: 128.666973ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:52:56.335326Z","caller":"traceutil/trace.go:171","msg":"trace[932263302] transaction","detail":"{read_only:false; response_revision:3930; number_of_response:1; }","duration":"131.830568ms","start":"2026-10-14T15:52:56.203411Z","end":"2026-10-14T15:52:56.335241Z","steps":["trace[932263302] 'process raft request' (duration: 120.878138ms)","trace[932263302] 'compare' (duration: 10.610212ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:52:56.336033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.957628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T15:52:56.336247Z","caller":"traceutil/trace.go:171","msg":"trace[1564323822] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3931; }","duration":"131.46815ms","start":"2026-10-14T15:52:56.204757Z","end":"2026-10-14T15:52:56.336225Z","steps":["trace[1564323822] 'agreement among raft nodes before linearized reading' (duration: 130.948707ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:00.042341Z","caller":"traceutil/trace.go:171","msg":"trace[1942515269] linearizableReadLoop","detail":"{readStateIndex:5457; appliedIndex:5456; }","duration":"225.960103ms","start":"2026-10-14T15:54:59.816357Z","end":"2026-10-14T15:55:00.042317Z","steps":["trace[1942515269] 'read index received' (duration: 211.125992ms)","trace[1942515269] 'applied index is now lower than readState.Index' (duration: 14.832741ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:55:00.042464Z","caller":"traceutil/trace.go:171","msg":"trace[1577584698] transaction","detail":"{read_only:false; response_revision:5255; number_of_response:1; }","duration":"228.142165ms","start":"2026-10-14T15:54:59.814311Z","end":"2026-10-14T15:55:00.042453Z","steps":["trace[1577584698] 'process raft request' (duration: 213.15914ms)","trace[1577584698] 'compare' (duration: 14.427542ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:55:00.042859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.055204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-10-14T15:55:00.043019Z","caller":"traceutil/trace.go:171","msg":"trace[2121654401] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5255; }","duration":"242.234979ms","start":"2026-10-14T15:54:59.800756Z","end":"2026-10-14T15:55:00.042991Z","steps":["trace[2121654401] 'agreement among raft nodes before linearized reading' (duration: 241.83132ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:00.043044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.121765ms","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-10-14T15:55:00.043123Z","caller":"traceutil/trace.go:171","msg":"trace[1347346581] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5255; }","duration":"247.234527ms","start":"2026-10-14T15:54:59.795869Z","end":"2026-10-14T15:55:00.043104Z","steps":["trace[1347346581] 'agreement among raft nodes before linearized reading' (duration: 246.793467ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:00.048556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.548871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T15:55:00.048632Z","caller":"traceutil/trace.go:171","msg":"trace[1109143157] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:5257; }","duration":"170.639293ms","start":"2026-10-14T15:54:59.877974Z","end":"2026-10-14T15:55:00.048614Z","steps":["trace[1109143157] 'agreement among raft nodes before linearized reading' (duration: 170.456788ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:00.048801Z","caller":"traceutil/trace.go:171","msg":"trace[978202352] transaction","detail":"{read_only:false; response_revision:5256; number_of_response:1; }","duration":"228.73575ms","start":"2026-10-14T15:54:59.820041Z","end":"2026-10-14T15:55:00.048776Z","steps":["trace[978202352] 'process raft request' (duration: 228.216297ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:00.048933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.168768ms","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":"info","ts":"2026-10-14T15:55:00.04901Z","caller":"traceutil/trace.go:171","msg":"trace[1563192234] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5257; }","duration":"115.304652ms","start":"2026-10-14T15:54:59.933689Z","end":"2026-10-14T15:55:00.048994Z","steps":["trace[1563192234] 'agreement among raft nodes before linearized reading' (duration: 115.135718ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:00.998832Z","caller":"traceutil/trace.go:171","msg":"trace[155924785] transaction","detail":"{read_only:false; response_revision:5307; number_of_response:1; }","duration":"277.550525ms","start":"2026-10-14T15:55:00.721251Z","end":"2026-10-14T15:55:00.998801Z","steps":["trace[155924785] 'process raft request' (duration: 277.306519ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:00.998871Z","caller":"traceutil/trace.go:171","msg":"trace[113409998] transaction","detail":"{read_only:false; response_revision:5306; number_of_response:1; }","duration":"284.655344ms","start":"2026-10-14T15:55:00.714184Z","end":"2026-10-14T15:55:00.99884Z","steps":["trace[113409998] 'process raft request' (duration: 202.668482ms)","trace[113409998] 'compare' (duration: 81.215584ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:55:00.998987Z","caller":"traceutil/trace.go:171","msg":"trace[1062236948] transaction","detail":"{read_only:false; response_revision:5308; number_of_response:1; }","duration":"277.653948ms","start":"2026-10-14T15:55:00.721294Z","end":"2026-10-14T15:55:00.998948Z","steps":["trace[1062236948] 'process raft request' (duration: 277.33748ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:00.999356Z","caller":"traceutil/trace.go:171","msg":"trace[953191763] transaction","detail":"{read_only:false; response_revision:5309; number_of_response:1; }","duration":"278.041107ms","start":"2026-10-14T15:55:00.721299Z","end":"2026-10-14T15:55:00.99934Z","steps":["trace[953191763] 'process raft request' (duration: 277.591076ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:00.999491Z","caller":"traceutil/trace.go:171","msg":"trace[808987760] transaction","detail":"{read_only:false; response_revision:5310; number_of_response:1; }","duration":"278.029677ms","start":"2026-10-14T15:55:00.721427Z","end":"2026-10-14T15:55:00.999456Z","steps":["trace[808987760] 'process raft request' (duration: 277.843402ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:00.999756Z","caller":"traceutil/trace.go:171","msg":"trace[129054995] transaction","detail":"{read_only:false; response_revision:5311; number_of_response:1; }","duration":"277.688529ms","start":"2026-10-14T15:55:00.722043Z","end":"2026-10-14T15:55:00.999732Z","steps":["trace[129054995] 'process raft request' (duration: 277.338351ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:01.000602Z","caller":"traceutil/trace.go:171","msg":"trace[1402973255] transaction","detail":"{read_only:false; response_revision:5312; number_of_response:1; }","duration":"222.341587ms","start":"2026-10-14T15:55:00.778238Z","end":"2026-10-14T15:55:01.00058Z","steps":["trace[1402973255] 'process raft request' (duration: 221.424166ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:04.375455Z","caller":"traceutil/trace.go:171","msg":"trace[1662880024] linearizableReadLoop","detail":"{readStateIndex:5612; appliedIndex:5611; }","duration":"176.815339ms","start":"2026-10-14T15:55:04.198615Z","end":"2026-10-14T15:55:04.375431Z","steps":["trace[1662880024] 'read index received' (duration: 176.569913ms)","trace[1662880024] 'applied index is now lower than readState.Index' (duration: 244.535µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:55:04.375525Z","caller":"traceutil/trace.go:171","msg":"trace[1319453531] transaction","detail":"{read_only:false; response_revision:5405; number_of_response:1; }","duration":"214.242046ms","start":"2026-10-14T15:55:04.161241Z","end":"2026-10-14T15:55:04.375483Z","steps":["trace[1319453531] 'process raft request' (duration: 214.036731ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:04.375698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.275226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-14T15:55:04.375739Z","caller":"traceutil/trace.go:171","msg":"trace[10415320] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5405; }","duration":"176.360608ms","start":"2026-10-14T15:55:04.199369Z","end":"2026-10-14T15:55:04.37573Z","steps":["trace[10415320] 'agreement among raft nodes before linearized reading' (duration: 176.206994ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:04.375738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.976877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T15:55:04.375851Z","caller":"traceutil/trace.go:171","msg":"trace[1193045928] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5405; }","duration":"170.150311ms","start":"2026-10-14T15:55:04.205677Z","end":"2026-10-14T15:55:04.375827Z","steps":["trace[1193045928] 'agreement among raft nodes before linearized reading' (duration: 169.996497ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:04.376339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.727231ms","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-10-14T15:55:04.376396Z","caller":"traceutil/trace.go:171","msg":"trace[627854071] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5405; }","duration":"177.827503ms","start":"2026-10-14T15:55:04.198553Z","end":"2026-10-14T15:55:04.376381Z","steps":["trace[627854071] 'agreement among raft nodes before linearized reading' (duration: 177.022644ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:05.167637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"724.564626ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T15:55:05.167729Z","caller":"traceutil/trace.go:171","msg":"trace[2019120676] linearizableReadLoop","detail":"{readStateIndex:5613; appliedIndex:5612; }","duration":"787.60569ms","start":"2026-10-14T15:55:04.380108Z","end":"2026-10-14T15:55:05.167714Z","steps":["trace[2019120676] 'read index received' (duration: 62.851539ms)","trace[2019120676] 'applied index is now lower than readState.Index' (duration: 724.753061ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:55:05.167794Z","caller":"traceutil/trace.go:171","msg":"trace[1515440262] transaction","detail":"{read_only:false; response_revision:5406; number_of_response:1; }","duration":"788.301876ms","start":"2026-10-14T15:55:04.379481Z","end":"2026-10-14T15:55:05.167783Z","steps":["trace[1515440262] 'process raft request' (duration: 63.503074ms)","trace[1515440262] 'compare' (duration: 724.429503ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:55:05.167843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:04.379459Z","time spent":"788.354858ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T15:55:05.167955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.824395ms","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-10-14T15:55:05.168031Z","caller":"traceutil/trace.go:171","msg":"trace[320805549] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5406; }","duration":"787.934707ms","start":"2026-10-14T15:55:04.380078Z","end":"2026-10-14T15:55:05.168013Z","steps":["trace[320805549] 'agreement among raft nodes before linearized reading' (duration: 787.734373ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:05.168065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:04.380063Z","time spent":"787.994919ms","remote":"127.0.0.1:47684","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-10-14T15:55:05.601777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.69996ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T15:55:05.601955Z","caller":"traceutil/trace.go:171","msg":"trace[1195651212] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5406; }","duration":"139.899244ms","start":"2026-10-14T15:55:05.462031Z","end":"2026-10-14T15:55:05.601931Z","steps":["trace[1195651212] 'range keys from in-memory index tree' (duration: 139.670369ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:05.602117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.990064ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T15:55:05.60233Z","caller":"traceutil/trace.go:171","msg":"trace[2113664852] linearizableReadLoop","detail":"{readStateIndex:5615; appliedIndex:5613; }","duration":"434.561184ms","start":"2026-10-14T15:55:05.167752Z","end":"2026-10-14T15:55:05.602313Z","steps":["trace[2113664852] 'read index received' (duration: 121.380816ms)","trace[2113664852] 'applied index is now lower than readState.Index' (duration: 313.179268ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:55:05.60235Z","caller":"traceutil/trace.go:171","msg":"trace[1335360244] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"451.113797ms","start":"2026-10-14T15:55:05.151214Z","end":"2026-10-14T15:55:05.602328Z","steps":["trace[1335360244] 'process raft request' (duration: 451.034465ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:05.602449Z","caller":"traceutil/trace.go:171","msg":"trace[1801947100] transaction","detail":"{read_only:false; response_revision:5407; number_of_response:1; }","duration":"590.530969ms","start":"2026-10-14T15:55:05.011895Z","end":"2026-10-14T15:55:05.602426Z","steps":["trace[1801947100] 'process raft request' (duration: 277.126465ms)","trace[1801947100] 'compare' (duration: 312.847881ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:55:05.602489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:05.15119Z","time spent":"451.224229ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T15:55:05.60253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"888.079899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-14T15:55:05.602566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.035362488s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-917d0aea-c77f-4e58-8bcf-47a06c7bced6\" ","response":"range_response_count:1 size:3601"} {"level":"warn","ts":"2026-10-14T15:55:05.602562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.298932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-14T15:55:05.602602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.027788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:17451"} {"level":"info","ts":"2026-10-14T15:55:05.60261Z","caller":"traceutil/trace.go:171","msg":"trace[2127774697] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:5408; }","duration":"888.193382ms","start":"2026-10-14T15:55:04.714397Z","end":"2026-10-14T15:55:05.60259Z","steps":["trace[2127774697] 'agreement among raft nodes before linearized reading' (duration: 887.963437ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:05.602634Z","caller":"traceutil/trace.go:171","msg":"trace[420836261] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5408; }","duration":"433.076939ms","start":"2026-10-14T15:55:05.169548Z","end":"2026-10-14T15:55:05.602625Z","steps":["trace[420836261] 'agreement among raft nodes before linearized reading' (duration: 432.937966ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:05.602645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.122639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-917d0aea-c77f-4e58-8bcf-47a06c7bced6\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-14T15:55:05.602642Z","caller":"traceutil/trace.go:171","msg":"trace[431891742] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:5408; }","duration":"500.438245ms","start":"2026-10-14T15:55:05.102183Z","end":"2026-10-14T15:55:05.602622Z","steps":["trace[431891742] 'agreement among raft nodes before linearized reading' (duration: 500.260761ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:05.602664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:05.169531Z","time spent":"433.126471ms","remote":"127.0.0.1:47680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":17474,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-10-14T15:55:05.602659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:04.714325Z","time spent":"888.323144ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-10-14T15:55:05.602678Z","caller":"traceutil/trace.go:171","msg":"trace[195911996] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-917d0aea-c77f-4e58-8bcf-47a06c7bced6; range_end:; response_count:1; response_revision:5408; }","duration":"522.193581ms","start":"2026-10-14T15:55:05.080473Z","end":"2026-10-14T15:55:05.602667Z","steps":["trace[195911996] 'agreement among raft nodes before linearized reading' (duration: 522.111159ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:05.602676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.136006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jqn6g\" ","response":"range_response_count:1 size:6522"} {"level":"warn","ts":"2026-10-14T15:55:05.602693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:05.102158Z","time spent":"500.524857ms","remote":"127.0.0.1:59038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":30,"request content":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true "} {"level":"warn","ts":"2026-10-14T15:55:05.60254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:05.01187Z","time spent":"590.626972ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T15:55:05.602709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:05.080452Z","time spent":"522.249072ms","remote":"127.0.0.1:47684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3624,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-917d0aea-c77f-4e58-8bcf-47a06c7bced6\" "} {"level":"info","ts":"2026-10-14T15:55:05.602736Z","caller":"traceutil/trace.go:171","msg":"trace[1011970235] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jqn6g; range_end:; response_count:1; response_revision:5408; }","duration":"987.224678ms","start":"2026-10-14T15:55:04.615496Z","end":"2026-10-14T15:55:05.602721Z","steps":["trace[1011970235] 'agreement among raft nodes before linearized reading' (duration: 987.051284ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:05.602801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:04.615482Z","time spent":"987.3081ms","remote":"127.0.0.1:47684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6545,"request content":"key:\"/registry/pods/openstack/keepalived-jqn6g\" "} {"level":"info","ts":"2026-10-14T15:55:05.602632Z","caller":"traceutil/trace.go:171","msg":"trace[1899503122] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-917d0aea-c77f-4e58-8bcf-47a06c7bced6; range_end:; response_count:1; response_revision:5408; }","duration":"1.035472551s","start":"2026-10-14T15:55:04.567124Z","end":"2026-10-14T15:55:05.602597Z","steps":["trace[1899503122] 'agreement among raft nodes before linearized reading' (duration: 1.035338548s)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:05.602856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:04.567101Z","time spent":"1.035733977s","remote":"127.0.0.1:47684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3624,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-917d0aea-c77f-4e58-8bcf-47a06c7bced6\" "} {"level":"warn","ts":"2026-10-14T15:55:05.602461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"903.252649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T15:55:05.602929Z","caller":"traceutil/trace.go:171","msg":"trace[1337730749] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:5408; }","duration":"903.782391ms","start":"2026-10-14T15:55:04.699134Z","end":"2026-10-14T15:55:05.602917Z","steps":["trace[1337730749] 'agreement among raft nodes before linearized reading' (duration: 903.262668ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:05.602972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:04.699114Z","time spent":"903.841333ms","remote":"127.0.0.1:47858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-10-14T15:55:05.602998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.01718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786928"} {"level":"info","ts":"2026-10-14T15:55:05.603058Z","caller":"traceutil/trace.go:171","msg":"trace[1743358325] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5408; }","duration":"187.114553ms","start":"2026-10-14T15:55:05.415925Z","end":"2026-10-14T15:55:05.60304Z","steps":["trace[1743358325] 'agreement among raft nodes before linearized reading' (duration: 186.607691ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:05.947672Z","caller":"traceutil/trace.go:171","msg":"trace[1842516098] linearizableReadLoop","detail":"{readStateIndex:5616; appliedIndex:5615; }","duration":"264.64618ms","start":"2026-10-14T15:55:05.683003Z","end":"2026-10-14T15:55:05.947649Z","steps":["trace[1842516098] 'read index received' (duration: 264.382544ms)","trace[1842516098] 'applied index is now lower than readState.Index' (duration: 262.486µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:55:05.94772Z","caller":"traceutil/trace.go:171","msg":"trace[2135143656] transaction","detail":"{read_only:false; response_revision:5409; number_of_response:1; }","duration":"337.518407ms","start":"2026-10-14T15:55:05.610174Z","end":"2026-10-14T15:55:05.947693Z","steps":["trace[2135143656] 'process raft request' (duration: 337.320992ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:05.947873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:05.610122Z","time spent":"337.66001ms","remote":"127.0.0.1:47684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3706,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T15:55:05.947888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.856915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-14T15:55:05.947948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.886593ms","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-10-14T15:55:05.94796Z","caller":"traceutil/trace.go:171","msg":"trace[246015390] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5409; }","duration":"264.988108ms","start":"2026-10-14T15:55:05.682955Z","end":"2026-10-14T15:55:05.947943Z","steps":["trace[246015390] 'agreement among raft nodes before linearized reading' (duration: 264.818784ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:05.947987Z","caller":"traceutil/trace.go:171","msg":"trace[1758065569] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5409; }","duration":"106.984095ms","start":"2026-10-14T15:55:05.840992Z","end":"2026-10-14T15:55:05.947976Z","steps":["trace[1758065569] 'agreement among raft nodes before linearized reading' (duration: 106.79626ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:06.42722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.609464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-14T15:55:06.427324Z","caller":"traceutil/trace.go:171","msg":"trace[708194972] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5410; }","duration":"379.759818ms","start":"2026-10-14T15:55:06.047536Z","end":"2026-10-14T15:55:06.427296Z","steps":["trace[708194972] 'range keys from in-memory index tree' (duration: 379.335767ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:06.4274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:06.047515Z","time spent":"379.848049ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-10-14T15:55:06.427711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.33472ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T15:55:06.42792Z","caller":"traceutil/trace.go:171","msg":"trace[671175547] transaction","detail":"{read_only:false; response_revision:5412; number_of_response:1; }","duration":"271.40517ms","start":"2026-10-14T15:55:06.156463Z","end":"2026-10-14T15:55:06.427868Z","steps":["trace[671175547] 'process raft request' (duration: 271.347259ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:06.428011Z","caller":"traceutil/trace.go:171","msg":"trace[954962407] transaction","detail":"{read_only:false; response_revision:5411; number_of_response:1; }","duration":"358.116414ms","start":"2026-10-14T15:55:06.069871Z","end":"2026-10-14T15:55:06.427987Z","steps":["trace[954962407] 'process raft request' (duration: 80.417725ms)","trace[954962407] 'compare' (duration: 277.192387ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:55:06.428118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:06.069847Z","time spent":"358.206746ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T15:55:06.428129Z","caller":"traceutil/trace.go:171","msg":"trace[2128610647] linearizableReadLoop","detail":"{readStateIndex:5618; appliedIndex:5617; }","duration":"347.756119ms","start":"2026-10-14T15:55:06.080362Z","end":"2026-10-14T15:55:06.428118Z","steps":["trace[2128610647] 'read index received' (duration: 69.962618ms)","trace[2128610647] 'applied index is now lower than readState.Index' (duration: 277.792181ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:55:06.428379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.926224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-10-14T15:55:06.428387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.656148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-10-14T15:55:06.428372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.450672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"warn","ts":"2026-10-14T15:55:06.42837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.45608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T15:55:06.428431Z","caller":"traceutil/trace.go:171","msg":"trace[119927460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5412; }","duration":"342.717769ms","start":"2026-10-14T15:55:06.085701Z","end":"2026-10-14T15:55:06.428418Z","steps":["trace[119927460] 'agreement among raft nodes before linearized reading' (duration: 342.599716ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:06.428445Z","caller":"traceutil/trace.go:171","msg":"trace[28673699] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5412; }","duration":"343.007636ms","start":"2026-10-14T15:55:06.085401Z","end":"2026-10-14T15:55:06.428409Z","steps":["trace[28673699] 'agreement among raft nodes before linearized reading' (duration: 342.856412ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:06.428443Z","caller":"traceutil/trace.go:171","msg":"trace[1509568075] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5412; }","duration":"274.583305ms","start":"2026-10-14T15:55:06.153845Z","end":"2026-10-14T15:55:06.428429Z","steps":["trace[1509568075] 'agreement among raft nodes before linearized reading' (duration: 274.419411ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:06.428463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:06.085693Z","time spent":"342.762531ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-14T15:55:06.428472Z","caller":"traceutil/trace.go:171","msg":"trace[64486291] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5412; }","duration":"222.614364ms","start":"2026-10-14T15:55:06.205839Z","end":"2026-10-14T15:55:06.428453Z","steps":["trace[64486291] 'agreement among raft nodes before linearized reading' (duration: 222.43439ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:06.428479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:06.08538Z","time spent":"343.090578ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-10-14T15:55:06.428455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.076056ms","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-10-14T15:55:06.428548Z","caller":"traceutil/trace.go:171","msg":"trace[780393965] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5412; }","duration":"348.21703ms","start":"2026-10-14T15:55:06.08031Z","end":"2026-10-14T15:55:06.428527Z","steps":["trace[780393965] 'agreement among raft nodes before linearized reading' (duration: 347.932433ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:06.428594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:06.080287Z","time spent":"348.297862ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-14T15:55:06.863853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.172272ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T15:55:06.864285Z","caller":"traceutil/trace.go:171","msg":"trace[1555743699] transaction","detail":"{read_only:false; response_revision:5415; number_of_response:1; }","duration":"431.305248ms","start":"2026-10-14T15:55:06.432962Z","end":"2026-10-14T15:55:06.864267Z","steps":["trace[1555743699] 'process raft request' (duration: 431.071512ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:06.864269Z","caller":"traceutil/trace.go:171","msg":"trace[67191948] transaction","detail":"{read_only:false; response_revision:5413; number_of_response:1; }","duration":"432.070156ms","start":"2026-10-14T15:55:06.432164Z","end":"2026-10-14T15:55:06.864234Z","steps":["trace[67191948] 'process raft request' (duration: 177.414213ms)","trace[67191948] 'compare' (duration: 253.960867ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:55:06.864317Z","caller":"traceutil/trace.go:171","msg":"trace[1505936328] linearizableReadLoop","detail":"{readStateIndex:5625; appliedIndex:5619; }","duration":"346.045859ms","start":"2026-10-14T15:55:06.518257Z","end":"2026-10-14T15:55:06.864303Z","steps":["trace[1505936328] 'read index received' (duration: 91.343124ms)","trace[1505936328] 'applied index is now lower than readState.Index' (duration: 254.701765ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:55:06.864347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:06.432942Z","time spent":"431.3768ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T15:55:06.864388Z","caller":"traceutil/trace.go:171","msg":"trace[1105794446] transaction","detail":"{read_only:false; response_revision:5417; number_of_response:1; }","duration":"430.500159ms","start":"2026-10-14T15:55:06.433863Z","end":"2026-10-14T15:55:06.864363Z","steps":["trace[1105794446] 'process raft request' (duration: 430.239323ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:06.864408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:06.432116Z","time spent":"432.22029ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T15:55:06.864426Z","caller":"traceutil/trace.go:171","msg":"trace[324654302] transaction","detail":"{read_only:false; response_revision:5418; number_of_response:1; }","duration":"430.059758ms","start":"2026-10-14T15:55:06.434353Z","end":"2026-10-14T15:55:06.864413Z","steps":["trace[324654302] 'process raft request' (duration: 429.892655ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:06.864496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:06.434337Z","time spent":"430.11737ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T15:55:06.864476Z","caller":"traceutil/trace.go:171","msg":"trace[1127342112] transaction","detail":"{read_only:false; response_revision:5414; number_of_response:1; }","duration":"431.507273ms","start":"2026-10-14T15:55:06.432924Z","end":"2026-10-14T15:55:06.864431Z","steps":["trace[1127342112] 'process raft request' (duration: 431.031372ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:06.864492Z","caller":"traceutil/trace.go:171","msg":"trace[276288314] transaction","detail":"{read_only:false; response_revision:5416; number_of_response:1; }","duration":"430.748055ms","start":"2026-10-14T15:55:06.433716Z","end":"2026-10-14T15:55:06.864464Z","steps":["trace[276288314] 'process raft request' (duration: 430.350865ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:06.86464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.372336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-14T15:55:06.864646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:06.432907Z","time spent":"431.648256ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T15:55:06.864642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:06.433702Z","time spent":"430.860308ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T15:55:06.864699Z","caller":"traceutil/trace.go:171","msg":"trace[1292874109] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:5418; }","duration":"346.460258ms","start":"2026-10-14T15:55:06.518223Z","end":"2026-10-14T15:55:06.864683Z","steps":["trace[1292874109] 'agreement among raft nodes before linearized reading' (duration: 346.361176ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:06.864501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:06.433836Z","time spent":"430.604782ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T15:55:06.864733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:06.518208Z","time spent":"346.51604ms","remote":"127.0.0.1:47918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-10-14T15:55:06.864749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.194983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-917d0aea-c77f-4e58-8bcf-47a06c7bced6\" ","response":"range_response_count:1 size:3721"} {"level":"info","ts":"2026-10-14T15:55:06.86478Z","caller":"traceutil/trace.go:171","msg":"trace[506971900] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-917d0aea-c77f-4e58-8bcf-47a06c7bced6; range_end:; response_count:1; response_revision:5418; }","duration":"257.260125ms","start":"2026-10-14T15:55:06.607509Z","end":"2026-10-14T15:55:06.864769Z","steps":["trace[506971900] 'agreement among raft nodes before linearized reading' (duration: 257.140092ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:06.864707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.911438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/goldpinger\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T15:55:06.865166Z","caller":"traceutil/trace.go:171","msg":"trace[1058390820] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/goldpinger; range_end:; response_count:0; response_revision:5418; }","duration":"279.378749ms","start":"2026-10-14T15:55:06.585746Z","end":"2026-10-14T15:55:06.865125Z","steps":["trace[1058390820] 'agreement among raft nodes before linearized reading' (duration: 278.748234ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:14.750061Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2946} {"level":"info","ts":"2026-10-14T15:55:14.832601Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2946,"took":"81.04695ms","hash":3644915802,"current-db-size-bytes":54910976,"current-db-size":"55 MB","current-db-size-in-use-bytes":31019008,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-14T15:55:14.832789Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3644915802,"revision":2946,"compact-revision":-1} {"level":"warn","ts":"2026-10-14T15:55:19.071611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.705786ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T15:55:19.071787Z","caller":"traceutil/trace.go:171","msg":"trace[1541388895] transaction","detail":"{read_only:false; response_revision:5636; number_of_response:1; }","duration":"315.796251ms","start":"2026-10-14T15:55:18.75597Z","end":"2026-10-14T15:55:19.071766Z","steps":["trace[1541388895] 'process raft request' (duration: 92.841789ms)","trace[1541388895] 'compare' (duration: 222.402949ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:55:19.071862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:18.75595Z","time spent":"315.874934ms","remote":"127.0.0.1:47684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8041,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T15:55:26.506273Z","caller":"traceutil/trace.go:171","msg":"trace[1542370284] transaction","detail":"{read_only:false; response_revision:5784; number_of_response:1; }","duration":"323.176317ms","start":"2026-10-14T15:55:26.183072Z","end":"2026-10-14T15:55:26.506248Z","steps":["trace[1542370284] 'process raft request' (duration: 255.843671ms)","trace[1542370284] 'compare' (duration: 67.184892ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:55:26.506401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:26.183047Z","time spent":"323.292819ms","remote":"127.0.0.1:47608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":790,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T15:55:26.506413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.151248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T15:55:26.506273Z","caller":"traceutil/trace.go:171","msg":"trace[971086353] linearizableReadLoop","detail":"{readStateIndex:6000; appliedIndex:5999; }","duration":"301.998085ms","start":"2026-10-14T15:55:26.204249Z","end":"2026-10-14T15:55:26.506247Z","steps":["trace[971086353] 'read index received' (duration: 234.67757ms)","trace[971086353] 'applied index is now lower than readState.Index' (duration: 67.319105ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:55:26.506462Z","caller":"traceutil/trace.go:171","msg":"trace[2081989742] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5784; }","duration":"302.316073ms","start":"2026-10-14T15:55:26.204132Z","end":"2026-10-14T15:55:26.506448Z","steps":["trace[2081989742] 'agreement among raft nodes before linearized reading' (duration: 302.18793ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:26.506671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:26.204113Z","time spent":"302.541797ms","remote":"127.0.0.1:47524","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-10-14T15:55:26.506811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.158069ms","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-10-14T15:55:26.50685Z","caller":"traceutil/trace.go:171","msg":"trace[1356492438] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5784; }","duration":"137.233981ms","start":"2026-10-14T15:55:26.369606Z","end":"2026-10-14T15:55:26.50684Z","steps":["trace[1356492438] 'agreement among raft nodes before linearized reading' (duration: 137.100218ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:26.923259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.584147ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-14T15:55:26.923605Z","caller":"traceutil/trace.go:171","msg":"trace[206166174] transaction","detail":"{read_only:false; response_revision:5786; number_of_response:1; }","duration":"334.118444ms","start":"2026-10-14T15:55:26.589438Z","end":"2026-10-14T15:55:26.923556Z","steps":["trace[206166174] 'process raft request' (duration: 333.909379ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:26.923608Z","caller":"traceutil/trace.go:171","msg":"trace[2100108207] transaction","detail":"{read_only:false; response_revision:5785; number_of_response:1; }","duration":"412.643955ms","start":"2026-10-14T15:55:26.510711Z","end":"2026-10-14T15:55:26.923355Z","steps":["trace[2100108207] 'process raft request' (duration: 112.900174ms)","trace[2100108207] 'compare' (duration: 299.382382ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:55:26.923637Z","caller":"traceutil/trace.go:171","msg":"trace[756174722] linearizableReadLoop","detail":"{readStateIndex:6001; appliedIndex:6000; }","duration":"412.164184ms","start":"2026-10-14T15:55:26.511444Z","end":"2026-10-14T15:55:26.923608Z","steps":["trace[756174722] 'read index received' (duration: 112.183638ms)","trace[756174722] 'applied index is now lower than readState.Index' (duration: 299.977466ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:55:26.923795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:26.58941Z","time spent":"334.233677ms","remote":"127.0.0.1:47768","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-10-14T15:55:26.923921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.136619ms","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":"warn","ts":"2026-10-14T15:55:26.923963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.727067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-de2c7e9f-76f1-465f-995d-117f24091c8d\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-14T15:55:26.924036Z","caller":"traceutil/trace.go:171","msg":"trace[1680309303] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-de2c7e9f-76f1-465f-995d-117f24091c8d; range_end:; response_count:1; response_revision:5786; }","duration":"114.88194ms","start":"2026-10-14T15:55:26.809134Z","end":"2026-10-14T15:55:26.924016Z","steps":["trace[1680309303] 'agreement among raft nodes before linearized reading' (duration: 114.701426ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:26.923954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:26.510696Z","time spent":"413.070785ms","remote":"127.0.0.1:47608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":896,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T15:55:26.923977Z","caller":"traceutil/trace.go:171","msg":"trace[983874264] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:5786; }","duration":"178.232121ms","start":"2026-10-14T15:55:26.74573Z","end":"2026-10-14T15:55:26.923962Z","steps":["trace[983874264] 'agreement among raft nodes before linearized reading' (duration: 178.083867ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:26.923918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19278"} {"level":"info","ts":"2026-10-14T15:55:26.924289Z","caller":"traceutil/trace.go:171","msg":"trace[1067434495] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5786; }","duration":"412.84657ms","start":"2026-10-14T15:55:26.511418Z","end":"2026-10-14T15:55:26.924265Z","steps":["trace[1067434495] 'agreement among raft nodes before linearized reading' (duration: 412.321128ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:55:26.924362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:55:26.511406Z","time spent":"412.938442ms","remote":"127.0.0.1:47680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":19301,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-10-14T15:55:29.041042Z","caller":"traceutil/trace.go:171","msg":"trace[1919606333] transaction","detail":"{read_only:false; response_revision:5835; number_of_response:1; }","duration":"111.510742ms","start":"2026-10-14T15:55:28.929506Z","end":"2026-10-14T15:55:29.041016Z","steps":["trace[1919606333] 'process raft request' (duration: 111.285916ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:55:29.046425Z","caller":"traceutil/trace.go:171","msg":"trace[876464069] transaction","detail":"{read_only:false; response_revision:5836; number_of_response:1; }","duration":"100.203324ms","start":"2026-10-14T15:55:28.946204Z","end":"2026-10-14T15:55:29.046407Z","steps":["trace[876464069] 'process raft request' (duration: 100.080251ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:56:17.967949Z","caller":"traceutil/trace.go:171","msg":"trace[1307373559] transaction","detail":"{read_only:false; response_revision:6319; number_of_response:1; }","duration":"130.980163ms","start":"2026-10-14T15:56:17.83694Z","end":"2026-10-14T15:56:17.96792Z","steps":["trace[1307373559] 'process raft request' (duration: 130.788038ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:56:18.050068Z","caller":"traceutil/trace.go:171","msg":"trace[592345261] transaction","detail":"{read_only:false; response_revision:6321; number_of_response:1; }","duration":"120.697959ms","start":"2026-10-14T15:56:17.929336Z","end":"2026-10-14T15:56:18.050034Z","steps":["trace[592345261] 'process raft request' (duration: 120.581826ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:56:18.050109Z","caller":"traceutil/trace.go:171","msg":"trace[658324379] transaction","detail":"{read_only:false; response_revision:6320; number_of_response:1; }","duration":"122.718737ms","start":"2026-10-14T15:56:17.927352Z","end":"2026-10-14T15:56:18.050071Z","steps":["trace[658324379] 'process raft request' (duration: 116.205993ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:00:14.757789Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5581} {"level":"info","ts":"2026-10-14T16:00:14.848111Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5581,"took":"88.34747ms","hash":1434742758,"current-db-size-bytes":54910976,"current-db-size":"55 MB","current-db-size-in-use-bytes":28983296,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-14T16:00:14.848163Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1434742758,"revision":5581,"compact-revision":2946} {"level":"info","ts":"2026-10-14T16:01:29.299453Z","caller":"traceutil/trace.go:171","msg":"trace[818576335] transaction","detail":"{read_only:false; response_revision:8633; number_of_response:1; }","duration":"116.345731ms","start":"2026-10-14T16:01:29.183076Z","end":"2026-10-14T16:01:29.299421Z","steps":["trace[818576335] 'process raft request' (duration: 116.132296ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:01:29.314453Z","caller":"traceutil/trace.go:171","msg":"trace[549219299] transaction","detail":"{read_only:false; response_revision:8634; number_of_response:1; }","duration":"105.936535ms","start":"2026-10-14T16:01:29.208491Z","end":"2026-10-14T16:01:29.314427Z","steps":["trace[549219299] 'process raft request' (duration: 105.747441ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:01:29.314843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.961074ms","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-10-14T16:01:29.314962Z","caller":"traceutil/trace.go:171","msg":"trace[242924924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8635; }","duration":"108.132128ms","start":"2026-10-14T16:01:29.20681Z","end":"2026-10-14T16:01:29.314942Z","steps":["trace[242924924] 'agreement among raft nodes before linearized reading' (duration: 107.81004ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:01:39.478748Z","caller":"traceutil/trace.go:171","msg":"trace[1202451576] transaction","detail":"{read_only:false; response_revision:8690; number_of_response:1; }","duration":"105.310951ms","start":"2026-10-14T16:01:39.373412Z","end":"2026-10-14T16:01:39.478723Z","steps":["trace[1202451576] 'process raft request' (duration: 82.975443ms)","trace[1202451576] 'compare' (duration: 22.073482ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:01:40.343802Z","caller":"traceutil/trace.go:171","msg":"trace[609338581] linearizableReadLoop","detail":"{readStateIndex:9004; appliedIndex:9003; }","duration":"194.855848ms","start":"2026-10-14T16:01:40.148929Z","end":"2026-10-14T16:01:40.343785Z","steps":["trace[609338581] 'read index received' (duration: 194.721405ms)","trace[609338581] 'applied index is now lower than readState.Index' (duration: 133.793µs)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:01:40.343954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.002682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T16:01:40.343988Z","caller":"traceutil/trace.go:171","msg":"trace[859115424] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:8694; }","duration":"195.078624ms","start":"2026-10-14T16:01:40.148899Z","end":"2026-10-14T16:01:40.343978Z","steps":["trace[859115424] 'agreement among raft nodes before linearized reading' (duration: 194.963911ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:01:40.344554Z","caller":"traceutil/trace.go:171","msg":"trace[680232748] transaction","detail":"{read_only:false; response_revision:8694; number_of_response:1; }","duration":"248.489086ms","start":"2026-10-14T16:01:40.096052Z","end":"2026-10-14T16:01:40.344542Z","steps":["trace[680232748] 'process raft request' (duration: 247.644136ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:01:41.64774Z","caller":"traceutil/trace.go:171","msg":"trace[1271717358] linearizableReadLoop","detail":"{readStateIndex:9011; appliedIndex:9010; }","duration":"132.845502ms","start":"2026-10-14T16:01:41.514869Z","end":"2026-10-14T16:01:41.647714Z","steps":["trace[1271717358] 'read index received' (duration: 95.409556ms)","trace[1271717358] 'applied index is now lower than readState.Index' (duration: 37.434876ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:01:41.647829Z","caller":"traceutil/trace.go:171","msg":"trace[1544092037] transaction","detail":"{read_only:false; response_revision:8701; number_of_response:1; }","duration":"139.841628ms","start":"2026-10-14T16:01:41.507949Z","end":"2026-10-14T16:01:41.647791Z","steps":["trace[1544092037] 'process raft request' (duration: 102.30257ms)","trace[1544092037] 'compare' (duration: 37.354293ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:01:41.64801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.110938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-10-14T16:01:41.64805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.14502ms","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-10-14T16:01:41.648086Z","caller":"traceutil/trace.go:171","msg":"trace[426414311] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8701; }","duration":"133.215811ms","start":"2026-10-14T16:01:41.514851Z","end":"2026-10-14T16:01:41.648067Z","steps":["trace[426414311] 'agreement among raft nodes before linearized reading' (duration: 133.013046ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:01:41.648137Z","caller":"traceutil/trace.go:171","msg":"trace[660452544] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8701; }","duration":"133.271202ms","start":"2026-10-14T16:01:41.514843Z","end":"2026-10-14T16:01:41.648114Z","steps":["trace[660452544] 'agreement among raft nodes before linearized reading' (duration: 132.998196ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:02:05.94476Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023c3.wal"} {"level":"info","ts":"2026-10-14T16:02:10.023708Z","caller":"traceutil/trace.go:171","msg":"trace[2012762192] linearizableReadLoop","detail":"{readStateIndex:9221; appliedIndex:9220; }","duration":"191.228982ms","start":"2026-10-14T16:02:09.832455Z","end":"2026-10-14T16:02:10.023684Z","steps":["trace[2012762192] 'read index received' (duration: 191.063588ms)","trace[2012762192] 'applied index is now lower than readState.Index' (duration: 164.524µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:02:10.024089Z","caller":"traceutil/trace.go:171","msg":"trace[2122912117] transaction","detail":"{read_only:false; response_revision:8903; number_of_response:1; }","duration":"307.486441ms","start":"2026-10-14T16:02:09.716586Z","end":"2026-10-14T16:02:10.024072Z","steps":["trace[2122912117] 'process raft request' (duration: 306.886987ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:02:10.024247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:02:09.716562Z","time spent":"307.569472ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T16:02:10.024626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.162283ms","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-10-14T16:02:10.024684Z","caller":"traceutil/trace.go:171","msg":"trace[1585284070] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8903; }","duration":"192.267226ms","start":"2026-10-14T16:02:09.832402Z","end":"2026-10-14T16:02:10.02467Z","steps":["trace[1585284070] 'agreement among raft nodes before linearized reading' (duration: 192.104722ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:02:10.024928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.156894ms","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-10-14T16:02:10.024977Z","caller":"traceutil/trace.go:171","msg":"trace[1046408126] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8903; }","duration":"181.225875ms","start":"2026-10-14T16:02:09.843738Z","end":"2026-10-14T16:02:10.024964Z","steps":["trace[1046408126] 'agreement among raft nodes before linearized reading' (duration: 181.107272ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:02:10.025274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.716676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-10-14T16:02:10.025323Z","caller":"traceutil/trace.go:171","msg":"trace[144358333] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8903; }","duration":"178.782177ms","start":"2026-10-14T16:02:09.846527Z","end":"2026-10-14T16:02:10.025309Z","steps":["trace[144358333] 'agreement among raft nodes before linearized reading' (duration: 178.667314ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:02:10.27489Z","caller":"traceutil/trace.go:171","msg":"trace[911806538] transaction","detail":"{read_only:false; response_revision:8904; number_of_response:1; }","duration":"243.026996ms","start":"2026-10-14T16:02:10.031845Z","end":"2026-10-14T16:02:10.274872Z","steps":["trace[911806538] 'process raft request' (duration: 233.091311ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:02:10.275171Z","caller":"traceutil/trace.go:171","msg":"trace[188480595] linearizableReadLoop","detail":"{readStateIndex:9224; appliedIndex:9221; }","duration":"202.57269ms","start":"2026-10-14T16:02:10.072593Z","end":"2026-10-14T16:02:10.275165Z","steps":["trace[188480595] 'read index received' (duration: 192.511702ms)","trace[188480595] 'applied index is now lower than readState.Index' (duration: 10.060368ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:02:10.27515Z","caller":"traceutil/trace.go:171","msg":"trace[103844949] transaction","detail":"{read_only:false; response_revision:8905; number_of_response:1; }","duration":"237.834714ms","start":"2026-10-14T16:02:10.037288Z","end":"2026-10-14T16:02:10.275122Z","steps":["trace[103844949] 'process raft request' (duration: 237.516126ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:02:10.275229Z","caller":"traceutil/trace.go:171","msg":"trace[895259370] transaction","detail":"{read_only:false; response_revision:8906; number_of_response:1; }","duration":"231.929034ms","start":"2026-10-14T16:02:10.043278Z","end":"2026-10-14T16:02:10.275207Z","steps":["trace[895259370] 'process raft request' (duration: 231.75989ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:02:10.275326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.178067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jqn6g\" ","response":"range_response_count:1 size:6522"} {"level":"info","ts":"2026-10-14T16:02:10.275362Z","caller":"traceutil/trace.go:171","msg":"trace[1211563897] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jqn6g; range_end:; response_count:1; response_revision:8906; }","duration":"138.238629ms","start":"2026-10-14T16:02:10.1371Z","end":"2026-10-14T16:02:10.275339Z","steps":["trace[1211563897] 'agreement among raft nodes before linearized reading' (duration: 138.170697ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:02:10.275251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.651261ms","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-10-14T16:02:10.275442Z","caller":"traceutil/trace.go:171","msg":"trace[391005592] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:8906; }","duration":"202.875767ms","start":"2026-10-14T16:02:10.072551Z","end":"2026-10-14T16:02:10.275426Z","steps":["trace[391005592] 'agreement among raft nodes before linearized reading' (duration: 202.658612ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:02:18.328117Z","caller":"traceutil/trace.go:171","msg":"trace[263053738] transaction","detail":"{read_only:false; response_revision:8945; number_of_response:1; }","duration":"172.460408ms","start":"2026-10-14T16:02:18.155631Z","end":"2026-10-14T16:02:18.328091Z","steps":["trace[263053738] 'process raft request' (duration: 143.430882ms)","trace[263053738] 'compare' (duration: 28.828122ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:02:23.778136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.444849ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-14T16:02:23.77884Z","caller":"traceutil/trace.go:171","msg":"trace[269836682] linearizableReadLoop","detail":"{readStateIndex:9307; appliedIndex:9306; }","duration":"215.962787ms","start":"2026-10-14T16:02:23.562861Z","end":"2026-10-14T16:02:23.778824Z","steps":["trace[269836682] 'read index received' (duration: 215.773582ms)","trace[269836682] 'applied index is now lower than readState.Index' (duration: 188.035µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:02:23.778911Z","caller":"traceutil/trace.go:171","msg":"trace[754755317] transaction","detail":"{read_only:false; response_revision:8986; number_of_response:1; }","duration":"312.12454ms","start":"2026-10-14T16:02:23.466766Z","end":"2026-10-14T16:02:23.778891Z","steps":["trace[754755317] 'process raft request' (duration: 311.858394ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:02:23.779008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:02:23.466739Z","time spent":"312.191961ms","remote":"127.0.0.1:47684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4635,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T16:02:23.779119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.242233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T16:02:23.779174Z","caller":"traceutil/trace.go:171","msg":"trace[1008169626] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:8986; }","duration":"216.339956ms","start":"2026-10-14T16:02:23.562822Z","end":"2026-10-14T16:02:23.779162Z","steps":["trace[1008169626] 'agreement among raft nodes before linearized reading' (duration: 216.229493ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:02:23.960416Z","caller":"traceutil/trace.go:171","msg":"trace[59565309] transaction","detail":"{read_only:false; response_revision:8987; number_of_response:1; }","duration":"284.731292ms","start":"2026-10-14T16:02:23.675661Z","end":"2026-10-14T16:02:23.960392Z","steps":["trace[59565309] 'process raft request' (duration: 223.041273ms)","trace[59565309] 'compare' (duration: 61.419713ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:02:23.960867Z","caller":"traceutil/trace.go:171","msg":"trace[2003027511] transaction","detail":"{read_only:false; response_revision:8988; number_of_response:1; }","duration":"211.776328ms","start":"2026-10-14T16:02:23.749078Z","end":"2026-10-14T16:02:23.960855Z","steps":["trace[2003027511] 'process raft request' (duration: 211.236595ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:02:23.960987Z","caller":"traceutil/trace.go:171","msg":"trace[1561714643] linearizableReadLoop","detail":"{readStateIndex:9309; appliedIndex:9307; }","duration":"182.094725ms","start":"2026-10-14T16:02:23.778869Z","end":"2026-10-14T16:02:23.960964Z","steps":["trace[1561714643] 'read index received' (duration: 119.868684ms)","trace[1561714643] 'applied index is now lower than readState.Index' (duration: 62.223761ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:02:23.961179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.546682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-14T16:02:23.961253Z","caller":"traceutil/trace.go:171","msg":"trace[300960919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8988; }","duration":"200.662035ms","start":"2026-10-14T16:02:23.760578Z","end":"2026-10-14T16:02:23.961241Z","steps":["trace[300960919] 'agreement among raft nodes before linearized reading' (duration: 200.474151ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:03:32.942293Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"bb7d59f4041c8abe","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-14T16:03:32.950172Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-14T16:03:32.950272Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-14T16:03:45.323851Z","caller":"traceutil/trace.go:171","msg":"trace[721273737] transaction","detail":"{read_only:false; response_revision:9730; number_of_response:1; }","duration":"326.568882ms","start":"2026-10-14T16:03:44.997259Z","end":"2026-10-14T16:03:45.323828Z","steps":["trace[721273737] 'process raft request' (duration: 326.441329ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:03:45.323985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:03:44.997238Z","time spent":"326.679534ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T16:05:14.765335Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8010} {"level":"info","ts":"2026-10-14T16:05:14.853058Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8010,"took":"85.558392ms","hash":29642935,"current-db-size-bytes":54910976,"current-db-size":"55 MB","current-db-size-in-use-bytes":25915392,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-14T16:05:14.853164Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":29642935,"revision":8010,"compact-revision":5581} {"level":"info","ts":"2026-10-14T16:07:25.903129Z","caller":"traceutil/trace.go:171","msg":"trace[5524189] linearizableReadLoop","detail":"{readStateIndex:12053; appliedIndex:12052; }","duration":"121.463171ms","start":"2026-10-14T16:07:25.781642Z","end":"2026-10-14T16:07:25.903105Z","steps":["trace[5524189] 'read index received' (duration: 121.242016ms)","trace[5524189] 'applied index is now lower than readState.Index' (duration: 220.185µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:07:25.903228Z","caller":"traceutil/trace.go:171","msg":"trace[103710866] transaction","detail":"{read_only:false; response_revision:11652; number_of_response:1; }","duration":"129.676905ms","start":"2026-10-14T16:07:25.773524Z","end":"2026-10-14T16:07:25.903201Z","steps":["trace[103710866] 'process raft request' (duration: 129.44427ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:07:25.903287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.611564ms","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-10-14T16:07:25.903392Z","caller":"traceutil/trace.go:171","msg":"trace[1257703617] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:11652; }","duration":"121.784088ms","start":"2026-10-14T16:07:25.781597Z","end":"2026-10-14T16:07:25.903381Z","steps":["trace[1257703617] 'agreement among raft nodes before linearized reading' (duration: 121.609094ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:10:14.772943Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10456} {"level":"info","ts":"2026-10-14T16:10:14.860691Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10456,"took":"85.48064ms","hash":671368535,"current-db-size-bytes":54910976,"current-db-size":"55 MB","current-db-size-in-use-bytes":27975680,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-14T16:10:14.8608Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":671368535,"revision":10456,"compact-revision":8010} {"level":"info","ts":"2026-10-14T16:13:18.458166Z","caller":"traceutil/trace.go:171","msg":"trace[1310488376] linearizableReadLoop","detail":"{readStateIndex:14537; appliedIndex:14536; }","duration":"115.850277ms","start":"2026-10-14T16:13:18.342285Z","end":"2026-10-14T16:13:18.458135Z","steps":["trace[1310488376] 'read index received' (duration: 96.9097ms)","trace[1310488376] 'applied index is now lower than readState.Index' (duration: 18.938867ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:13:18.458211Z","caller":"traceutil/trace.go:171","msg":"trace[1229131545] transaction","detail":"{read_only:false; response_revision:14052; number_of_response:1; }","duration":"121.668945ms","start":"2026-10-14T16:13:18.336497Z","end":"2026-10-14T16:13:18.458166Z","steps":["trace[1229131545] 'process raft request' (duration: 102.705987ms)","trace[1229131545] 'compare' (duration: 18.819485ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:13:18.458432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.129564ms","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-10-14T16:13:18.45852Z","caller":"traceutil/trace.go:171","msg":"trace[1698181734] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14052; }","duration":"116.237597ms","start":"2026-10-14T16:13:18.342267Z","end":"2026-10-14T16:13:18.458504Z","steps":["trace[1698181734] 'agreement among raft nodes before linearized reading' (duration: 115.992701ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:13:43.204259Z","caller":"traceutil/trace.go:171","msg":"trace[1026232607] transaction","detail":"{read_only:false; response_revision:14186; number_of_response:1; }","duration":"124.063612ms","start":"2026-10-14T16:13:43.080127Z","end":"2026-10-14T16:13:43.20419Z","steps":["trace[1026232607] 'process raft request' (duration: 123.879687ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:13:59.864439Z","caller":"traceutil/trace.go:171","msg":"trace[1233988503] linearizableReadLoop","detail":"{readStateIndex:14780; appliedIndex:14779; }","duration":"339.452971ms","start":"2026-10-14T16:13:59.524947Z","end":"2026-10-14T16:13:59.8644Z","steps":["trace[1233988503] 'read index received' (duration: 339.053061ms)","trace[1233988503] 'applied index is now lower than readState.Index' (duration: 392.15µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:13:59.864515Z","caller":"traceutil/trace.go:171","msg":"trace[435867500] transaction","detail":"{read_only:false; response_revision:14285; number_of_response:1; }","duration":"440.022658ms","start":"2026-10-14T16:13:59.424464Z","end":"2026-10-14T16:13:59.864487Z","steps":["trace[435867500] 'process raft request' (duration: 439.618838ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:13:59.864718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:13:59.42444Z","time spent":"440.140561ms","remote":"127.0.0.1:47768","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-10-14T16:13:59.864754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.772839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19755"} {"level":"info","ts":"2026-10-14T16:13:59.86489Z","caller":"traceutil/trace.go:171","msg":"trace[605734115] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:14285; }","duration":"339.947253ms","start":"2026-10-14T16:13:59.524893Z","end":"2026-10-14T16:13:59.864841Z","steps":["trace[605734115] 'agreement among raft nodes before linearized reading' (duration: 339.639886ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:13:59.864789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.591547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-14T16:13:59.864951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:13:59.524873Z","time spent":"340.063095ms","remote":"127.0.0.1:47680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":19778,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-10-14T16:13:59.86499Z","caller":"traceutil/trace.go:171","msg":"trace[1440301476] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:14285; }","duration":"282.838533ms","start":"2026-10-14T16:13:59.582135Z","end":"2026-10-14T16:13:59.864973Z","steps":["trace[1440301476] 'agreement among raft nodes before linearized reading' (duration: 282.449204ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:13:59.864784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.02628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-nq6zf\" ","response":"range_response_count:1 size:12364"} {"level":"info","ts":"2026-10-14T16:13:59.865143Z","caller":"traceutil/trace.go:171","msg":"trace[538925404] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-nq6zf; range_end:; response_count:1; response_revision:14285; }","duration":"157.408199ms","start":"2026-10-14T16:13:59.707671Z","end":"2026-10-14T16:13:59.865079Z","steps":["trace[538925404] 'agreement among raft nodes before linearized reading' (duration: 156.966518ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:13:59.865127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.623039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-14T16:13:59.865281Z","caller":"traceutil/trace.go:171","msg":"trace[527190895] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14285; }","duration":"175.877076ms","start":"2026-10-14T16:13:59.689374Z","end":"2026-10-14T16:13:59.865251Z","steps":["trace[527190895] 'agreement among raft nodes before linearized reading' (duration: 175.369604ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:13:59.993671Z","caller":"traceutil/trace.go:171","msg":"trace[1928942553] transaction","detail":"{read_only:false; response_revision:14286; number_of_response:1; }","duration":"123.215352ms","start":"2026-10-14T16:13:59.870424Z","end":"2026-10-14T16:13:59.993639Z","steps":["trace[1928942553] 'process raft request' (duration: 35.712074ms)","trace[1928942553] 'compare' (duration: 87.362635ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:14:00.005645Z","caller":"traceutil/trace.go:171","msg":"trace[1966280391] transaction","detail":"{read_only:false; response_revision:14287; number_of_response:1; }","duration":"124.779778ms","start":"2026-10-14T16:13:59.880848Z","end":"2026-10-14T16:14:00.005628Z","steps":["trace[1966280391] 'process raft request' (duration: 124.675966ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:14:10.142541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.285263ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T16:14:10.142777Z","caller":"traceutil/trace.go:171","msg":"trace[2033183504] transaction","detail":"{read_only:false; response_revision:14455; number_of_response:1; }","duration":"245.752748ms","start":"2026-10-14T16:14:09.897003Z","end":"2026-10-14T16:14:10.142756Z","steps":["trace[2033183504] 'process raft request' (duration: 245.664405ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:14:10.142795Z","caller":"traceutil/trace.go:171","msg":"trace[540594510] linearizableReadLoop","detail":"{readStateIndex:14952; appliedIndex:14951; }","duration":"292.156754ms","start":"2026-10-14T16:14:09.850599Z","end":"2026-10-14T16:14:10.142756Z","steps":["trace[540594510] 'read index received' (duration: 124.573354ms)","trace[540594510] 'applied index is now lower than readState.Index' (duration: 167.581039ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:14:10.142845Z","caller":"traceutil/trace.go:171","msg":"trace[1944683840] transaction","detail":"{read_only:false; response_revision:14454; number_of_response:1; }","duration":"309.78182ms","start":"2026-10-14T16:14:09.832952Z","end":"2026-10-14T16:14:10.142734Z","steps":["trace[1944683840] 'process raft request' (duration: 142.212971ms)","trace[1944683840] 'compare' (duration: 167.042737ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:14:10.143038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.42036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/ovn-northd-6c6687ddd6-6lfgz\" ","response":"range_response_count:1 size:7042"} {"level":"info","ts":"2026-10-14T16:14:10.143122Z","caller":"traceutil/trace.go:171","msg":"trace[1491837093] range","detail":"{range_begin:/registry/pods/openstack/ovn-northd-6c6687ddd6-6lfgz; range_end:; response_count:1; response_revision:14455; }","duration":"292.537413ms","start":"2026-10-14T16:14:09.850564Z","end":"2026-10-14T16:14:10.143102Z","steps":["trace[1491837093] 'agreement among raft nodes before linearized reading' (duration: 292.307257ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:14:10.14325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:14:09.832942Z","time spent":"310.065746ms","remote":"127.0.0.1:47608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T16:14:10.33387Z","caller":"traceutil/trace.go:171","msg":"trace[1768926668] transaction","detail":"{read_only:false; response_revision:14456; number_of_response:1; }","duration":"186.039176ms","start":"2026-10-14T16:14:10.147807Z","end":"2026-10-14T16:14:10.333846Z","steps":["trace[1768926668] 'process raft request' (duration: 155.154596ms)","trace[1768926668] 'compare' (duration: 30.748407ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:14:10.33387Z","caller":"traceutil/trace.go:171","msg":"trace[600596655] linearizableReadLoop","detail":"{readStateIndex:14954; appliedIndex:14953; }","duration":"180.885944ms","start":"2026-10-14T16:14:10.152953Z","end":"2026-10-14T16:14:10.333839Z","steps":["trace[600596655] 'read index received' (duration: 150.021874ms)","trace[600596655] 'applied index is now lower than readState.Index' (duration: 30.86289ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:14:10.334077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.100839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jqn6g\" ","response":"range_response_count:1 size:6522"} {"level":"info","ts":"2026-10-14T16:14:10.334141Z","caller":"traceutil/trace.go:171","msg":"trace[1861461917] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jqn6g; range_end:; response_count:1; response_revision:14456; }","duration":"181.204852ms","start":"2026-10-14T16:14:10.152919Z","end":"2026-10-14T16:14:10.334124Z","steps":["trace[1861461917] 'agreement among raft nodes before linearized reading' (duration: 180.998907ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:14:10.337451Z","caller":"traceutil/trace.go:171","msg":"trace[795809664] transaction","detail":"{read_only:false; response_revision:14457; number_of_response:1; }","duration":"183.638519ms","start":"2026-10-14T16:14:10.153762Z","end":"2026-10-14T16:14:10.3374Z","steps":["trace[795809664] 'process raft request' (duration: 182.84564ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:14:10.337688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.126258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-10-14T16:14:10.337744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.656307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T16:14:10.33782Z","caller":"traceutil/trace.go:171","msg":"trace[1807827817] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14457; }","duration":"130.732909ms","start":"2026-10-14T16:14:10.207073Z","end":"2026-10-14T16:14:10.337806Z","steps":["trace[1807827817] 'agreement among raft nodes before linearized reading' (duration: 130.625256ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:14:10.3378Z","caller":"traceutil/trace.go:171","msg":"trace[708674029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14457; }","duration":"120.233851ms","start":"2026-10-14T16:14:10.21753Z","end":"2026-10-14T16:14:10.337764Z","steps":["trace[708674029] 'agreement among raft nodes before linearized reading' (duration: 119.984155ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:14:10.33866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.440855ms","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-10-14T16:14:10.338745Z","caller":"traceutil/trace.go:171","msg":"trace[1213560646] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14457; }","duration":"164.573568ms","start":"2026-10-14T16:14:10.174153Z","end":"2026-10-14T16:14:10.338726Z","steps":["trace[1213560646] 'agreement among raft nodes before linearized reading' (duration: 162.645923ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:15:14.784254Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12786} {"level":"info","ts":"2026-10-14T16:15:14.867872Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12786,"took":"80.898602ms","hash":2202438544,"current-db-size-bytes":54910976,"current-db-size":"55 MB","current-db-size-in-use-bytes":31535104,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-14T16:15:14.867938Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2202438544,"revision":12786,"compact-revision":10456} {"level":"info","ts":"2026-10-14T16:15:51.04069Z","caller":"traceutil/trace.go:171","msg":"trace[644114203] linearizableReadLoop","detail":"{readStateIndex:16078; appliedIndex:16076; }","duration":"140.165021ms","start":"2026-10-14T16:15:50.900493Z","end":"2026-10-14T16:15:51.040658Z","steps":["trace[644114203] 'read index received' (duration: 13.478678ms)","trace[644114203] 'applied index is now lower than readState.Index' (duration: 126.685003ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:15:51.04101Z","caller":"traceutil/trace.go:171","msg":"trace[1947075550] transaction","detail":"{read_only:false; response_revision:15548; number_of_response:1; }","duration":"148.961959ms","start":"2026-10-14T16:15:50.891797Z","end":"2026-10-14T16:15:51.040759Z","steps":["trace[1947075550] 'process raft request' (duration: 126.618831ms)","trace[1947075550] 'compare' (duration: 21.57355ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:15:51.041011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.491869ms","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-10-14T16:15:51.041381Z","caller":"traceutil/trace.go:171","msg":"trace[1184429666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15548; }","duration":"140.893129ms","start":"2026-10-14T16:15:50.900469Z","end":"2026-10-14T16:15:51.041362Z","steps":["trace[1184429666] 'agreement among raft nodes before linearized reading' (duration: 140.383157ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:20:14.791445Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15353} {"level":"info","ts":"2026-10-14T16:20:14.892985Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15353,"took":"98.354404ms","hash":2265266718,"current-db-size-bytes":54910976,"current-db-size":"55 MB","current-db-size-in-use-bytes":31522816,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-14T16:20:14.893074Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2265266718,"revision":15353,"compact-revision":12786} {"level":"info","ts":"2026-10-14T16:21:25.119401Z","caller":"traceutil/trace.go:171","msg":"trace[1190165371] transaction","detail":"{read_only:false; response_revision:18000; number_of_response:1; }","duration":"162.109288ms","start":"2026-10-14T16:21:24.957258Z","end":"2026-10-14T16:21:25.119368Z","steps":["trace[1190165371] 'process raft request' (duration: 149.566922ms)","trace[1190165371] 'compare' (duration: 12.353402ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:21:25.129354Z","caller":"traceutil/trace.go:171","msg":"trace[1705295805] linearizableReadLoop","detail":"{readStateIndex:18615; appliedIndex:18612; }","duration":"166.438451ms","start":"2026-10-14T16:21:24.962897Z","end":"2026-10-14T16:21:25.129336Z","steps":["trace[1705295805] 'read index received' (duration: 143.94308ms)","trace[1705295805] 'applied index is now lower than readState.Index' (duration: 22.494531ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:21:25.129449Z","caller":"traceutil/trace.go:171","msg":"trace[241563900] transaction","detail":"{read_only:false; response_revision:18001; number_of_response:1; }","duration":"171.668334ms","start":"2026-10-14T16:21:24.957755Z","end":"2026-10-14T16:21:25.129423Z","steps":["trace[241563900] 'process raft request' (duration: 171.335406ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:21:25.129611Z","caller":"traceutil/trace.go:171","msg":"trace[856496287] transaction","detail":"{read_only:false; response_revision:18002; number_of_response:1; }","duration":"169.79056ms","start":"2026-10-14T16:21:24.959807Z","end":"2026-10-14T16:21:25.129597Z","steps":["trace[856496287] 'process raft request' (duration: 169.460942ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:21:25.130064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.14376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-10-14T16:21:25.13011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.191098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1344"} {"level":"info","ts":"2026-10-14T16:21:25.130161Z","caller":"traceutil/trace.go:171","msg":"trace[218462762] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18002; }","duration":"154.253233ms","start":"2026-10-14T16:21:24.975886Z","end":"2026-10-14T16:21:25.130139Z","steps":["trace[218462762] 'agreement among raft nodes before linearized reading' (duration: 154.055508ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:21:25.130259Z","caller":"traceutil/trace.go:171","msg":"trace[954027564] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:18002; }","duration":"167.347622ms","start":"2026-10-14T16:21:24.962841Z","end":"2026-10-14T16:21:25.130189Z","steps":["trace[954027564] 'agreement among raft nodes before linearized reading' (duration: 167.078386ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:21:25.130772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.442954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-14T16:21:25.130831Z","caller":"traceutil/trace.go:171","msg":"trace[809509392] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18002; }","duration":"157.50493ms","start":"2026-10-14T16:21:24.97331Z","end":"2026-10-14T16:21:25.130815Z","steps":["trace[809509392] 'agreement among raft nodes before linearized reading' (duration: 156.354343ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:21:30.602362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.63087ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-14T16:21:30.602653Z","caller":"traceutil/trace.go:171","msg":"trace[501177370] transaction","detail":"{read_only:false; response_revision:18083; number_of_response:1; }","duration":"219.651608ms","start":"2026-10-14T16:21:30.382947Z","end":"2026-10-14T16:21:30.602599Z","steps":["trace[501177370] 'process raft request' (duration: 92.70578ms)","trace[501177370] 'compare' (duration: 126.509367ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:21:30.604116Z","caller":"traceutil/trace.go:171","msg":"trace[1051511016] linearizableReadLoop","detail":"{readStateIndex:18697; appliedIndex:18696; }","duration":"132.923969ms","start":"2026-10-14T16:21:30.471172Z","end":"2026-10-14T16:21:30.604096Z","steps":["trace[1051511016] 'read index received' (duration: 4.404734ms)","trace[1051511016] 'applied index is now lower than readState.Index' (duration: 128.517755ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:21:30.604407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.221716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/rabbitmq-heat-server\" ","response":"range_response_count:1 size:700"} {"level":"info","ts":"2026-10-14T16:21:30.604508Z","caller":"traceutil/trace.go:171","msg":"trace[1325612748] range","detail":"{range_begin:/registry/serviceaccounts/openstack/rabbitmq-heat-server; range_end:; response_count:1; response_revision:18083; }","duration":"133.359559ms","start":"2026-10-14T16:21:30.47112Z","end":"2026-10-14T16:21:30.60448Z","steps":["trace[1325612748] 'agreement among raft nodes before linearized reading' (duration: 133.112233ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:21:30.605107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.177096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-10-14T16:21:30.605173Z","caller":"traceutil/trace.go:171","msg":"trace[2070485506] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:18083; }","duration":"125.278588ms","start":"2026-10-14T16:21:30.479881Z","end":"2026-10-14T16:21:30.605159Z","steps":["trace[2070485506] 'agreement among raft nodes before linearized reading' (duration: 124.430858ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:21:30.87552Z","caller":"traceutil/trace.go:171","msg":"trace[823008442] linearizableReadLoop","detail":"{readStateIndex:18698; appliedIndex:18697; }","duration":"205.343889ms","start":"2026-10-14T16:21:30.670157Z","end":"2026-10-14T16:21:30.875501Z","steps":["trace[823008442] 'read index received' (duration: 173.473387ms)","trace[823008442] 'applied index is now lower than readState.Index' (duration: 31.869482ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:21:30.875726Z","caller":"traceutil/trace.go:171","msg":"trace[1885870188] transaction","detail":"{read_only:false; response_revision:18084; number_of_response:1; }","duration":"230.264137ms","start":"2026-10-14T16:21:30.645449Z","end":"2026-10-14T16:21:30.875713Z","steps":["trace[1885870188] 'process raft request' (duration: 198.16801ms)","trace[1885870188] 'compare' (duration: 31.79271ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:21:30.87578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.593505ms","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:8"} {"level":"info","ts":"2026-10-14T16:21:30.875876Z","caller":"traceutil/trace.go:171","msg":"trace[203959090] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:18084; }","duration":"205.741569ms","start":"2026-10-14T16:21:30.670111Z","end":"2026-10-14T16:21:30.875853Z","steps":["trace[203959090] 'agreement among raft nodes before linearized reading' (duration: 205.559634ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:21:30.902421Z","caller":"traceutil/trace.go:171","msg":"trace[738522242] transaction","detail":"{read_only:false; response_revision:18085; number_of_response:1; }","duration":"132.195031ms","start":"2026-10-14T16:21:30.770197Z","end":"2026-10-14T16:21:30.902392Z","steps":["trace[738522242] 'process raft request' (duration: 131.70296ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:21:30.903259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.915722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-57lcp\" ","response":"range_response_count:1 size:22126"} {"level":"info","ts":"2026-10-14T16:21:30.903331Z","caller":"traceutil/trace.go:171","msg":"trace[1969213365] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-57lcp; range_end:; response_count:1; response_revision:18085; }","duration":"145.031905ms","start":"2026-10-14T16:21:30.758283Z","end":"2026-10-14T16:21:30.903315Z","steps":["trace[1969213365] 'agreement among raft nodes before linearized reading' (duration: 144.840971ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:21:31.090923Z","caller":"traceutil/trace.go:171","msg":"trace[1915944983] transaction","detail":"{read_only:false; response_revision:18087; number_of_response:1; }","duration":"177.147442ms","start":"2026-10-14T16:21:30.913749Z","end":"2026-10-14T16:21:31.090897Z","steps":["trace[1915944983] 'process raft request' (duration: 176.691721ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:21:31.09127Z","caller":"traceutil/trace.go:171","msg":"trace[812495014] transaction","detail":"{read_only:false; response_revision:18088; number_of_response:1; }","duration":"171.761715ms","start":"2026-10-14T16:21:30.91948Z","end":"2026-10-14T16:21:31.091242Z","steps":["trace[812495014] 'process raft request' (duration: 171.240373ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:21:31.091137Z","caller":"traceutil/trace.go:171","msg":"trace[1316485959] linearizableReadLoop","detail":"{readStateIndex:18701; appliedIndex:18699; }","duration":"172.84491ms","start":"2026-10-14T16:21:30.918277Z","end":"2026-10-14T16:21:31.091122Z","steps":["trace[1316485959] 'read index received' (duration: 35.754454ms)","trace[1316485959] 'applied index is now lower than readState.Index' (duration: 137.089616ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:21:31.092459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.133411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:94 size:925736"} {"level":"info","ts":"2026-10-14T16:21:31.092526Z","caller":"traceutil/trace.go:171","msg":"trace[1458723356] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:94; response_revision:18088; }","duration":"174.266384ms","start":"2026-10-14T16:21:30.918244Z","end":"2026-10-14T16:21:31.09251Z","steps":["trace[1458723356] 'agreement among raft nodes before linearized reading' (duration: 173.101837ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:23:55.038638Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"bb7d59f4041c8abe","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-14T16:23:55.048124Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-14T16:23:55.04828Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-14T16:25:14.797778Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17500} {"level":"info","ts":"2026-10-14T16:25:14.897486Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17500,"took":"96.530549ms","hash":714940458,"current-db-size-bytes":54910976,"current-db-size":"55 MB","current-db-size-in-use-bytes":34197504,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-14T16:25:14.897576Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":714940458,"revision":17500,"compact-revision":15353} {"level":"info","ts":"2026-10-14T16:27:08.115765Z","caller":"traceutil/trace.go:171","msg":"trace[273525543] transaction","detail":"{read_only:false; response_revision:20643; number_of_response:1; }","duration":"130.676423ms","start":"2026-10-14T16:27:07.985066Z","end":"2026-10-14T16:27:08.115743Z","steps":["trace[273525543] 'process raft request' (duration: 130.522959ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:08.774051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.160039ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:42"} {"level":"info","ts":"2026-10-14T16:27:08.774394Z","caller":"traceutil/trace.go:171","msg":"trace[1244738969] transaction","detail":"{read_only:false; response_revision:20645; number_of_response:1; }","duration":"239.755837ms","start":"2026-10-14T16:27:08.534618Z","end":"2026-10-14T16:27:08.774373Z","steps":["trace[1244738969] 'process raft request' (duration: 239.690306ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:27:08.774604Z","caller":"traceutil/trace.go:171","msg":"trace[1075863048] transaction","detail":"{read_only:false; response_revision:20644; number_of_response:1; }","duration":"401.597406ms","start":"2026-10-14T16:27:08.372989Z","end":"2026-10-14T16:27:08.774586Z","steps":["trace[1075863048] 'process raft request' (duration: 401.195737ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:08.774669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:08.345363Z","time spent":"429.29818ms","remote":"127.0.0.1:47608","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-10-14T16:27:08.774729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:08.372957Z","time spent":"401.690638ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T16:27:08.774743Z","caller":"traceutil/trace.go:171","msg":"trace[52834492] linearizableReadLoop","detail":"{readStateIndex:21343; appliedIndex:21342; }","duration":"424.109507ms","start":"2026-10-14T16:27:08.350562Z","end":"2026-10-14T16:27:08.774672Z","steps":["trace[52834492] 'read index received' (duration: 182.941587ms)","trace[52834492] 'applied index is now lower than readState.Index' (duration: 241.16218ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:27:08.774973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.390744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"info","ts":"2026-10-14T16:27:08.775052Z","caller":"traceutil/trace.go:171","msg":"trace[1322843567] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:20645; }","duration":"424.534517ms","start":"2026-10-14T16:27:08.350496Z","end":"2026-10-14T16:27:08.77503Z","steps":["trace[1322843567] 'agreement among raft nodes before linearized reading' (duration: 424.320882ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:08.77513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:08.350473Z","time spent":"424.613009ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":585,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-10-14T16:27:09.085864Z","caller":"traceutil/trace.go:171","msg":"trace[939418239] linearizableReadLoop","detail":"{readStateIndex:21346; appliedIndex:21345; }","duration":"310.982318ms","start":"2026-10-14T16:27:08.774825Z","end":"2026-10-14T16:27:09.085807Z","steps":["trace[939418239] 'read index received' (duration: 310.756553ms)","trace[939418239] 'applied index is now lower than readState.Index' (duration: 224.405µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:27:09.085999Z","caller":"traceutil/trace.go:171","msg":"trace[1165688225] transaction","detail":"{read_only:false; response_revision:20646; number_of_response:1; }","duration":"327.267312ms","start":"2026-10-14T16:27:08.758713Z","end":"2026-10-14T16:27:09.08598Z","steps":["trace[1165688225] 'process raft request' (duration: 326.890953ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:09.086355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:08.758688Z","time spent":"327.351565ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T16:27:09.086434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.875371ms","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:8"} {"level":"info","ts":"2026-10-14T16:27:09.086525Z","caller":"traceutil/trace.go:171","msg":"trace[398494507] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:20646; }","duration":"521.368193ms","start":"2026-10-14T16:27:08.565134Z","end":"2026-10-14T16:27:09.086502Z","steps":["trace[398494507] 'agreement among raft nodes before linearized reading' (duration: 520.885901ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:09.086576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:08.565088Z","time spent":"521.473085ms","remote":"127.0.0.1:47432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-10-14T16:27:09.086626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.028526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-14T16:27:09.086683Z","caller":"traceutil/trace.go:171","msg":"trace[1198089237] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20646; }","duration":"338.129119ms","start":"2026-10-14T16:27:08.748538Z","end":"2026-10-14T16:27:09.086667Z","steps":["trace[1198089237] 'agreement among raft nodes before linearized reading' (duration: 337.871172ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:09.086733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.20405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"warn","ts":"2026-10-14T16:27:09.086721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:08.748515Z","time spent":"338.1988ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-14T16:27:09.086797Z","caller":"traceutil/trace.go:171","msg":"trace[2108445249] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:20646; }","duration":"702.312482ms","start":"2026-10-14T16:27:08.384467Z","end":"2026-10-14T16:27:09.086779Z","steps":["trace[2108445249] 'agreement among raft nodes before linearized reading' (duration: 702.129148ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:09.086843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:08.384441Z","time spent":"702.391954ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":556,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-10-14T16:27:09.10392Z","caller":"traceutil/trace.go:171","msg":"trace[858152763] transaction","detail":"{read_only:false; response_revision:20647; number_of_response:1; }","duration":"327.989779ms","start":"2026-10-14T16:27:08.775913Z","end":"2026-10-14T16:27:09.103903Z","steps":["trace[858152763] 'process raft request' (duration: 327.811885ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:27:09.104192Z","caller":"traceutil/trace.go:171","msg":"trace[921957605] transaction","detail":"{read_only:false; response_revision:20648; number_of_response:1; }","duration":"323.984845ms","start":"2026-10-14T16:27:08.780177Z","end":"2026-10-14T16:27:09.104161Z","steps":["trace[921957605] 'process raft request' (duration: 323.678278ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:09.10409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:08.775899Z","time spent":"328.088042ms","remote":"127.0.0.1:47608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1163,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T16:27:09.104338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:08.780161Z","time spent":"324.108948ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T16:27:09.104499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.981955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-14T16:27:09.10462Z","caller":"traceutil/trace.go:171","msg":"trace[1094836383] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20648; }","duration":"171.152219ms","start":"2026-10-14T16:27:08.93345Z","end":"2026-10-14T16:27:09.104602Z","steps":["trace[1094836383] 'agreement among raft nodes before linearized reading' (duration: 170.78244ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:09.104688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.833606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:423"} {"level":"info","ts":"2026-10-14T16:27:09.104741Z","caller":"traceutil/trace.go:171","msg":"trace[1949400472] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:20648; }","duration":"327.925828ms","start":"2026-10-14T16:27:08.7768Z","end":"2026-10-14T16:27:09.104726Z","steps":["trace[1949400472] 'agreement among raft nodes before linearized reading' (duration: 327.272792ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:09.104786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:08.776781Z","time spent":"327.99521ms","remote":"127.0.0.1:47672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":446,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-10-14T16:27:09.555352Z","caller":"traceutil/trace.go:171","msg":"trace[1762319122] linearizableReadLoop","detail":"{readStateIndex:21350; appliedIndex:21348; }","duration":"448.82239ms","start":"2026-10-14T16:27:09.106505Z","end":"2026-10-14T16:27:09.555328Z","steps":["trace[1762319122] 'read index received' (duration: 378.188864ms)","trace[1762319122] 'applied index is now lower than readState.Index' (duration: 70.632596ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:27:09.555482Z","caller":"traceutil/trace.go:171","msg":"trace[1684831297] transaction","detail":"{read_only:false; response_revision:20650; number_of_response:1; }","duration":"461.756356ms","start":"2026-10-14T16:27:09.093711Z","end":"2026-10-14T16:27:09.555467Z","steps":["trace[1684831297] 'process raft request' (duration: 461.569481ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:27:09.555485Z","caller":"traceutil/trace.go:171","msg":"trace[1220153626] transaction","detail":"{read_only:false; response_revision:20649; number_of_response:1; }","duration":"462.555815ms","start":"2026-10-14T16:27:09.092888Z","end":"2026-10-14T16:27:09.555444Z","steps":["trace[1220153626] 'process raft request' (duration: 391.788275ms)","trace[1220153626] 'compare' (duration: 70.456473ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:27:09.555603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:09.093689Z","time spent":"461.826458ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T16:27:09.55563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:09.092863Z","time spent":"462.687478ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T16:27:09.555696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.163188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-10-14T16:27:09.555768Z","caller":"traceutil/trace.go:171","msg":"trace[540585454] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:20650; }","duration":"449.289851ms","start":"2026-10-14T16:27:09.106461Z","end":"2026-10-14T16:27:09.555751Z","steps":["trace[540585454] 'agreement among raft nodes before linearized reading' (duration: 449.063856ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:09.555807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:09.106447Z","time spent":"449.350814ms","remote":"127.0.0.1:47576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":163,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"warn","ts":"2026-10-14T16:27:09.560164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.816556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-14T16:27:09.560255Z","caller":"traceutil/trace.go:171","msg":"trace[890037953] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20652; }","duration":"405.944899ms","start":"2026-10-14T16:27:09.154293Z","end":"2026-10-14T16:27:09.560238Z","steps":["trace[890037953] 'agreement among raft nodes before linearized reading' (duration: 405.763295ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:09.560285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:09.154272Z","time spent":"406.00548ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-14T16:27:09.560454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.757414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-14T16:27:09.561037Z","caller":"traceutil/trace.go:171","msg":"trace[1640188691] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20652; }","duration":"403.367898ms","start":"2026-10-14T16:27:09.157638Z","end":"2026-10-14T16:27:09.561006Z","steps":["trace[1640188691] 'agreement among raft nodes before linearized reading' (duration: 402.415926ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:09.561213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:09.157628Z","time spent":"403.563653ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-10-14T16:27:09.56049Z","caller":"traceutil/trace.go:171","msg":"trace[1986255263] transaction","detail":"{read_only:false; response_revision:20651; number_of_response:1; }","duration":"451.721099ms","start":"2026-10-14T16:27:09.10874Z","end":"2026-10-14T16:27:09.560461Z","steps":["trace[1986255263] 'process raft request' (duration: 451.150315ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:09.561535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:09.108723Z","time spent":"452.725273ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T16:27:09.560508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.644266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-10-14T16:27:09.561675Z","caller":"traceutil/trace.go:171","msg":"trace[1115266209] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20652; }","duration":"432.843234ms","start":"2026-10-14T16:27:09.128806Z","end":"2026-10-14T16:27:09.561649Z","steps":["trace[1115266209] 'agreement among raft nodes before linearized reading' (duration: 431.479121ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:09.561741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:09.128794Z","time spent":"432.928146ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-14T16:27:09.560552Z","caller":"traceutil/trace.go:171","msg":"trace[1774498930] transaction","detail":"{read_only:false; response_revision:20652; number_of_response:1; }","duration":"419.309964ms","start":"2026-10-14T16:27:09.14123Z","end":"2026-10-14T16:27:09.56054Z","steps":["trace[1774498930] 'process raft request' (duration: 418.762181ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:09.561863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:09.141213Z","time spent":"420.588655ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T16:27:09.560616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.788663ms","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-10-14T16:27:09.561949Z","caller":"traceutil/trace.go:171","msg":"trace[1293525572] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20652; }","duration":"423.186916ms","start":"2026-10-14T16:27:09.138727Z","end":"2026-10-14T16:27:09.561914Z","steps":["trace[1293525572] 'agreement among raft nodes before linearized reading' (duration: 421.67544ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:09.562014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:09.138711Z","time spent":"423.287019ms","remote":"127.0.0.1:47768","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":"info","ts":"2026-10-14T16:27:09.954392Z","caller":"traceutil/trace.go:171","msg":"trace[1157433171] transaction","detail":"{read_only:false; response_revision:20654; number_of_response:1; }","duration":"388.158869ms","start":"2026-10-14T16:27:09.566204Z","end":"2026-10-14T16:27:09.954363Z","steps":["trace[1157433171] 'process raft request' (duration: 387.709328ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:09.954537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:09.566176Z","time spent":"388.286112ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T16:27:09.954406Z","caller":"traceutil/trace.go:171","msg":"trace[743303660] transaction","detail":"{read_only:false; response_revision:20655; number_of_response:1; }","duration":"387.713128ms","start":"2026-10-14T16:27:09.566663Z","end":"2026-10-14T16:27:09.954376Z","steps":["trace[743303660] 'process raft request' (duration: 387.557825ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:09.954744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:09.566644Z","time spent":"387.998605ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T16:27:09.954949Z","caller":"traceutil/trace.go:171","msg":"trace[48166649] transaction","detail":"{read_only:false; response_revision:20656; number_of_response:1; }","duration":"386.52789ms","start":"2026-10-14T16:27:09.568404Z","end":"2026-10-14T16:27:09.954932Z","steps":["trace[48166649] 'process raft request' (duration: 385.889165ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:27:09.955036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:27:09.568369Z","time spent":"386.627313ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T16:27:09.963276Z","caller":"traceutil/trace.go:171","msg":"trace[646603526] transaction","detail":"{read_only:false; response_revision:20657; number_of_response:1; }","duration":"244.303194ms","start":"2026-10-14T16:27:09.718958Z","end":"2026-10-14T16:27:09.963261Z","steps":["trace[646603526] 'process raft request' (duration: 244.003237ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:30:14.804354Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19944} {"level":"info","ts":"2026-10-14T16:30:14.925998Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19944,"took":"118.069886ms","hash":1497167409,"current-db-size-bytes":54910976,"current-db-size":"55 MB","current-db-size-in-use-bytes":30064640,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-14T16:30:14.926096Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1497167409,"revision":19944,"compact-revision":17500} {"level":"info","ts":"2026-10-14T16:31:04.039388Z","caller":"traceutil/trace.go:171","msg":"trace[257074752] transaction","detail":"{read_only:false; response_revision:23094; number_of_response:1; }","duration":"105.878858ms","start":"2026-10-14T16:31:03.93345Z","end":"2026-10-14T16:31:04.039329Z","steps":["trace[257074752] 'process raft request' (duration: 105.680713ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:32:32.143342Z","caller":"traceutil/trace.go:171","msg":"trace[737077430] transaction","detail":"{read_only:false; response_revision:24040; number_of_response:1; }","duration":"177.5895ms","start":"2026-10-14T16:32:31.965486Z","end":"2026-10-14T16:32:32.143075Z","steps":["trace[737077430] 'process raft request' (duration: 177.134599ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:20.170669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.890287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-14T16:34:20.170773Z","caller":"traceutil/trace.go:171","msg":"trace[917395429] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25036; }","duration":"115.044421ms","start":"2026-10-14T16:34:20.055711Z","end":"2026-10-14T16:34:20.170755Z","steps":["trace[917395429] 'range keys from in-memory index tree' (duration: 114.669122ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:34:25.565787Z","caller":"traceutil/trace.go:171","msg":"trace[37043235] transaction","detail":"{read_only:false; response_revision:25075; number_of_response:1; }","duration":"146.618924ms","start":"2026-10-14T16:34:25.419136Z","end":"2026-10-14T16:34:25.565754Z","steps":["trace[37043235] 'process raft request' (duration: 146.46338ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:25.741623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.798336ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-14T16:34:25.742091Z","caller":"traceutil/trace.go:171","msg":"trace[186723093] linearizableReadLoop","detail":"{readStateIndex:25900; appliedIndex:25899; }","duration":"299.436765ms","start":"2026-10-14T16:34:25.442638Z","end":"2026-10-14T16:34:25.742074Z","steps":["trace[186723093] 'read index received' (duration: 123.122471ms)","trace[186723093] 'applied index is now lower than readState.Index' (duration: 176.312914ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:34:25.742106Z","caller":"traceutil/trace.go:171","msg":"trace[1014310954] transaction","detail":"{read_only:false; response_revision:25076; number_of_response:1; }","duration":"317.111101ms","start":"2026-10-14T16:34:25.424974Z","end":"2026-10-14T16:34:25.742085Z","steps":["trace[1014310954] 'process raft request' (duration: 206.731521ms)","trace[1014310954] 'compare' (duration: 109.656003ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:34:25.742188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:34:25.424953Z","time spent":"317.191183ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T16:34:25.742213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.563128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/services/\" range_end:\"/registry/openstack.k-orc.cloud/services0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T16:34:25.742245Z","caller":"traceutil/trace.go:171","msg":"trace[1948487336] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/services/; range_end:/registry/openstack.k-orc.cloud/services0; response_count:0; response_revision:25076; }","duration":"299.605609ms","start":"2026-10-14T16:34:25.442633Z","end":"2026-10-14T16:34:25.742239Z","steps":["trace[1948487336] 'agreement among raft nodes before linearized reading' (duration: 299.534917ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:25.749116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.083436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:186"} {"level":"info","ts":"2026-10-14T16:34:25.749186Z","caller":"traceutil/trace.go:171","msg":"trace[339777716] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:25077; }","duration":"265.194937ms","start":"2026-10-14T16:34:25.483976Z","end":"2026-10-14T16:34:25.749171Z","steps":["trace[339777716] 'agreement among raft nodes before linearized reading' (duration: 265.004923ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:25.749369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.105632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-14T16:34:25.749381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.89976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-10-14T16:34:25.749404Z","caller":"traceutil/trace.go:171","msg":"trace[811976563] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:25077; }","duration":"126.961232ms","start":"2026-10-14T16:34:25.622436Z","end":"2026-10-14T16:34:25.749398Z","steps":["trace[811976563] 'agreement among raft nodes before linearized reading' (duration: 126.826198ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:34:25.749403Z","caller":"traceutil/trace.go:171","msg":"trace[172800793] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:25077; }","duration":"157.174243ms","start":"2026-10-14T16:34:25.592221Z","end":"2026-10-14T16:34:25.749395Z","steps":["trace[172800793] 'agreement among raft nodes before linearized reading' (duration: 157.117681ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:34:25.944168Z","caller":"traceutil/trace.go:171","msg":"trace[1870553152] transaction","detail":"{read_only:false; response_revision:25078; number_of_response:1; }","duration":"174.369168ms","start":"2026-10-14T16:34:25.769778Z","end":"2026-10-14T16:34:25.944147Z","steps":["trace[1870553152] 'process raft request' (duration: 164.750241ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:34:26.29844Z","caller":"traceutil/trace.go:171","msg":"trace[1122538204] transaction","detail":"{read_only:false; response_revision:25079; number_of_response:1; }","duration":"348.796157ms","start":"2026-10-14T16:34:25.949617Z","end":"2026-10-14T16:34:26.298413Z","steps":["trace[1122538204] 'process raft request' (duration: 348.646794ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:26.298607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:34:25.949596Z","time spent":"348.936651ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T16:34:26.325328Z","caller":"traceutil/trace.go:171","msg":"trace[1630118825] transaction","detail":"{read_only:false; response_revision:25080; number_of_response:1; }","duration":"326.988184ms","start":"2026-10-14T16:34:25.998319Z","end":"2026-10-14T16:34:26.325307Z","steps":["trace[1630118825] 'process raft request' (duration: 326.82727ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:26.32547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:34:25.998299Z","time spent":"327.095196ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T16:34:26.325708Z","caller":"traceutil/trace.go:171","msg":"trace[1676120306] transaction","detail":"{read_only:false; response_revision:25081; number_of_response:1; }","duration":"134.049718ms","start":"2026-10-14T16:34:26.191641Z","end":"2026-10-14T16:34:26.325691Z","steps":["trace[1676120306] 'process raft request' (duration: 133.628698ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:34:26.325704Z","caller":"traceutil/trace.go:171","msg":"trace[452062656] linearizableReadLoop","detail":"{readStateIndex:25905; appliedIndex:25902; }","duration":"126.504771ms","start":"2026-10-14T16:34:26.199167Z","end":"2026-10-14T16:34:26.325671Z","steps":["trace[452062656] 'read index received' (duration: 99.070164ms)","trace[452062656] 'applied index is now lower than readState.Index' (duration: 27.433597ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:34:26.325892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.705315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-14T16:34:26.325945Z","caller":"traceutil/trace.go:171","msg":"trace[1574722915] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25082; }","duration":"126.798588ms","start":"2026-10-14T16:34:26.199135Z","end":"2026-10-14T16:34:26.325933Z","steps":["trace[1574722915] 'agreement among raft nodes before linearized reading' (duration: 126.617693ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:26.325899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.282224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T16:34:26.326147Z","caller":"traceutil/trace.go:171","msg":"trace[331366078] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25082; }","duration":"120.496509ms","start":"2026-10-14T16:34:26.205586Z","end":"2026-10-14T16:34:26.326082Z","steps":["trace[331366078] 'agreement among raft nodes before linearized reading' (duration: 120.279574ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:26.326391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.145851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-14T16:34:26.326468Z","caller":"traceutil/trace.go:171","msg":"trace[848470446] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25082; }","duration":"120.250173ms","start":"2026-10-14T16:34:26.206198Z","end":"2026-10-14T16:34:26.326448Z","steps":["trace[848470446] 'agreement among raft nodes before linearized reading' (duration: 119.927115ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:34:26.536336Z","caller":"traceutil/trace.go:171","msg":"trace[506610093] transaction","detail":"{read_only:false; response_revision:25083; number_of_response:1; }","duration":"206.27182ms","start":"2026-10-14T16:34:26.33004Z","end":"2026-10-14T16:34:26.536312Z","steps":["trace[506610093] 'process raft request' (duration: 175.206058ms)","trace[506610093] 'compare' (duration: 30.534719ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:34:26.537883Z","caller":"traceutil/trace.go:171","msg":"trace[1337147687] linearizableReadLoop","detail":"{readStateIndex:25909; appliedIndex:25906; }","duration":"206.464875ms","start":"2026-10-14T16:34:26.331396Z","end":"2026-10-14T16:34:26.537861Z","steps":["trace[1337147687] 'read index received' (duration: 173.864726ms)","trace[1337147687] 'applied index is now lower than readState.Index' (duration: 32.599349ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:34:26.538124Z","caller":"traceutil/trace.go:171","msg":"trace[1224089864] transaction","detail":"{read_only:false; response_revision:25084; number_of_response:1; }","duration":"207.663562ms","start":"2026-10-14T16:34:26.330449Z","end":"2026-10-14T16:34:26.538113Z","steps":["trace[1224089864] 'process raft request' (duration: 207.249803ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:34:26.538295Z","caller":"traceutil/trace.go:171","msg":"trace[272163356] transaction","detail":"{read_only:false; response_revision:25085; number_of_response:1; }","duration":"207.489298ms","start":"2026-10-14T16:34:26.330794Z","end":"2026-10-14T16:34:26.538283Z","steps":["trace[272163356] 'process raft request' (duration: 207.015987ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:26.53853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.084569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-14T16:34:26.538569Z","caller":"traceutil/trace.go:171","msg":"trace[1605667862] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25085; }","duration":"207.207902ms","start":"2026-10-14T16:34:26.331352Z","end":"2026-10-14T16:34:26.53856Z","steps":["trace[1605667862] 'agreement among raft nodes before linearized reading' (duration: 207.032908ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:26.538705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.750024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/magnum-api-64d5b4c446-chw6t\" ","response":"range_response_count:1 size:8652"} {"level":"info","ts":"2026-10-14T16:34:26.53874Z","caller":"traceutil/trace.go:171","msg":"trace[2104677444] range","detail":"{range_begin:/registry/pods/openstack/magnum-api-64d5b4c446-chw6t; range_end:; response_count:1; response_revision:25085; }","duration":"117.819236ms","start":"2026-10-14T16:34:26.420907Z","end":"2026-10-14T16:34:26.538726Z","steps":["trace[2104677444] 'agreement among raft nodes before linearized reading' (duration: 117.731624ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:42.846694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19233"} {"level":"info","ts":"2026-10-14T16:34:42.846833Z","caller":"traceutil/trace.go:171","msg":"trace[141057366] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25260; }","duration":"470.480945ms","start":"2026-10-14T16:34:42.376319Z","end":"2026-10-14T16:34:42.8468Z","steps":["trace[141057366] 'range keys from in-memory index tree' (duration: 470.121536ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:42.846891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:34:42.376312Z","time spent":"470.564347ms","remote":"127.0.0.1:47680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":19256,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-10-14T16:34:42.846848Z","caller":"traceutil/trace.go:171","msg":"trace[1082713656] transaction","detail":"{read_only:false; response_revision:25261; number_of_response:1; }","duration":"456.435093ms","start":"2026-10-14T16:34:42.390373Z","end":"2026-10-14T16:34:42.846808Z","steps":["trace[1082713656] 'process raft request' (duration: 382.927371ms)","trace[1082713656] 'compare' (duration: 73.172764ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:34:42.847043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:34:42.390353Z","time spent":"456.598877ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T16:34:42.940106Z","caller":"traceutil/trace.go:171","msg":"trace[870038218] transaction","detail":"{read_only:false; response_revision:25262; number_of_response:1; }","duration":"546.672279ms","start":"2026-10-14T16:34:42.393394Z","end":"2026-10-14T16:34:42.940066Z","steps":["trace[870038218] 'process raft request' (duration: 546.482155ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:42.940315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:34:42.393381Z","time spent":"546.808682ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T16:34:42.940562Z","caller":"traceutil/trace.go:171","msg":"trace[565395767] transaction","detail":"{read_only:false; response_revision:25264; number_of_response:1; }","duration":"507.123368ms","start":"2026-10-14T16:34:42.433425Z","end":"2026-10-14T16:34:42.940549Z","steps":["trace[565395767] 'process raft request' (duration: 506.758499ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:34:42.940555Z","caller":"traceutil/trace.go:171","msg":"trace[1749833513] linearizableReadLoop","detail":"{readStateIndex:26089; appliedIndex:26087; }","duration":"539.692915ms","start":"2026-10-14T16:34:42.400788Z","end":"2026-10-14T16:34:42.940481Z","steps":["trace[1749833513] 'read index received' (duration: 372.410554ms)","trace[1749833513] 'applied index is now lower than readState.Index' (duration: 167.280591ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:34:42.94067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:34:42.433406Z","time spent":"507.191359ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T16:34:42.940858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.044763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-10-14T16:34:42.940889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.508402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-14T16:34:42.94039Z","caller":"traceutil/trace.go:171","msg":"trace[1207086740] transaction","detail":"{read_only:false; response_revision:25263; number_of_response:1; }","duration":"535.67378ms","start":"2026-10-14T16:34:42.404685Z","end":"2026-10-14T16:34:42.940359Z","steps":["trace[1207086740] 'process raft request' (duration: 535.342362ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:34:42.940924Z","caller":"traceutil/trace.go:171","msg":"trace[520602005] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25264; }","duration":"540.125135ms","start":"2026-10-14T16:34:42.400781Z","end":"2026-10-14T16:34:42.940907Z","steps":["trace[520602005] 'agreement among raft nodes before linearized reading' (duration: 539.90693ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:34:42.940926Z","caller":"traceutil/trace.go:171","msg":"trace[399610728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25264; }","duration":"295.588404ms","start":"2026-10-14T16:34:42.645327Z","end":"2026-10-14T16:34:42.940916Z","steps":["trace[399610728] 'agreement among raft nodes before linearized reading' (duration: 295.452241ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:42.940973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:34:42.400748Z","time spent":"540.211817ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-14T16:34:42.940891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.793817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2083"} {"level":"info","ts":"2026-10-14T16:34:42.941089Z","caller":"traceutil/trace.go:171","msg":"trace[1330923047] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:25264; }","duration":"467.028683ms","start":"2026-10-14T16:34:42.474038Z","end":"2026-10-14T16:34:42.941067Z","steps":["trace[1330923047] 'agreement among raft nodes before linearized reading' (duration: 466.720186ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:42.941164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:34:42.474017Z","time spent":"467.133756ms","remote":"127.0.0.1:47670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2106,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-10-14T16:34:42.941192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.647131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-10-14T16:34:42.941182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.778759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-10-14T16:34:42.941221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:34:42.404679Z","time spent":"536.272685ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T16:34:42.941247Z","caller":"traceutil/trace.go:171","msg":"trace[1084103714] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25264; }","duration":"267.870211ms","start":"2026-10-14T16:34:42.673366Z","end":"2026-10-14T16:34:42.941237Z","steps":["trace[1084103714] 'agreement among raft nodes before linearized reading' (duration: 267.722237ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:34:42.941276Z","caller":"traceutil/trace.go:171","msg":"trace[1609477040] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25264; }","duration":"302.737613ms","start":"2026-10-14T16:34:42.638493Z","end":"2026-10-14T16:34:42.941231Z","steps":["trace[1609477040] 'agreement among raft nodes before linearized reading' (duration: 302.60945ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:42.941324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:34:42.638485Z","time spent":"302.826925ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-14T16:34:42.941184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.819777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T16:34:42.941424Z","caller":"traceutil/trace.go:171","msg":"trace[523820043] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:25264; }","duration":"152.104964ms","start":"2026-10-14T16:34:42.789293Z","end":"2026-10-14T16:34:42.941398Z","steps":["trace[523820043] 'agreement among raft nodes before linearized reading' (duration: 151.790576ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:42.94147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.982119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-10-14T16:34:42.941688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.147431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-14T16:34:42.941836Z","caller":"traceutil/trace.go:171","msg":"trace[284808122] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25264; }","duration":"297.373126ms","start":"2026-10-14T16:34:42.644429Z","end":"2026-10-14T16:34:42.941802Z","steps":["trace[284808122] 'agreement among raft nodes before linearized reading' (duration: 296.926336ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:34:42.941746Z","caller":"traceutil/trace.go:171","msg":"trace[2025388055] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25264; }","duration":"306.300936ms","start":"2026-10-14T16:34:42.635428Z","end":"2026-10-14T16:34:42.941729Z","steps":["trace[2025388055] 'agreement among raft nodes before linearized reading' (duration: 305.973829ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:42.941983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:34:42.6354Z","time spent":"306.569632ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-14T16:34:43.092814Z","caller":"traceutil/trace.go:171","msg":"trace[1058166087] transaction","detail":"{read_only:false; response_revision:25265; number_of_response:1; }","duration":"143.990442ms","start":"2026-10-14T16:34:42.948787Z","end":"2026-10-14T16:34:43.092778Z","steps":["trace[1058166087] 'process raft request' (duration: 131.888577ms)","trace[1058166087] 'compare' (duration: 11.739476ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:34:43.101567Z","caller":"traceutil/trace.go:171","msg":"trace[450957661] transaction","detail":"{read_only:false; response_revision:25267; number_of_response:1; }","duration":"152.394541ms","start":"2026-10-14T16:34:42.949155Z","end":"2026-10-14T16:34:43.101549Z","steps":["trace[450957661] 'process raft request' (duration: 152.303119ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:34:43.101835Z","caller":"traceutil/trace.go:171","msg":"trace[2018119628] transaction","detail":"{read_only:false; response_revision:25268; number_of_response:1; }","duration":"151.338055ms","start":"2026-10-14T16:34:42.950482Z","end":"2026-10-14T16:34:43.10182Z","steps":["trace[2018119628] 'process raft request' (duration: 151.009708ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:34:43.101927Z","caller":"traceutil/trace.go:171","msg":"trace[2045889369] transaction","detail":"{read_only:false; response_revision:25269; number_of_response:1; }","duration":"151.272864ms","start":"2026-10-14T16:34:42.950625Z","end":"2026-10-14T16:34:43.101898Z","steps":["trace[2045889369] 'process raft request' (duration: 151.09728ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:34:43.10202Z","caller":"traceutil/trace.go:171","msg":"trace[707717446] linearizableReadLoop","detail":"{readStateIndex:26096; appliedIndex:26091; }","duration":"150.804973ms","start":"2026-10-14T16:34:42.951191Z","end":"2026-10-14T16:34:43.101996Z","steps":["trace[707717446] 'read index received' (duration: 129.45254ms)","trace[707717446] 'applied index is now lower than readState.Index' (duration: 21.350633ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:34:43.102053Z","caller":"traceutil/trace.go:171","msg":"trace[455282429] transaction","detail":"{read_only:false; response_revision:25270; number_of_response:1; }","duration":"149.135364ms","start":"2026-10-14T16:34:42.952893Z","end":"2026-10-14T16:34:43.102028Z","steps":["trace[455282429] 'process raft request' (duration: 148.9585ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:34:43.102299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.08038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-0ae19f37-8921-43ce-a37c-a133f517e68e\" ","response":"range_response_count:1 size:1436"} {"level":"info","ts":"2026-10-14T16:34:43.102369Z","caller":"traceutil/trace.go:171","msg":"trace[1094527498] range","detail":"{range_begin:/registry/persistentvolumes/pvc-0ae19f37-8921-43ce-a37c-a133f517e68e; range_end:; response_count:1; response_revision:25270; }","duration":"151.184852ms","start":"2026-10-14T16:34:42.951164Z","end":"2026-10-14T16:34:43.102349Z","steps":["trace[1094527498] 'agreement among raft nodes before linearized reading' (duration: 150.963096ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:34:43.101604Z","caller":"traceutil/trace.go:171","msg":"trace[1908560068] transaction","detail":"{read_only:false; response_revision:25266; number_of_response:1; }","duration":"152.760519ms","start":"2026-10-14T16:34:42.948797Z","end":"2026-10-14T16:34:43.101558Z","steps":["trace[1908560068] 'process raft request' (duration: 152.574425ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:35:14.811452Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22196} {"level":"info","ts":"2026-10-14T16:35:14.926309Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22196,"took":"110.876632ms","hash":89665109,"current-db-size-bytes":57028608,"current-db-size":"57 MB","current-db-size-in-use-bytes":44224512,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-10-14T16:35:14.926377Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":89665109,"revision":22196,"compact-revision":19944} {"level":"info","ts":"2026-10-14T16:35:27.345429Z","caller":"traceutil/trace.go:171","msg":"trace[1455710240] transaction","detail":"{read_only:false; response_revision:25661; number_of_response:1; }","duration":"294.157781ms","start":"2026-10-14T16:35:27.051243Z","end":"2026-10-14T16:35:27.345401Z","steps":["trace[1455710240] 'process raft request' (duration: 293.987867ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:35:27.699429Z","caller":"traceutil/trace.go:171","msg":"trace[1093107023] transaction","detail":"{read_only:false; response_revision:25662; number_of_response:1; }","duration":"588.038404ms","start":"2026-10-14T16:35:27.111333Z","end":"2026-10-14T16:35:27.699372Z","steps":["trace[1093107023] 'process raft request' (duration: 541.294103ms)","trace[1093107023] 'compare' (duration: 46.534486ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:35:27.699627Z","caller":"traceutil/trace.go:171","msg":"trace[1972698243] linearizableReadLoop","detail":"{readStateIndex:26500; appliedIndex:26498; }","duration":"492.194606ms","start":"2026-10-14T16:35:27.20738Z","end":"2026-10-14T16:35:27.699575Z","steps":["trace[1972698243] 'read index received' (duration: 138.023812ms)","trace[1972698243] 'applied index is now lower than readState.Index' (duration: 354.169564ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T16:35:27.699662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:35:27.111309Z","time spent":"588.221369ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T16:35:27.699821Z","caller":"traceutil/trace.go:171","msg":"trace[1577596982] transaction","detail":"{read_only:false; response_revision:25663; number_of_response:1; }","duration":"566.707821ms","start":"2026-10-14T16:35:27.133097Z","end":"2026-10-14T16:35:27.699805Z","steps":["trace[1577596982] 'process raft request' (duration: 566.197009ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:35:27.699864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.462262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-14T16:35:27.699918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:35:27.133064Z","time spent":"566.803444ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T16:35:27.699929Z","caller":"traceutil/trace.go:171","msg":"trace[880745123] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25663; }","duration":"492.538464ms","start":"2026-10-14T16:35:27.207373Z","end":"2026-10-14T16:35:27.699912Z","steps":["trace[880745123] 'agreement among raft nodes before linearized reading' (duration: 492.422011ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:35:27.699974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:35:27.207319Z","time spent":"492.645276ms","remote":"127.0.0.1:47524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-14T16:35:27.699985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.876348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-10-14T16:35:27.700274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.614641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T16:35:27.700292Z","caller":"traceutil/trace.go:171","msg":"trace[1164352762] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25663; }","duration":"301.126214ms","start":"2026-10-14T16:35:27.399057Z","end":"2026-10-14T16:35:27.700184Z","steps":["trace[1164352762] 'agreement among raft nodes before linearized reading' (duration: 300.831767ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:35:27.700319Z","caller":"traceutil/trace.go:171","msg":"trace[1547781914] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:25663; }","duration":"235.658292ms","start":"2026-10-14T16:35:27.464647Z","end":"2026-10-14T16:35:27.700306Z","steps":["trace[1547781914] 'agreement among raft nodes before linearized reading' (duration: 235.546369ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:35:27.700344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:35:27.399037Z","time spent":"301.292199ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":582,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-10-14T16:35:27.700398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.463957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-10-14T16:35:27.700428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.398765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-10-14T16:35:27.700419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.082014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-10-14T16:35:27.700449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.258794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-14T16:35:27.700481Z","caller":"traceutil/trace.go:171","msg":"trace[1741394556] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25663; }","duration":"291.511408ms","start":"2026-10-14T16:35:27.408955Z","end":"2026-10-14T16:35:27.700466Z","steps":["trace[1741394556] 'agreement among raft nodes before linearized reading' (duration: 291.340094ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:35:27.700487Z","caller":"traceutil/trace.go:171","msg":"trace[22127480] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25663; }","duration":"263.573179ms","start":"2026-10-14T16:35:27.436876Z","end":"2026-10-14T16:35:27.700449Z","steps":["trace[22127480] 'agreement among raft nodes before linearized reading' (duration: 263.386705ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:35:27.700499Z","caller":"traceutil/trace.go:171","msg":"trace[1797804555] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25663; }","duration":"276.196357ms","start":"2026-10-14T16:35:27.424284Z","end":"2026-10-14T16:35:27.70048Z","steps":["trace[1797804555] 'agreement among raft nodes before linearized reading' (duration: 275.965362ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:35:27.700503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.805911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-14T16:35:27.700523Z","caller":"traceutil/trace.go:171","msg":"trace[1514933154] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25663; }","duration":"269.357476ms","start":"2026-10-14T16:35:27.431142Z","end":"2026-10-14T16:35:27.7005Z","steps":["trace[1514933154] 'agreement among raft nodes before linearized reading' (duration: 269.12914ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:35:27.700615Z","caller":"traceutil/trace.go:171","msg":"trace[1161907821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25663; }","duration":"276.949555ms","start":"2026-10-14T16:35:27.423647Z","end":"2026-10-14T16:35:27.700596Z","steps":["trace[1161907821] 'agreement among raft nodes before linearized reading' (duration: 276.669268ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:35:27.902634Z","caller":"traceutil/trace.go:171","msg":"trace[2123208669] transaction","detail":"{read_only:false; response_revision:25664; number_of_response:1; }","duration":"196.033168ms","start":"2026-10-14T16:35:27.706572Z","end":"2026-10-14T16:35:27.902605Z","steps":["trace[2123208669] 'process raft request' (duration: 171.885099ms)","trace[2123208669] 'compare' (duration: 23.992886ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:35:28.063143Z","caller":"traceutil/trace.go:171","msg":"trace[287501291] transaction","detail":"{read_only:false; response_revision:25667; number_of_response:1; }","duration":"356.383077ms","start":"2026-10-14T16:35:27.706692Z","end":"2026-10-14T16:35:28.063075Z","steps":["trace[287501291] 'process raft request' (duration: 356.308035ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:35:28.063327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:35:27.70667Z","time spent":"356.567351ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T16:35:28.063403Z","caller":"traceutil/trace.go:171","msg":"trace[904791903] linearizableReadLoop","detail":"{readStateIndex:26506; appliedIndex:26500; }","duration":"205.982443ms","start":"2026-10-14T16:35:27.857402Z","end":"2026-10-14T16:35:28.063384Z","steps":["trace[904791903] 'read index received' (duration: 21.072397ms)","trace[904791903] 'applied index is now lower than readState.Index' (duration: 184.909046ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:35:28.063526Z","caller":"traceutil/trace.go:171","msg":"trace[1995576296] transaction","detail":"{read_only:false; response_revision:25665; number_of_response:1; }","duration":"356.872248ms","start":"2026-10-14T16:35:27.706643Z","end":"2026-10-14T16:35:28.063515Z","steps":["trace[1995576296] 'process raft request' (duration: 354.552144ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:35:28.063614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:35:27.706625Z","time spent":"356.95549ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T16:35:28.063673Z","caller":"traceutil/trace.go:171","msg":"trace[123803546] transaction","detail":"{read_only:false; response_revision:25670; number_of_response:1; }","duration":"190.874546ms","start":"2026-10-14T16:35:27.872782Z","end":"2026-10-14T16:35:28.063656Z","steps":["trace[123803546] 'process raft request' (duration: 190.499858ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:35:28.063959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.544566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1989"} {"level":"info","ts":"2026-10-14T16:35:28.063988Z","caller":"traceutil/trace.go:171","msg":"trace[849912249] transaction","detail":"{read_only:false; response_revision:25666; number_of_response:1; }","duration":"357.311978ms","start":"2026-10-14T16:35:27.706661Z","end":"2026-10-14T16:35:28.063973Z","steps":["trace[849912249] 'process raft request' (duration: 356.284134ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:35:28.064024Z","caller":"traceutil/trace.go:171","msg":"trace[371713966] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:25670; }","duration":"206.660319ms","start":"2026-10-14T16:35:27.857346Z","end":"2026-10-14T16:35:28.064006Z","steps":["trace[371713966] 'agreement among raft nodes before linearized reading' (duration: 206.463464ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:35:28.064058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:35:27.70664Z","time spent":"357.38304ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T16:35:28.064259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.799558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T16:35:28.064328Z","caller":"traceutil/trace.go:171","msg":"trace[1410880654] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:25673; }","duration":"129.909771ms","start":"2026-10-14T16:35:27.934402Z","end":"2026-10-14T16:35:28.064311Z","steps":["trace[1410880654] 'agreement among raft nodes before linearized reading' (duration: 129.760837ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:35:28.063353Z","caller":"traceutil/trace.go:171","msg":"trace[1624475506] transaction","detail":"{read_only:false; response_revision:25669; number_of_response:1; }","duration":"356.53641ms","start":"2026-10-14T16:35:27.706791Z","end":"2026-10-14T16:35:28.063327Z","steps":["trace[1624475506] 'process raft request' (duration: 356.382846ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:35:28.064518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:35:27.706742Z","time spent":"357.673906ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T16:35:28.064669Z","caller":"traceutil/trace.go:171","msg":"trace[850792033] transaction","detail":"{read_only:false; response_revision:25668; number_of_response:1; }","duration":"357.904492ms","start":"2026-10-14T16:35:27.706751Z","end":"2026-10-14T16:35:28.064655Z","steps":["trace[850792033] 'process raft request' (duration: 356.287184ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T16:35:28.064745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T16:35:27.706704Z","time spent":"358.004054ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T16:35:49.934257Z","caller":"traceutil/trace.go:171","msg":"trace[1520946696] transaction","detail":"{read_only:false; response_revision:25824; number_of_response:1; }","duration":"132.999743ms","start":"2026-10-14T16:35:49.801222Z","end":"2026-10-14T16:35:49.934222Z","steps":["trace[1520946696] 'process raft request' (duration: 49.634829ms)","trace[1520946696] 'compare' (duration: 83.220991ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T16:36:01.10071Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068d6.wal"} {"level":"info","ts":"2026-10-14T16:40:14.820979Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25573} {"level":"info","ts":"2026-10-14T16:40:14.991695Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25573,"took":"165.382235ms","hash":1681295209,"current-db-size-bytes":59576320,"current-db-size":"60 MB","current-db-size-in-use-bytes":35610624,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-14T16:40:14.991792Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1681295209,"revision":25573,"compact-revision":22196} {"level":"info","ts":"2026-10-14T16:41:42.24831Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"bb7d59f4041c8abe","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-14T16:41:42.2551Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-14T16:41:42.25524Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-14T16:45:14.830607Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28432} {"level":"info","ts":"2026-10-14T16:45:14.985765Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28432,"took":"150.999827ms","hash":3383138045,"current-db-size-bytes":59576320,"current-db-size":"60 MB","current-db-size-in-use-bytes":30670848,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-14T16:45:14.985845Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3383138045,"revision":28432,"compact-revision":25573} {"level":"info","ts":"2026-10-14T16:50:14.837098Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30659} {"level":"info","ts":"2026-10-14T16:50:14.960888Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30659,"took":"119.764261ms","hash":80395377,"current-db-size-bytes":59576320,"current-db-size":"60 MB","current-db-size-in-use-bytes":30982144,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-14T16:50:14.960954Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":80395377,"revision":30659,"compact-revision":28432} {"level":"info","ts":"2026-10-14T16:55:06.952506Z","caller":"traceutil/trace.go:171","msg":"trace[874318758] transaction","detail":"{read_only:false; response_revision:35127; number_of_response:1; }","duration":"104.185776ms","start":"2026-10-14T16:55:06.848261Z","end":"2026-10-14T16:55:06.952447Z","steps":["trace[874318758] 'process raft request' (duration: 103.801607ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T16:55:14.846724Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32912} {"level":"info","ts":"2026-10-14T16:55:15.019858Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32912,"took":"168.910552ms","hash":3223319135,"current-db-size-bytes":59576320,"current-db-size":"60 MB","current-db-size-in-use-bytes":30404608,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-14T16:55:15.019996Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3223319135,"revision":32912,"compact-revision":30659} {"level":"info","ts":"2026-10-14T17:00:14.861231Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35206} {"level":"info","ts":"2026-10-14T17:00:14.991201Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35206,"took":"124.552306ms","hash":2414164542,"current-db-size-bytes":59576320,"current-db-size":"60 MB","current-db-size-in-use-bytes":32768000,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-14T17:00:14.991277Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2414164542,"revision":35206,"compact-revision":32912} {"level":"info","ts":"2026-10-14T17:03:06.787267Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"bb7d59f4041c8abe","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-14T17:03:06.793723Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-14T17:03:06.794147Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-14T17:05:14.873781Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37481} {"level":"info","ts":"2026-10-14T17:05:15.005386Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37481,"took":"128.458599ms","hash":3479572369,"current-db-size-bytes":59998208,"current-db-size":"60 MB","current-db-size-in-use-bytes":33021952,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-14T17:05:15.005442Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3479572369,"revision":37481,"compact-revision":35206}