{"level":"warn","ts":"2026-09-10T01:54:36.519325Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-10T01:54:36.519502Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.128: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.128:2380","--initial-cluster=instance=https://162.253.55.128:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.128:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.128: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-09-10T01:54:36.519653Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-10T01:54:36.519677Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.128:2380"]} {"level":"info","ts":"2026-09-10T01:54:36.519708Z","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-09-10T01:54:36.521077Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.128:2379"]} {"level":"info","ts":"2026-09-10T01:54:36.521226Z","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.128:2380"],"listen-peer-urls":["https://162.253.55.128:2380"],"advertise-client-urls":["https://162.253.55.128:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.128:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.128: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-09-10T01:54:36.526058Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.413264ms"} {"level":"info","ts":"2026-09-10T01:54:36.532618Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3e8b7bea2e3a32b","cluster-id":"ca619600f96ab468"} {"level":"info","ts":"2026-09-10T01:54:36.532718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b switched to configuration voters=()"} {"level":"info","ts":"2026-09-10T01:54:36.532744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b became follower at term 0"} {"level":"info","ts":"2026-09-10T01:54:36.532758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3e8b7bea2e3a32b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-10T01:54:36.53277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b became follower at term 1"} {"level":"info","ts":"2026-09-10T01:54:36.53281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b switched to configuration voters=(16422578070611010347)"} {"level":"warn","ts":"2026-09-10T01:54:36.543004Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-10T01:54:36.544422Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-10T01:54:36.545826Z","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-09-10T01:54:36.548559Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3e8b7bea2e3a32b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-10T01:54:36.549383Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3e8b7bea2e3a32b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-10T01:54:36.549386Z","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-09-10T01:54:36.55031Z","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-09-10T01:54:36.550343Z","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-09-10T01:54:36.55212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b switched to configuration voters=(16422578070611010347)"} {"level":"info","ts":"2026-09-10T01:54:36.552336Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ca619600f96ab468","local-member-id":"e3e8b7bea2e3a32b","added-peer-id":"e3e8b7bea2e3a32b","added-peer-peer-urls":["https://162.253.55.128:2380"]} {"level":"info","ts":"2026-09-10T01:54:36.556356Z","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-09-10T01:54:36.556736Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3e8b7bea2e3a32b","initial-advertise-peer-urls":["https://162.253.55.128:2380"],"listen-peer-urls":["https://162.253.55.128:2380"],"advertise-client-urls":["https://162.253.55.128:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.128:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-10T01:54:36.556796Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-10T01:54:36.557548Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.128:2380"} {"level":"info","ts":"2026-09-10T01:54:36.557615Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.128:2380"} {"level":"info","ts":"2026-09-10T01:54:36.633748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b is starting a new election at term 1"} {"level":"info","ts":"2026-09-10T01:54:36.633828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b became pre-candidate at term 1"} {"level":"info","ts":"2026-09-10T01:54:36.63387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b received MsgPreVoteResp from e3e8b7bea2e3a32b at term 1"} {"level":"info","ts":"2026-09-10T01:54:36.633893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b became candidate at term 2"} {"level":"info","ts":"2026-09-10T01:54:36.633911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b received MsgVoteResp from e3e8b7bea2e3a32b at term 2"} {"level":"info","ts":"2026-09-10T01:54:36.633927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b became leader at term 2"} {"level":"info","ts":"2026-09-10T01:54:36.63394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3e8b7bea2e3a32b elected leader e3e8b7bea2e3a32b at term 2"} {"level":"info","ts":"2026-09-10T01:54:36.635743Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3e8b7bea2e3a32b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.128:2379]}","request-path":"/0/members/e3e8b7bea2e3a32b/attributes","cluster-id":"ca619600f96ab468","publish-timeout":"7s"} {"level":"info","ts":"2026-09-10T01:54:36.637009Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-10T01:54:36.637298Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-10T01:54:36.637428Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-10T01:54:36.637458Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-10T01:54:36.637487Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-10T01:54:36.640081Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.128:2379"} {"level":"info","ts":"2026-09-10T01:54:36.641387Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ca619600f96ab468","local-member-id":"e3e8b7bea2e3a32b","cluster-version":"3.5"} {"level":"info","ts":"2026-09-10T01:54:36.641525Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-10T01:54:36.64161Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-10T01:54:36.641274Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-10T01:55:16.259664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.75376ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-09-10T01:55:16.259835Z","caller":"traceutil/trace.go:171","msg":"trace[450695509] linearizableReadLoop","detail":"{readStateIndex:554; appliedIndex:553; }","duration":"123.504301ms","start":"2026-09-10T01:55:16.136307Z","end":"2026-09-10T01:55:16.259811Z","steps":["trace[450695509] 'read index received' (duration: 125.844µs)","trace[450695509] 'applied index is now lower than readState.Index' (duration: 123.376597ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T01:55:16.259974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.642226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T01:55:16.260073Z","caller":"traceutil/trace.go:171","msg":"trace[1136278802] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:537; }","duration":"123.7906ms","start":"2026-09-10T01:55:16.136256Z","end":"2026-09-10T01:55:16.260047Z","steps":["trace[1136278802] 'agreement among raft nodes before linearized reading' (duration: 123.620885ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:55:23.487675Z","caller":"traceutil/trace.go:171","msg":"trace[473644546] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"610.573116ms","start":"2026-09-10T01:55:22.877064Z","end":"2026-09-10T01:55:23.487637Z","steps":["trace[473644546] 'process raft request' (duration: 608.205654ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:55:23.487835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.811201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-10T01:55:23.487897Z","caller":"traceutil/trace.go:171","msg":"trace[742120244] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:642; }","duration":"391.928075ms","start":"2026-09-10T01:55:23.095956Z","end":"2026-09-10T01:55:23.487884Z","steps":["trace[742120244] 'agreement among raft nodes before linearized reading' (duration: 391.75411ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:55:23.487684Z","caller":"traceutil/trace.go:171","msg":"trace[1586552113] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:662; }","duration":"391.597615ms","start":"2026-09-10T01:55:23.096001Z","end":"2026-09-10T01:55:23.487599Z","steps":["trace[1586552113] 'read index received' (duration: 386.420908ms)","trace[1586552113] 'applied index is now lower than readState.Index' (duration: 5.172187ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T01:55:23.487945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:55:23.095936Z","time spent":"392.000017ms","remote":"127.0.0.1:39016","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":"warn","ts":"2026-09-10T01:55:23.488423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:55:22.877029Z","time spent":"610.742601ms","remote":"127.0.0.1:38856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T01:55:23.49111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.950477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-10T01:55:23.49118Z","caller":"traceutil/trace.go:171","msg":"trace[819400443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:643; }","duration":"395.06855ms","start":"2026-09-10T01:55:23.096094Z","end":"2026-09-10T01:55:23.491163Z","steps":["trace[819400443] 'agreement among raft nodes before linearized reading' (duration: 394.876504ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:55:23.491217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:55:23.096061Z","time spent":"395.148922ms","remote":"127.0.0.1:39016","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-09-10T01:55:23.491465Z","caller":"traceutil/trace.go:171","msg":"trace[1250399033] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"115.096095ms","start":"2026-09-10T01:55:23.376355Z","end":"2026-09-10T01:55:23.491451Z","steps":["trace[1250399033] 'process raft request' (duration: 114.506738ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:55:23.491652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.864252ms","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-09-10T01:55:23.491681Z","caller":"traceutil/trace.go:171","msg":"trace[914439899] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:643; }","duration":"335.913124ms","start":"2026-09-10T01:55:23.155757Z","end":"2026-09-10T01:55:23.491671Z","steps":["trace[914439899] 'agreement among raft nodes before linearized reading' (duration: 335.8087ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:55:23.491703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:55:23.155746Z","time spent":"335.950925ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-10T01:55:23.491906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.002904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T01:55:23.491938Z","caller":"traceutil/trace.go:171","msg":"trace[714694401] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"356.058966ms","start":"2026-09-10T01:55:23.135866Z","end":"2026-09-10T01:55:23.491925Z","steps":["trace[714694401] 'agreement among raft nodes before linearized reading' (duration: 356.011865ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:55:23.491961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:55:23.135853Z","time spent":"356.102447ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-10T01:55:23.879866Z","caller":"traceutil/trace.go:171","msg":"trace[473421282] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"384.075797ms","start":"2026-09-10T01:55:23.495759Z","end":"2026-09-10T01:55:23.879834Z","steps":["trace[473421282] 'process raft request' (duration: 358.696846ms)","trace[473421282] 'compare' (duration: 25.141374ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T01:55:23.880087Z","caller":"traceutil/trace.go:171","msg":"trace[1170511068] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:665; }","duration":"296.737384ms","start":"2026-09-10T01:55:23.583327Z","end":"2026-09-10T01:55:23.880064Z","steps":["trace[1170511068] 'read index received' (duration: 271.221749ms)","trace[1170511068] 'applied index is now lower than readState.Index' (duration: 25.514655ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T01:55:23.880176Z","caller":"traceutil/trace.go:171","msg":"trace[1238945824] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"318.092202ms","start":"2026-09-10T01:55:23.562053Z","end":"2026-09-10T01:55:23.880146Z","steps":["trace[1238945824] 'process raft request' (duration: 317.912687ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:55:23.880091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:55:23.495744Z","time spent":"384.214301ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T01:55:23.880266Z","caller":"traceutil/trace.go:171","msg":"trace[523165349] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"383.404866ms","start":"2026-09-10T01:55:23.496792Z","end":"2026-09-10T01:55:23.880197Z","steps":["trace[523165349] 'process raft request' (duration: 382.998534ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:55:23.880327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:55:23.562021Z","time spent":"318.225156ms","remote":"127.0.0.1:39088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-10T01:55:23.880303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.95699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kdvrm\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-10T01:55:23.88064Z","caller":"traceutil/trace.go:171","msg":"trace[1791488091] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kdvrm; range_end:; response_count:1; response_revision:647; }","duration":"297.262889ms","start":"2026-09-10T01:55:23.583289Z","end":"2026-09-10T01:55:23.880552Z","steps":["trace[1791488091] 'agreement among raft nodes before linearized reading' (duration: 296.863828ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:55:23.880488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:55:23.49676Z","time spent":"383.608372ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T01:55:24.141052Z","caller":"traceutil/trace.go:171","msg":"trace[1411922582] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"200.14766ms","start":"2026-09-10T01:55:23.940864Z","end":"2026-09-10T01:55:24.141012Z","steps":["trace[1411922582] 'read index received' (duration: 198.368386ms)","trace[1411922582] 'applied index is now lower than readState.Index' (duration: 1.777964ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T01:55:24.141117Z","caller":"traceutil/trace.go:171","msg":"trace[308438897] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"230.538382ms","start":"2026-09-10T01:55:23.910543Z","end":"2026-09-10T01:55:24.141082Z","steps":["trace[308438897] 'process raft request' (duration: 228.771129ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:55:24.141292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.405217ms","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-09-10T01:55:24.14136Z","caller":"traceutil/trace.go:171","msg":"trace[878796892] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:648; }","duration":"200.530582ms","start":"2026-09-10T01:55:23.940818Z","end":"2026-09-10T01:55:24.141348Z","steps":["trace[878796892] 'agreement among raft nodes before linearized reading' (duration: 200.316874ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:55:25.979429Z","caller":"traceutil/trace.go:171","msg":"trace[127387512] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"120.671205ms","start":"2026-09-10T01:55:25.858731Z","end":"2026-09-10T01:55:25.979402Z","steps":["trace[127387512] 'process raft request' (duration: 103.656389ms)","trace[127387512] 'compare' (duration: 16.870362ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T01:55:41.089475Z","caller":"traceutil/trace.go:171","msg":"trace[1237450822] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"384.979194ms","start":"2026-09-10T01:55:40.70446Z","end":"2026-09-10T01:55:41.08944Z","steps":["trace[1237450822] 'process raft request' (duration: 384.753467ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:55:41.08971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:55:40.704446Z","time spent":"385.131948ms","remote":"127.0.0.1:38930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T01:56:12.458984Z","caller":"traceutil/trace.go:171","msg":"trace[703455805] linearizableReadLoop","detail":"{readStateIndex:1258; appliedIndex:1257; }","duration":"225.175949ms","start":"2026-09-10T01:56:12.233789Z","end":"2026-09-10T01:56:12.458965Z","steps":["trace[703455805] 'read index received' (duration: 224.995944ms)","trace[703455805] 'applied index is now lower than readState.Index' (duration: 179.355µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T01:56:12.459052Z","caller":"traceutil/trace.go:171","msg":"trace[1003984027] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"225.561893ms","start":"2026-09-10T01:56:12.233458Z","end":"2026-09-10T01:56:12.459019Z","steps":["trace[1003984027] 'process raft request' (duration: 225.398297ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:56:12.45916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.357886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-10T01:56:12.459189Z","caller":"traceutil/trace.go:171","msg":"trace[2119046077] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1225; }","duration":"225.424028ms","start":"2026-09-10T01:56:12.233757Z","end":"2026-09-10T01:56:12.459181Z","steps":["trace[2119046077] 'agreement among raft nodes before linearized reading' (duration: 225.308385ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:57:01.821765Z","caller":"traceutil/trace.go:171","msg":"trace[1942894251] linearizableReadLoop","detail":"{readStateIndex:1985; appliedIndex:1984; }","duration":"330.623856ms","start":"2026-09-10T01:57:01.491096Z","end":"2026-09-10T01:57:01.82172Z","steps":["trace[1942894251] 'read index received' (duration: 330.42557ms)","trace[1942894251] 'applied index is now lower than readState.Index' (duration: 197.426µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T01:57:01.821831Z","caller":"traceutil/trace.go:171","msg":"trace[134371476] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"435.780253ms","start":"2026-09-10T01:57:01.386012Z","end":"2026-09-10T01:57:01.821793Z","steps":["trace[134371476] 'process raft request' (duration: 435.561787ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:57:01.821998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.862084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-09-10T01:57:01.822004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:57:01.385985Z","time spent":"435.917078ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T01:57:01.822041Z","caller":"traceutil/trace.go:171","msg":"trace[844405949] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1914; }","duration":"330.999808ms","start":"2026-09-10T01:57:01.491029Z","end":"2026-09-10T01:57:01.822029Z","steps":["trace[844405949] 'agreement among raft nodes before linearized reading' (duration: 330.814722ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:57:01.822084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:57:01.490996Z","time spent":"331.07697ms","remote":"127.0.0.1:41098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-09-10T01:57:02.182696Z","caller":"traceutil/trace.go:171","msg":"trace[1909394548] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"163.666831ms","start":"2026-09-10T01:57:02.018992Z","end":"2026-09-10T01:57:02.182658Z","steps":["trace[1909394548] 'process raft request' (duration: 163.482675ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:57:02.416081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.110754ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-10T01:57:02.416348Z","caller":"traceutil/trace.go:171","msg":"trace[1795353451] linearizableReadLoop","detail":"{readStateIndex:1987; appliedIndex:1985; }","duration":"349.083985ms","start":"2026-09-10T01:57:02.067211Z","end":"2026-09-10T01:57:02.416295Z","steps":["trace[1795353451] 'read index received' (duration: 115.243073ms)","trace[1795353451] 'applied index is now lower than readState.Index' (duration: 233.837942ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T01:57:02.416467Z","caller":"traceutil/trace.go:171","msg":"trace[1914469294] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"396.10565ms","start":"2026-09-10T01:57:02.020317Z","end":"2026-09-10T01:57:02.416423Z","steps":["trace[1914469294] 'process raft request' (duration: 255.556382ms)","trace[1914469294] 'compare' (duration: 139.97604ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T01:57:02.416661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:57:02.020291Z","time spent":"396.261284ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T01:57:02.41667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.432827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-332410e2-34d5-45be-836c-0617e26dacbd\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-10T01:57:02.416752Z","caller":"traceutil/trace.go:171","msg":"trace[1455560436] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-332410e2-34d5-45be-836c-0617e26dacbd; range_end:; response_count:1; response_revision:1917; }","duration":"349.546611ms","start":"2026-09-10T01:57:02.067163Z","end":"2026-09-10T01:57:02.41671Z","steps":["trace[1455560436] 'agreement among raft nodes before linearized reading' (duration: 349.306804ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:57:02.4168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:57:02.067146Z","time spent":"349.640443ms","remote":"127.0.0.1:38930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-332410e2-34d5-45be-836c-0617e26dacbd\" "} {"level":"warn","ts":"2026-09-10T01:57:02.423644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.648339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-332410e2-34d5-45be-836c-0617e26dacbd\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-10T01:57:02.423674Z","caller":"traceutil/trace.go:171","msg":"trace[457108183] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-332410e2-34d5-45be-836c-0617e26dacbd; range_end:; response_count:1; response_revision:1918; }","duration":"294.743092ms","start":"2026-09-10T01:57:02.128924Z","end":"2026-09-10T01:57:02.423667Z","steps":["trace[457108183] 'agreement among raft nodes before linearized reading' (duration: 294.634589ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:57:02.533232Z","caller":"traceutil/trace.go:171","msg":"trace[1680633686] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"101.209913ms","start":"2026-09-10T01:57:02.43193Z","end":"2026-09-10T01:57:02.53314Z","steps":["trace[1680633686] 'process raft request' (duration: 101.049399ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:57:10.404899Z","caller":"traceutil/trace.go:171","msg":"trace[1680451182] transaction","detail":"{read_only:false; response_revision:1989; number_of_response:1; }","duration":"181.605355ms","start":"2026-09-10T01:57:10.223247Z","end":"2026-09-10T01:57:10.404852Z","steps":["trace[1680451182] 'process raft request' (duration: 181.402069ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:57:15.405147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.507987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-fpptc\" ","response":"range_response_count:1 size:5852"} {"level":"info","ts":"2026-09-10T01:57:15.405241Z","caller":"traceutil/trace.go:171","msg":"trace[276529120] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-fpptc; range_end:; response_count:1; response_revision:2022; }","duration":"141.666582ms","start":"2026-09-10T01:57:15.26355Z","end":"2026-09-10T01:57:15.405217Z","steps":["trace[276529120] 'range keys from in-memory index tree' (duration: 141.225668ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:57:47.239585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.77393ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-10T01:57:47.239881Z","caller":"traceutil/trace.go:171","msg":"trace[1162853002] linearizableReadLoop","detail":"{readStateIndex:2294; appliedIndex:2293; }","duration":"140.130702ms","start":"2026-09-10T01:57:47.099723Z","end":"2026-09-10T01:57:47.239853Z","steps":["trace[1162853002] 'read index received' (duration: 33.990151ms)","trace[1162853002] 'applied index is now lower than readState.Index' (duration: 106.138501ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T01:57:47.239868Z","caller":"traceutil/trace.go:171","msg":"trace[1798412449] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"135.174549ms","start":"2026-09-10T01:57:47.104671Z","end":"2026-09-10T01:57:47.239845Z","steps":["trace[1798412449] 'process raft request' (duration: 135.056435ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:57:47.23986Z","caller":"traceutil/trace.go:171","msg":"trace[2073830424] transaction","detail":"{read_only:false; response_revision:2213; number_of_response:1; }","duration":"190.016864ms","start":"2026-09-10T01:57:47.049771Z","end":"2026-09-10T01:57:47.239788Z","steps":["trace[2073830424] 'process raft request' (duration: 83.933784ms)","trace[2073830424] 'compare' (duration: 105.618375ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T01:57:47.240065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.974714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T01:57:47.240101Z","caller":"traceutil/trace.go:171","msg":"trace[997674497] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2214; }","duration":"104.057976ms","start":"2026-09-10T01:57:47.136034Z","end":"2026-09-10T01:57:47.240091Z","steps":["trace[997674497] 'agreement among raft nodes before linearized reading' (duration: 103.978224ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:57:47.240086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.620932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-10T01:57:47.240169Z","caller":"traceutil/trace.go:171","msg":"trace[1059810046] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2214; }","duration":"156.742996ms","start":"2026-09-10T01:57:47.083406Z","end":"2026-09-10T01:57:47.240149Z","steps":["trace[1059810046] 'agreement among raft nodes before linearized reading' (duration: 156.477228ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:57:47.240595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.932909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-10T01:57:47.240647Z","caller":"traceutil/trace.go:171","msg":"trace[472607894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2214; }","duration":"166.022731ms","start":"2026-09-10T01:57:47.074611Z","end":"2026-09-10T01:57:47.240633Z","steps":["trace[472607894] 'agreement among raft nodes before linearized reading' (duration: 165.393092ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:57:52.897598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.518557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T01:57:52.897717Z","caller":"traceutil/trace.go:171","msg":"trace[38258980] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:2240; }","duration":"199.686003ms","start":"2026-09-10T01:57:52.698001Z","end":"2026-09-10T01:57:52.897687Z","steps":["trace[38258980] 'count revisions from in-memory index tree' (duration: 199.371943ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:57:52.897873Z","caller":"traceutil/trace.go:171","msg":"trace[1868028579] linearizableReadLoop","detail":"{readStateIndex:2324; appliedIndex:2323; }","duration":"155.798646ms","start":"2026-09-10T01:57:52.742047Z","end":"2026-09-10T01:57:52.897846Z","steps":["trace[1868028579] 'read index received' (duration: 139.194762ms)","trace[1868028579] 'applied index is now lower than readState.Index' (duration: 16.602604ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T01:57:52.897962Z","caller":"traceutil/trace.go:171","msg":"trace[1128681264] transaction","detail":"{read_only:false; response_revision:2241; number_of_response:1; }","duration":"180.309664ms","start":"2026-09-10T01:57:52.717618Z","end":"2026-09-10T01:57:52.897927Z","steps":["trace[1128681264] 'process raft request' (duration: 163.608857ms)","trace[1128681264] 'compare' (duration: 16.256113ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T01:57:52.898157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.093015ms","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-09-10T01:57:52.8982Z","caller":"traceutil/trace.go:171","msg":"trace[811690584] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2241; }","duration":"156.171087ms","start":"2026-09-10T01:57:52.742015Z","end":"2026-09-10T01:57:52.898186Z","steps":["trace[811690584] 'agreement among raft nodes before linearized reading' (duration: 156.028303ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:57:53.225834Z","caller":"traceutil/trace.go:171","msg":"trace[947668] transaction","detail":"{read_only:false; response_revision:2243; number_of_response:1; }","duration":"164.540706ms","start":"2026-09-10T01:57:53.061239Z","end":"2026-09-10T01:57:53.225779Z","steps":["trace[947668] 'process raft request' (duration: 163.72128ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:57:53.226014Z","caller":"traceutil/trace.go:171","msg":"trace[1096713043] linearizableReadLoop","detail":"{readStateIndex:2326; appliedIndex:2326; }","duration":"114.397086ms","start":"2026-09-10T01:57:53.111592Z","end":"2026-09-10T01:57:53.225989Z","steps":["trace[1096713043] 'read index received' (duration: 114.388666ms)","trace[1096713043] 'applied index is now lower than readState.Index' (duration: 6.97µs)"],"step_count":2} {"level":"warn","ts":"2026-09-10T01:57:53.226245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.629744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-10T01:57:53.2263Z","caller":"traceutil/trace.go:171","msg":"trace[479398461] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:2243; }","duration":"114.705866ms","start":"2026-09-10T01:57:53.111579Z","end":"2026-09-10T01:57:53.226285Z","steps":["trace[479398461] 'agreement among raft nodes before linearized reading' (duration: 114.531501ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:57:53.663644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.102891ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-10T01:57:53.663735Z","caller":"traceutil/trace.go:171","msg":"trace[396111451] linearizableReadLoop","detail":"{readStateIndex:2327; appliedIndex:2326; }","duration":"398.976424ms","start":"2026-09-10T01:57:53.264743Z","end":"2026-09-10T01:57:53.66372Z","steps":["trace[396111451] 'read index received' (duration: 182.736999ms)","trace[396111451] 'applied index is now lower than readState.Index' (duration: 216.238255ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T01:57:53.663918Z","caller":"traceutil/trace.go:171","msg":"trace[42437701] transaction","detail":"{read_only:false; response_revision:2244; number_of_response:1; }","duration":"399.292303ms","start":"2026-09-10T01:57:53.264613Z","end":"2026-09-10T01:57:53.663905Z","steps":["trace[42437701] 'process raft request' (duration: 182.854262ms)","trace[42437701] 'compare' (duration: 215.679277ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T01:57:53.663979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:57:53.264584Z","time spent":"399.364106ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T01:57:53.664331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.564211ms","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-09-10T01:57:53.664424Z","caller":"traceutil/trace.go:171","msg":"trace[588136572] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2244; }","duration":"399.707075ms","start":"2026-09-10T01:57:53.264695Z","end":"2026-09-10T01:57:53.664402Z","steps":["trace[588136572] 'agreement among raft nodes before linearized reading' (duration: 399.434807ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:57:53.664474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:57:53.264667Z","time spent":"399.793078ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-10T01:57:53.676636Z","caller":"traceutil/trace.go:171","msg":"trace[503693060] transaction","detail":"{read_only:false; response_revision:2245; number_of_response:1; }","duration":"264.007892ms","start":"2026-09-10T01:57:53.412606Z","end":"2026-09-10T01:57:53.676614Z","steps":["trace[503693060] 'process raft request' (duration: 263.882428ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:57:53.724512Z","caller":"traceutil/trace.go:171","msg":"trace[1111534529] transaction","detail":"{read_only:false; response_revision:2246; number_of_response:1; }","duration":"220.967431ms","start":"2026-09-10T01:57:53.503526Z","end":"2026-09-10T01:57:53.724494Z","steps":["trace[1111534529] 'process raft request' (duration: 220.598459ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:57:53.724532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.120824ms","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-09-10T01:57:53.724617Z","caller":"traceutil/trace.go:171","msg":"trace[1490639770] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2247; }","duration":"439.255868ms","start":"2026-09-10T01:57:53.285339Z","end":"2026-09-10T01:57:53.724595Z","steps":["trace[1490639770] 'agreement among raft nodes before linearized reading' (duration: 439.01557ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:57:53.724677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:57:53.285317Z","time spent":"439.34901ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-10T01:57:53.724682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.551276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-10T01:57:53.724746Z","caller":"traceutil/trace.go:171","msg":"trace[2077027702] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2247; }","duration":"427.66867ms","start":"2026-09-10T01:57:53.29706Z","end":"2026-09-10T01:57:53.724729Z","steps":["trace[2077027702] 'agreement among raft nodes before linearized reading' (duration: 427.477654ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:57:53.724827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:57:53.297044Z","time spent":"427.747111ms","remote":"127.0.0.1:41098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-10T01:57:53.725445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.455679ms","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-09-10T01:57:53.725524Z","caller":"traceutil/trace.go:171","msg":"trace[1783339053] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2247; }","duration":"434.572833ms","start":"2026-09-10T01:57:53.290933Z","end":"2026-09-10T01:57:53.725506Z","steps":["trace[1783339053] 'agreement among raft nodes before linearized reading' (duration: 433.608203ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:57:53.725562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:57:53.29092Z","time spent":"434.633515ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-10T01:57:59.08328Z","caller":"traceutil/trace.go:171","msg":"trace[112996263] transaction","detail":"{read_only:false; response_revision:2272; number_of_response:1; }","duration":"166.891949ms","start":"2026-09-10T01:57:58.916361Z","end":"2026-09-10T01:57:59.083253Z","steps":["trace[112996263] 'process raft request' (duration: 166.713933ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:57:59.083293Z","caller":"traceutil/trace.go:171","msg":"trace[1138757927] linearizableReadLoop","detail":"{readStateIndex:2356; appliedIndex:2356; }","duration":"148.308454ms","start":"2026-09-10T01:57:58.93495Z","end":"2026-09-10T01:57:59.083258Z","steps":["trace[1138757927] 'read index received' (duration: 148.293703ms)","trace[1138757927] 'applied index is now lower than readState.Index' (duration: 11.981µs)"],"step_count":2} {"level":"warn","ts":"2026-09-10T01:57:59.083539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.063405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T01:57:59.083586Z","caller":"traceutil/trace.go:171","msg":"trace[2047451534] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:2272; }","duration":"147.166689ms","start":"2026-09-10T01:57:58.936404Z","end":"2026-09-10T01:57:59.083571Z","steps":["trace[2047451534] 'agreement among raft nodes before linearized reading' (duration: 147.083647ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:57:59.083596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.618294ms","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-09-10T01:57:59.08363Z","caller":"traceutil/trace.go:171","msg":"trace[784291046] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2272; }","duration":"148.717127ms","start":"2026-09-10T01:57:58.934902Z","end":"2026-09-10T01:57:59.08362Z","steps":["trace[784291046] 'agreement among raft nodes before linearized reading' (duration: 148.519431ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:58:44.838622Z","caller":"traceutil/trace.go:171","msg":"trace[1078301370] transaction","detail":"{read_only:false; response_revision:2690; number_of_response:1; }","duration":"228.813228ms","start":"2026-09-10T01:58:44.609787Z","end":"2026-09-10T01:58:44.8386Z","steps":["trace[1078301370] 'process raft request' (duration: 228.677044ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T01:59:18.129769Z","caller":"traceutil/trace.go:171","msg":"trace[395945934] transaction","detail":"{read_only:false; response_revision:2891; number_of_response:1; }","duration":"131.277116ms","start":"2026-09-10T01:59:17.998455Z","end":"2026-09-10T01:59:18.129733Z","steps":["trace[395945934] 'process raft request' (duration: 131.040779ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:59:18.634419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.662228ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-10T01:59:18.634557Z","caller":"traceutil/trace.go:171","msg":"trace[2089745851] transaction","detail":"{read_only:false; response_revision:2895; number_of_response:1; }","duration":"285.58305ms","start":"2026-09-10T01:59:18.348951Z","end":"2026-09-10T01:59:18.634534Z","steps":["trace[2089745851] 'process raft request' (duration: 65.689685ms)","trace[2089745851] 'compare' (duration: 219.42428ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T01:59:23.792786Z","caller":"traceutil/trace.go:171","msg":"trace[437381043] linearizableReadLoop","detail":"{readStateIndex:3031; appliedIndex:3030; }","duration":"175.142462ms","start":"2026-09-10T01:59:23.617613Z","end":"2026-09-10T01:59:23.792755Z","steps":["trace[437381043] 'read index received' (duration: 174.873924ms)","trace[437381043] 'applied index is now lower than readState.Index' (duration: 267.338µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T01:59:23.792991Z","caller":"traceutil/trace.go:171","msg":"trace[37481897] transaction","detail":"{read_only:false; response_revision:2923; number_of_response:1; }","duration":"192.689411ms","start":"2026-09-10T01:59:23.600251Z","end":"2026-09-10T01:59:23.792941Z","steps":["trace[37481897] 'process raft request' (duration: 192.31666ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T01:59:23.79315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.501903ms","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-09-10T01:59:23.793193Z","caller":"traceutil/trace.go:171","msg":"trace[778153558] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2923; }","duration":"175.639767ms","start":"2026-09-10T01:59:23.617543Z","end":"2026-09-10T01:59:23.793183Z","steps":["trace[778153558] 'agreement among raft nodes before linearized reading' (duration: 175.39064ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:02:32.187869Z","caller":"traceutil/trace.go:171","msg":"trace[1881483658] transaction","detail":"{read_only:false; response_revision:4114; number_of_response:1; }","duration":"106.362629ms","start":"2026-09-10T02:02:32.081476Z","end":"2026-09-10T02:02:32.187839Z","steps":["trace[1881483658] 'process raft request' (duration: 106.188204ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:02:32.218227Z","caller":"traceutil/trace.go:171","msg":"trace[1535145661] linearizableReadLoop","detail":"{readStateIndex:4267; appliedIndex:4265; }","duration":"110.27512ms","start":"2026-09-10T02:02:32.107925Z","end":"2026-09-10T02:02:32.2182Z","steps":["trace[1535145661] 'read index received' (duration: 79.871105ms)","trace[1535145661] 'applied index is now lower than readState.Index' (duration: 30.402704ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:02:32.218266Z","caller":"traceutil/trace.go:171","msg":"trace[1795829266] transaction","detail":"{read_only:false; response_revision:4115; number_of_response:1; }","duration":"115.655605ms","start":"2026-09-10T02:02:32.102588Z","end":"2026-09-10T02:02:32.218244Z","steps":["trace[1795829266] 'process raft request' (duration: 115.452659ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:02:32.218421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.485565ms","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-09-10T02:02:32.218458Z","caller":"traceutil/trace.go:171","msg":"trace[1057080185] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4115; }","duration":"110.573198ms","start":"2026-09-10T02:02:32.107878Z","end":"2026-09-10T02:02:32.218451Z","steps":["trace[1057080185] 'agreement among raft nodes before linearized reading' (duration: 110.423314ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:04:07.952203Z","caller":"traceutil/trace.go:171","msg":"trace[83334171] linearizableReadLoop","detail":"{readStateIndex:5420; appliedIndex:5419; }","duration":"199.378691ms","start":"2026-09-10T02:04:07.7528Z","end":"2026-09-10T02:04:07.952178Z","steps":["trace[83334171] 'read index received' (duration: 112.644671ms)","trace[83334171] 'applied index is now lower than readState.Index' (duration: 86.73303ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:04:07.952258Z","caller":"traceutil/trace.go:171","msg":"trace[936631413] transaction","detail":"{read_only:false; response_revision:5226; number_of_response:1; }","duration":"207.804589ms","start":"2026-09-10T02:04:07.744429Z","end":"2026-09-10T02:04:07.952233Z","steps":["trace[936631413] 'process raft request' (duration: 121.146931ms)","trace[936631413] 'compare' (duration: 86.502723ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:04:07.95247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.86718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-09-10T02:04:07.952459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.643239ms","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-09-10T02:04:07.952543Z","caller":"traceutil/trace.go:171","msg":"trace[1969256852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5226; }","duration":"199.765442ms","start":"2026-09-10T02:04:07.752748Z","end":"2026-09-10T02:04:07.952513Z","steps":["trace[1969256852] 'agreement among raft nodes before linearized reading' (duration: 199.543466ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:04:07.952511Z","caller":"traceutil/trace.go:171","msg":"trace[1323004600] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5226; }","duration":"187.982573ms","start":"2026-09-10T02:04:07.764519Z","end":"2026-09-10T02:04:07.952501Z","steps":["trace[1323004600] 'agreement among raft nodes before linearized reading' (duration: 187.825648ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:04:11.670326Z","caller":"traceutil/trace.go:171","msg":"trace[560299349] linearizableReadLoop","detail":"{readStateIndex:5548; appliedIndex:5547; }","duration":"298.398816ms","start":"2026-09-10T02:04:11.371895Z","end":"2026-09-10T02:04:11.670294Z","steps":["trace[560299349] 'read index received' (duration: 298.318674ms)","trace[560299349] 'applied index is now lower than readState.Index' (duration: 79.482µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:04:11.670406Z","caller":"traceutil/trace.go:171","msg":"trace[643051516] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5349; }","duration":"386.497228ms","start":"2026-09-10T02:04:11.283861Z","end":"2026-09-10T02:04:11.670358Z","steps":["trace[643051516] 'process raft request' (duration: 386.350674ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:04:11.67058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.668705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5abb725d-ffad-462f-863f-0d75e43c4552\" ","response":"range_response_count:1 size:3601"} {"level":"warn","ts":"2026-09-10T02:04:11.670567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.003008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-10T02:04:11.670594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.719632ms","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-09-10T02:04:11.670618Z","caller":"traceutil/trace.go:171","msg":"trace[1340401437] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5abb725d-ffad-462f-863f-0d75e43c4552; range_end:; response_count:1; response_revision:5349; }","duration":"298.783759ms","start":"2026-09-10T02:04:11.371823Z","end":"2026-09-10T02:04:11.670607Z","steps":["trace[1340401437] 'agreement among raft nodes before linearized reading' (duration: 298.619844ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:04:11.670632Z","caller":"traceutil/trace.go:171","msg":"trace[1556000941] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:5349; }","duration":"214.090161ms","start":"2026-09-10T02:04:11.456529Z","end":"2026-09-10T02:04:11.670619Z","steps":["trace[1556000941] 'agreement among raft nodes before linearized reading' (duration: 213.931106ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:04:11.670643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:04:11.283836Z","time spent":"386.705474ms","remote":"127.0.0.1:38882","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-10T02:04:11.670745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.349551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5abb725d-ffad-462f-863f-0d75e43c4552\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-09-10T02:04:11.670783Z","caller":"traceutil/trace.go:171","msg":"trace[156707205] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5abb725d-ffad-462f-863f-0d75e43c4552; range_end:; response_count:1; response_revision:5349; }","duration":"216.432323ms","start":"2026-09-10T02:04:11.45434Z","end":"2026-09-10T02:04:11.670772Z","steps":["trace[156707205] 'agreement among raft nodes before linearized reading' (duration: 216.345ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:04:11.670645Z","caller":"traceutil/trace.go:171","msg":"trace[901458534] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5349; }","duration":"289.822874ms","start":"2026-09-10T02:04:11.380809Z","end":"2026-09-10T02:04:11.670632Z","steps":["trace[901458534] 'agreement among raft nodes before linearized reading' (duration: 289.644089ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:04:12.000411Z","caller":"traceutil/trace.go:171","msg":"trace[1948295935] transaction","detail":"{read_only:false; response_revision:5362; number_of_response:1; }","duration":"117.335624ms","start":"2026-09-10T02:04:11.883046Z","end":"2026-09-10T02:04:12.000382Z","steps":["trace[1948295935] 'process raft request' (duration: 88.244366ms)","trace[1948295935] 'compare' (duration: 28.981555ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:04:13.901206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.700733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-10T02:04:13.901448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.750964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5abb725d-ffad-462f-863f-0d75e43c4552\" ","response":"range_response_count:1 size:3907"} {"level":"info","ts":"2026-09-10T02:04:13.90159Z","caller":"traceutil/trace.go:171","msg":"trace[454271230] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5abb725d-ffad-462f-863f-0d75e43c4552; range_end:; response_count:1; response_revision:5387; }","duration":"219.95146ms","start":"2026-09-10T02:04:13.681608Z","end":"2026-09-10T02:04:13.901559Z","steps":["trace[454271230] 'range keys from in-memory index tree' (duration: 219.525657ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:04:13.902063Z","caller":"traceutil/trace.go:171","msg":"trace[17025064] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:5387; }","duration":"147.864608ms","start":"2026-09-10T02:04:13.753415Z","end":"2026-09-10T02:04:13.90128Z","steps":["trace[17025064] 'count revisions from in-memory index tree' (duration: 147.550217ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:04:13.902781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.282601ms","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-09-10T02:04:13.90284Z","caller":"traceutil/trace.go:171","msg":"trace[348517198] transaction","detail":"{read_only:false; response_revision:5388; number_of_response:1; }","duration":"133.782386ms","start":"2026-09-10T02:04:13.769039Z","end":"2026-09-10T02:04:13.902821Z","steps":["trace[348517198] 'process raft request' (duration: 76.187277ms)","trace[348517198] 'compare' (duration: 55.96688ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:04:13.90285Z","caller":"traceutil/trace.go:171","msg":"trace[1648970675] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5387; }","duration":"203.392654ms","start":"2026-09-10T02:04:13.699442Z","end":"2026-09-10T02:04:13.902834Z","steps":["trace[1648970675] 'range keys from in-memory index tree' (duration: 202.399354ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:04:26.556138Z","caller":"traceutil/trace.go:171","msg":"trace[76499495] transaction","detail":"{read_only:false; response_revision:5632; number_of_response:1; }","duration":"105.582545ms","start":"2026-09-10T02:04:26.450524Z","end":"2026-09-10T02:04:26.556107Z","steps":["trace[76499495] 'process raft request' (duration: 105.481242ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:04:26.556275Z","caller":"traceutil/trace.go:171","msg":"trace[2065959035] transaction","detail":"{read_only:false; response_revision:5631; number_of_response:1; }","duration":"106.123391ms","start":"2026-09-10T02:04:26.45012Z","end":"2026-09-10T02:04:26.556243Z","steps":["trace[2065959035] 'compare' (duration: 96.502348ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:04:26.765145Z","caller":"traceutil/trace.go:171","msg":"trace[45773656] transaction","detail":"{read_only:false; response_revision:5633; number_of_response:1; }","duration":"111.360702ms","start":"2026-09-10T02:04:26.653732Z","end":"2026-09-10T02:04:26.765093Z","steps":["trace[45773656] 'process raft request' (duration: 56.243839ms)","trace[45773656] 'compare' (duration: 54.737542ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:04:27.246833Z","caller":"traceutil/trace.go:171","msg":"trace[129130174] linearizableReadLoop","detail":"{readStateIndex:5846; appliedIndex:5845; }","duration":"131.272371ms","start":"2026-09-10T02:04:27.115525Z","end":"2026-09-10T02:04:27.246798Z","steps":["trace[129130174] 'read index received' (duration: 130.984941ms)","trace[129130174] 'applied index is now lower than readState.Index' (duration: 285.86µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:04:27.246892Z","caller":"traceutil/trace.go:171","msg":"trace[1926885851] transaction","detail":"{read_only:false; response_revision:5640; number_of_response:1; }","duration":"298.684285ms","start":"2026-09-10T02:04:26.948168Z","end":"2026-09-10T02:04:27.246852Z","steps":["trace[1926885851] 'process raft request' (duration: 298.431667ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:04:27.247127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.396363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-10T02:04:27.247113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.548899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-10T02:04:27.24719Z","caller":"traceutil/trace.go:171","msg":"trace[1966045687] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5640; }","duration":"110.533377ms","start":"2026-09-10T02:04:27.136636Z","end":"2026-09-10T02:04:27.247169Z","steps":["trace[1966045687] 'agreement among raft nodes before linearized reading' (duration: 110.405093ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:04:27.247211Z","caller":"traceutil/trace.go:171","msg":"trace[1131216091] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:5640; }","duration":"131.723004ms","start":"2026-09-10T02:04:27.115462Z","end":"2026-09-10T02:04:27.247185Z","steps":["trace[1131216091] 'agreement among raft nodes before linearized reading' (duration: 131.517308ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:04:37.251877Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2997} {"level":"info","ts":"2026-09-10T02:04:37.341037Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2997,"took":"87.277946ms","hash":2015658898,"current-db-size-bytes":55672832,"current-db-size":"56 MB","current-db-size-in-use-bytes":31727616,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-10T02:04:37.34114Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2015658898,"revision":2997,"compact-revision":-1} {"level":"info","ts":"2026-09-10T02:04:45.006328Z","caller":"traceutil/trace.go:171","msg":"trace[1011882451] linearizableReadLoop","detail":"{readStateIndex:6134; appliedIndex:6133; }","duration":"126.106114ms","start":"2026-09-10T02:04:44.880183Z","end":"2026-09-10T02:04:45.006289Z","steps":["trace[1011882451] 'read index received' (duration: 125.888756ms)","trace[1011882451] 'applied index is now lower than readState.Index' (duration: 216.418µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:04:45.006408Z","caller":"traceutil/trace.go:171","msg":"trace[1403786954] transaction","detail":"{read_only:false; response_revision:5921; number_of_response:1; }","duration":"171.412007ms","start":"2026-09-10T02:04:44.834934Z","end":"2026-09-10T02:04:45.006346Z","steps":["trace[1403786954] 'process raft request' (duration: 171.172649ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:04:45.006678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.464434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e2b3a128-007b-4cd7-a65e-21f4b8cf2da8\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-10T02:04:45.006827Z","caller":"traceutil/trace.go:171","msg":"trace[377574677] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e2b3a128-007b-4cd7-a65e-21f4b8cf2da8; range_end:; response_count:1; response_revision:5921; }","duration":"126.68984ms","start":"2026-09-10T02:04:44.880098Z","end":"2026-09-10T02:04:45.006788Z","steps":["trace[377574677] 'agreement among raft nodes before linearized reading' (duration: 126.34948ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:04:45.132329Z","caller":"traceutil/trace.go:171","msg":"trace[1055991932] transaction","detail":"{read_only:false; response_revision:5922; number_of_response:1; }","duration":"120.885654ms","start":"2026-09-10T02:04:45.011412Z","end":"2026-09-10T02:04:45.132298Z","steps":["trace[1055991932] 'process raft request' (duration: 66.200282ms)","trace[1055991932] 'compare' (duration: 54.543966ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:04:45.143698Z","caller":"traceutil/trace.go:171","msg":"trace[605320560] transaction","detail":"{read_only:false; response_revision:5923; number_of_response:1; }","duration":"126.30884ms","start":"2026-09-10T02:04:45.01735Z","end":"2026-09-10T02:04:45.143658Z","steps":["trace[605320560] 'process raft request' (duration: 125.945928ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:09:37.258632Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5781} {"level":"info","ts":"2026-09-10T02:09:37.345827Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5781,"took":"85.742814ms","hash":2533940360,"current-db-size-bytes":55672832,"current-db-size":"56 MB","current-db-size-in-use-bytes":27000832,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-10T02:09:37.345901Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2533940360,"revision":5781,"compact-revision":2997} {"level":"info","ts":"2026-09-10T02:11:07.60283Z","caller":"traceutil/trace.go:171","msg":"trace[1839077755] linearizableReadLoop","detail":"{readStateIndex:9072; appliedIndex:9071; }","duration":"112.437456ms","start":"2026-09-10T02:11:07.490366Z","end":"2026-09-10T02:11:07.602803Z","steps":["trace[1839077755] 'read index received' (duration: 112.360424ms)","trace[1839077755] 'applied index is now lower than readState.Index' (duration: 75.692µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:11:07.602923Z","caller":"traceutil/trace.go:171","msg":"trace[2031720349] transaction","detail":"{read_only:false; response_revision:8767; number_of_response:1; }","duration":"376.91605ms","start":"2026-09-10T02:11:07.225971Z","end":"2026-09-10T02:11:07.602887Z","steps":["trace[2031720349] 'process raft request' (duration: 376.574999ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:11:07.602968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.58838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-10T02:11:07.603009Z","caller":"traceutil/trace.go:171","msg":"trace[2001705412] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:8767; }","duration":"112.694204ms","start":"2026-09-10T02:11:07.490299Z","end":"2026-09-10T02:11:07.602993Z","steps":["trace[2001705412] 'agreement among raft nodes before linearized reading' (duration: 112.605511ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:11:07.603076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:11:07.225938Z","time spent":"377.058874ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T02:11:07.745128Z","caller":"traceutil/trace.go:171","msg":"trace[853685921] transaction","detail":"{read_only:false; response_revision:8768; number_of_response:1; }","duration":"250.193759ms","start":"2026-09-10T02:11:07.494901Z","end":"2026-09-10T02:11:07.745095Z","steps":["trace[853685921] 'process raft request' (duration: 219.819227ms)","trace[853685921] 'compare' (duration: 30.218017ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:11:20.294474Z","caller":"traceutil/trace.go:171","msg":"trace[1353222209] linearizableReadLoop","detail":"{readStateIndex:9138; appliedIndex:9137; }","duration":"158.155545ms","start":"2026-09-10T02:11:20.136288Z","end":"2026-09-10T02:11:20.294444Z","steps":["trace[1353222209] 'read index received' (duration: 157.928028ms)","trace[1353222209] 'applied index is now lower than readState.Index' (duration: 225.827µs)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:11:20.294654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.3573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T02:11:20.294584Z","caller":"traceutil/trace.go:171","msg":"trace[195658724] transaction","detail":"{read_only:false; response_revision:8831; number_of_response:1; }","duration":"229.942765ms","start":"2026-09-10T02:11:20.0646Z","end":"2026-09-10T02:11:20.294543Z","steps":["trace[195658724] 'process raft request' (duration: 229.673687ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:11:20.294733Z","caller":"traceutil/trace.go:171","msg":"trace[1794986783] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8831; }","duration":"158.479944ms","start":"2026-09-10T02:11:20.136237Z","end":"2026-09-10T02:11:20.294717Z","steps":["trace[1794986783] 'agreement among raft nodes before linearized reading' (duration: 158.35865ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:11:21.091472Z","caller":"traceutil/trace.go:171","msg":"trace[1420399881] transaction","detail":"{read_only:false; response_revision:8838; number_of_response:1; }","duration":"114.514678ms","start":"2026-09-10T02:11:20.976926Z","end":"2026-09-10T02:11:21.091441Z","steps":["trace[1420399881] 'process raft request' (duration: 114.297981ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:11:26.398966Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023dd.wal"} {"level":"info","ts":"2026-09-10T02:11:49.982832Z","caller":"traceutil/trace.go:171","msg":"trace[1301355946] transaction","detail":"{read_only:false; response_revision:9046; number_of_response:1; }","duration":"251.273954ms","start":"2026-09-10T02:11:49.731521Z","end":"2026-09-10T02:11:49.982795Z","steps":["trace[1301355946] 'process raft request' (duration: 250.570322ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:11:53.001409Z","caller":"traceutil/trace.go:171","msg":"trace[1477714135] transaction","detail":"{read_only:false; response_revision:9066; number_of_response:1; }","duration":"102.178294ms","start":"2026-09-10T02:11:52.899199Z","end":"2026-09-10T02:11:53.001378Z","steps":["trace[1477714135] 'process raft request' (duration: 101.972057ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:11:53.360179Z","caller":"traceutil/trace.go:171","msg":"trace[1460970751] transaction","detail":"{read_only:false; response_revision:9067; number_of_response:1; }","duration":"125.223034ms","start":"2026-09-10T02:11:53.234904Z","end":"2026-09-10T02:11:53.360127Z","steps":["trace[1460970751] 'process raft request' (duration: 124.849573ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:11:53.360314Z","caller":"traceutil/trace.go:171","msg":"trace[193356485] linearizableReadLoop","detail":"{readStateIndex:9385; appliedIndex:9383; }","duration":"100.538074ms","start":"2026-09-10T02:11:53.259738Z","end":"2026-09-10T02:11:53.360276Z","steps":["trace[193356485] 'read index received' (duration: 100.04926ms)","trace[193356485] 'applied index is now lower than readState.Index' (duration: 485.674µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:11:53.360407Z","caller":"traceutil/trace.go:171","msg":"trace[734073456] transaction","detail":"{read_only:false; response_revision:9068; number_of_response:1; }","duration":"125.45722ms","start":"2026-09-10T02:11:53.234923Z","end":"2026-09-10T02:11:53.360381Z","steps":["trace[734073456] 'process raft request' (duration: 125.11747ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:11:53.360518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.75146ms","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":"info","ts":"2026-09-10T02:11:53.360564Z","caller":"traceutil/trace.go:171","msg":"trace[1318801032] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:9068; }","duration":"100.855893ms","start":"2026-09-10T02:11:53.259692Z","end":"2026-09-10T02:11:53.360548Z","steps":["trace[1318801032] 'agreement among raft nodes before linearized reading' (duration: 100.734899ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:02.414865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.417617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T02:12:02.414967Z","caller":"traceutil/trace.go:171","msg":"trace[245633845] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9112; }","duration":"277.579791ms","start":"2026-09-10T02:12:02.137357Z","end":"2026-09-10T02:12:02.414937Z","steps":["trace[245633845] 'range keys from in-memory index tree' (duration: 277.336454ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:02.415131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.883787ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-10T02:12:02.415234Z","caller":"traceutil/trace.go:171","msg":"trace[1876504542] transaction","detail":"{read_only:false; response_revision:9113; number_of_response:1; }","duration":"175.059787ms","start":"2026-09-10T02:12:02.240153Z","end":"2026-09-10T02:12:02.415213Z","steps":["trace[1876504542] 'process raft request' (duration: 12.978944ms)","trace[1876504542] 'compare' (duration: 161.542377ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:03.123871Z","caller":"traceutil/trace.go:171","msg":"trace[1292087498] transaction","detail":"{read_only:false; response_revision:9119; number_of_response:1; }","duration":"212.943448ms","start":"2026-09-10T02:12:02.910876Z","end":"2026-09-10T02:12:03.12382Z","steps":["trace[1292087498] 'process raft request' (duration: 172.908102ms)","trace[1292087498] 'compare' (duration: 39.856ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:31.140952Z","caller":"traceutil/trace.go:171","msg":"trace[1619941163] linearizableReadLoop","detail":"{readStateIndex:9697; appliedIndex:9696; }","duration":"165.354672ms","start":"2026-09-10T02:12:30.975504Z","end":"2026-09-10T02:12:31.140859Z","steps":["trace[1619941163] 'read index received' (duration: 165.237488ms)","trace[1619941163] 'applied index is now lower than readState.Index' (duration: 116.164µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:31.140972Z","caller":"traceutil/trace.go:171","msg":"trace[1314542009] transaction","detail":"{read_only:false; response_revision:9368; number_of_response:1; }","duration":"199.125028ms","start":"2026-09-10T02:12:30.941806Z","end":"2026-09-10T02:12:31.140931Z","steps":["trace[1314542009] 'process raft request' (duration: 198.876471ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:31.141124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.6299ms","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-09-10T02:12:31.141202Z","caller":"traceutil/trace.go:171","msg":"trace[178868238] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9368; }","duration":"165.758635ms","start":"2026-09-10T02:12:30.975423Z","end":"2026-09-10T02:12:31.141182Z","steps":["trace[178868238] 'agreement among raft nodes before linearized reading' (duration: 165.579539ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:31.141228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.869627ms","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-09-10T02:12:31.141262Z","caller":"traceutil/trace.go:171","msg":"trace[908709958] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9368; }","duration":"163.975162ms","start":"2026-09-10T02:12:30.977277Z","end":"2026-09-10T02:12:31.141252Z","steps":["trace[908709958] 'agreement among raft nodes before linearized reading' (duration: 163.819426ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:31.345878Z","caller":"traceutil/trace.go:171","msg":"trace[624767262] transaction","detail":"{read_only:false; response_revision:9371; number_of_response:1; }","duration":"110.447885ms","start":"2026-09-10T02:12:31.235394Z","end":"2026-09-10T02:12:31.345842Z","steps":["trace[624767262] 'process raft request' (duration: 65.951753ms)","trace[624767262] 'compare' (duration: 44.367498ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:32.233929Z","caller":"traceutil/trace.go:171","msg":"trace[765511956] transaction","detail":"{read_only:false; response_revision:9377; number_of_response:1; }","duration":"179.594275ms","start":"2026-09-10T02:12:32.054313Z","end":"2026-09-10T02:12:32.233907Z","steps":["trace[765511956] 'process raft request' (duration: 179.456121ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:32.497659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.348777ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-10T02:12:32.497846Z","caller":"traceutil/trace.go:171","msg":"trace[379761777] linearizableReadLoop","detail":"{readStateIndex:9709; appliedIndex:9707; }","duration":"136.573448ms","start":"2026-09-10T02:12:32.361257Z","end":"2026-09-10T02:12:32.49783Z","steps":["trace[379761777] 'read index received' (duration: 76.365879ms)","trace[379761777] 'applied index is now lower than readState.Index' (duration: 60.206579ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:12:32.497936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.675842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T02:12:32.497962Z","caller":"traceutil/trace.go:171","msg":"trace[537253311] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9380; }","duration":"136.736054ms","start":"2026-09-10T02:12:32.361216Z","end":"2026-09-10T02:12:32.497952Z","steps":["trace[537253311] 'agreement among raft nodes before linearized reading' (duration: 136.660431ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:32.497994Z","caller":"traceutil/trace.go:171","msg":"trace[653433076] transaction","detail":"{read_only:false; response_revision:9380; number_of_response:1; }","duration":"250.148748ms","start":"2026-09-10T02:12:32.247809Z","end":"2026-09-10T02:12:32.497958Z","steps":["trace[653433076] 'process raft request' (duration: 249.962942ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:32.498083Z","caller":"traceutil/trace.go:171","msg":"trace[1059908176] transaction","detail":"{read_only:false; response_revision:9379; number_of_response:1; }","duration":"250.409486ms","start":"2026-09-10T02:12:32.247642Z","end":"2026-09-10T02:12:32.498052Z","steps":["trace[1059908176] 'process raft request' (duration: 72.572774ms)","trace[1059908176] 'compare' (duration: 177.250874ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:32.760419Z","caller":"traceutil/trace.go:171","msg":"trace[1050098825] linearizableReadLoop","detail":"{readStateIndex:9712; appliedIndex:9710; }","duration":"256.47158ms","start":"2026-09-10T02:12:32.503919Z","end":"2026-09-10T02:12:32.760391Z","steps":["trace[1050098825] 'read index received' (duration: 423.283µs)","trace[1050098825] 'applied index is now lower than readState.Index' (duration: 256.047317ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:32.760498Z","caller":"traceutil/trace.go:171","msg":"trace[1583530214] transaction","detail":"{read_only:false; response_revision:9383; number_of_response:1; }","duration":"257.376378ms","start":"2026-09-10T02:12:32.50309Z","end":"2026-09-10T02:12:32.760467Z","steps":["trace[1583530214] 'process raft request' (duration: 257.184882ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:32.760713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.770379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:123410"} {"level":"info","ts":"2026-09-10T02:12:32.760774Z","caller":"traceutil/trace.go:171","msg":"trace[1034792078] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:9384; }","duration":"256.845401ms","start":"2026-09-10T02:12:32.503912Z","end":"2026-09-10T02:12:32.760758Z","steps":["trace[1034792078] 'agreement among raft nodes before linearized reading' (duration: 256.595514ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:32.760956Z","caller":"traceutil/trace.go:171","msg":"trace[1753038338] transaction","detail":"{read_only:false; response_revision:9384; number_of_response:1; }","duration":"256.870012ms","start":"2026-09-10T02:12:32.504071Z","end":"2026-09-10T02:12:32.760941Z","steps":["trace[1753038338] 'process raft request' (duration: 256.261514ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:32.760733Z","caller":"traceutil/trace.go:171","msg":"trace[1290114758] transaction","detail":"{read_only:false; response_revision:9382; number_of_response:1; }","duration":"257.833391ms","start":"2026-09-10T02:12:32.502889Z","end":"2026-09-10T02:12:32.760722Z","steps":["trace[1290114758] 'process raft request' (duration: 257.244214ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:32.876424Z","caller":"traceutil/trace.go:171","msg":"trace[1290847368] transaction","detail":"{read_only:false; response_revision:9385; number_of_response:1; }","duration":"111.372973ms","start":"2026-09-10T02:12:32.765023Z","end":"2026-09-10T02:12:32.876396Z","steps":["trace[1290847368] 'process raft request' (duration: 80.607429ms)","trace[1290847368] 'compare' (duration: 30.031452ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:33.028314Z","caller":"traceutil/trace.go:171","msg":"trace[549544754] transaction","detail":"{read_only:false; response_revision:9387; number_of_response:1; }","duration":"147.571123ms","start":"2026-09-10T02:12:32.880711Z","end":"2026-09-10T02:12:33.028282Z","steps":["trace[549544754] 'process raft request' (duration: 109.112675ms)","trace[549544754] 'compare' (duration: 38.314803ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:33.081658Z","caller":"traceutil/trace.go:171","msg":"trace[1258800637] transaction","detail":"{read_only:false; response_revision:9392; number_of_response:1; }","duration":"108.258938ms","start":"2026-09-10T02:12:32.973372Z","end":"2026-09-10T02:12:33.081631Z","steps":["trace[1258800637] 'process raft request' (duration: 108.211436ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:33.081998Z","caller":"traceutil/trace.go:171","msg":"trace[493622595] transaction","detail":"{read_only:false; response_revision:9388; number_of_response:1; }","duration":"109.001751ms","start":"2026-09-10T02:12:32.972989Z","end":"2026-09-10T02:12:33.081991Z","steps":["trace[493622595] 'process raft request' (duration: 108.344481ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:33.082145Z","caller":"traceutil/trace.go:171","msg":"trace[1428179190] transaction","detail":"{read_only:false; response_revision:9389; number_of_response:1; }","duration":"109.083034ms","start":"2026-09-10T02:12:32.973054Z","end":"2026-09-10T02:12:33.082137Z","steps":["trace[1428179190] 'process raft request' (duration: 108.415723ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:33.082284Z","caller":"traceutil/trace.go:171","msg":"trace[912661565] transaction","detail":"{read_only:false; response_revision:9391; number_of_response:1; }","duration":"109.061473ms","start":"2026-09-10T02:12:32.973176Z","end":"2026-09-10T02:12:33.082237Z","steps":["trace[912661565] 'process raft request' (duration: 108.380002ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:33.082449Z","caller":"traceutil/trace.go:171","msg":"trace[944604548] transaction","detail":"{read_only:false; response_revision:9390; number_of_response:1; }","duration":"109.427593ms","start":"2026-09-10T02:12:32.972996Z","end":"2026-09-10T02:12:33.082423Z","steps":["trace[944604548] 'process raft request' (duration: 108.518165ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:33.396285Z","caller":"traceutil/trace.go:171","msg":"trace[1558781627] transaction","detail":"{read_only:false; response_revision:9401; number_of_response:1; }","duration":"175.161171ms","start":"2026-09-10T02:12:33.221107Z","end":"2026-09-10T02:12:33.396268Z","steps":["trace[1558781627] 'process raft request' (duration: 87.26123ms)","trace[1558781627] 'compare' (duration: 87.384255ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:33.396502Z","caller":"traceutil/trace.go:171","msg":"trace[1760965260] transaction","detail":"{read_only:false; response_revision:9402; number_of_response:1; }","duration":"174.672095ms","start":"2026-09-10T02:12:33.22182Z","end":"2026-09-10T02:12:33.396492Z","steps":["trace[1760965260] 'process raft request' (duration: 174.135959ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:33.396629Z","caller":"traceutil/trace.go:171","msg":"trace[1000629694] transaction","detail":"{read_only:false; response_revision:9403; number_of_response:1; }","duration":"173.858971ms","start":"2026-09-10T02:12:33.222763Z","end":"2026-09-10T02:12:33.396622Z","steps":["trace[1000629694] 'process raft request' (duration: 173.238773ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:33.396717Z","caller":"traceutil/trace.go:171","msg":"trace[393166340] linearizableReadLoop","detail":"{readStateIndex:9731; appliedIndex:9728; }","duration":"174.238743ms","start":"2026-09-10T02:12:33.222468Z","end":"2026-09-10T02:12:33.396707Z","steps":["trace[393166340] 'read index received' (duration: 17.258464ms)","trace[393166340] 'applied index is now lower than readState.Index' (duration: 156.979529ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:12:33.397202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.708757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-09-10T02:12:33.397284Z","caller":"traceutil/trace.go:171","msg":"trace[64427983] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:9404; }","duration":"174.80195ms","start":"2026-09-10T02:12:33.222463Z","end":"2026-09-10T02:12:33.397265Z","steps":["trace[64427983] 'agreement among raft nodes before linearized reading' (duration: 174.548243ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:33.56086Z","caller":"traceutil/trace.go:171","msg":"trace[361177854] linearizableReadLoop","detail":"{readStateIndex:9735; appliedIndex:9734; }","duration":"125.945716ms","start":"2026-09-10T02:12:33.43489Z","end":"2026-09-10T02:12:33.560836Z","steps":["trace[361177854] 'read index received' (duration: 91.294063ms)","trace[361177854] 'applied index is now lower than readState.Index' (duration: 34.650763ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:33.561123Z","caller":"traceutil/trace.go:171","msg":"trace[1793320865] transaction","detail":"{read_only:false; response_revision:9406; number_of_response:1; }","duration":"135.494536ms","start":"2026-09-10T02:12:33.425581Z","end":"2026-09-10T02:12:33.561076Z","steps":["trace[1793320865] 'process raft request' (duration: 100.620347ms)","trace[1793320865] 'compare' (duration: 34.518598ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:12:33.561378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.468871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-09-10T02:12:33.561463Z","caller":"traceutil/trace.go:171","msg":"trace[613848952] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:9406; }","duration":"126.603385ms","start":"2026-09-10T02:12:33.434841Z","end":"2026-09-10T02:12:33.561444Z","steps":["trace[613848952] 'agreement among raft nodes before linearized reading' (duration: 126.142741ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:33.571296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.69417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225408"} {"level":"info","ts":"2026-09-10T02:12:33.571363Z","caller":"traceutil/trace.go:171","msg":"trace[1682035248] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:9407; }","duration":"106.794054ms","start":"2026-09-10T02:12:33.464553Z","end":"2026-09-10T02:12:33.571347Z","steps":["trace[1682035248] 'agreement among raft nodes before linearized reading' (duration: 105.6808ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:33.786024Z","caller":"traceutil/trace.go:171","msg":"trace[1710598565] transaction","detail":"{read_only:false; response_revision:9412; number_of_response:1; }","duration":"158.891146ms","start":"2026-09-10T02:12:33.627105Z","end":"2026-09-10T02:12:33.785996Z","steps":["trace[1710598565] 'process raft request' (duration: 158.530286ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:33.786994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.790136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3684"} {"level":"info","ts":"2026-09-10T02:12:33.787126Z","caller":"traceutil/trace.go:171","msg":"trace[1025094839] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:9412; }","duration":"139.980652ms","start":"2026-09-10T02:12:33.647118Z","end":"2026-09-10T02:12:33.787099Z","steps":["trace[1025094839] 'agreement among raft nodes before linearized reading' (duration: 139.731415ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:33.914769Z","caller":"traceutil/trace.go:171","msg":"trace[1770089554] linearizableReadLoop","detail":"{readStateIndex:9743; appliedIndex:9741; }","duration":"120.319764ms","start":"2026-09-10T02:12:33.794428Z","end":"2026-09-10T02:12:33.914747Z","steps":["trace[1770089554] 'read index received' (duration: 21.455562ms)","trace[1770089554] 'applied index is now lower than readState.Index' (duration: 98.863262ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:33.914893Z","caller":"traceutil/trace.go:171","msg":"trace[311579194] transaction","detail":"{read_only:false; response_revision:9415; number_of_response:1; }","duration":"117.389806ms","start":"2026-09-10T02:12:33.797458Z","end":"2026-09-10T02:12:33.914848Z","steps":["trace[311579194] 'process raft request' (duration: 117.22213ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:33.914945Z","caller":"traceutil/trace.go:171","msg":"trace[926121645] transaction","detail":"{read_only:false; response_revision:9414; number_of_response:1; }","duration":"121.050488ms","start":"2026-09-10T02:12:33.793874Z","end":"2026-09-10T02:12:33.914924Z","steps":["trace[926121645] 'process raft request' (duration: 120.695576ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:33.915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.536851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-09-10T02:12:33.915075Z","caller":"traceutil/trace.go:171","msg":"trace[1995953606] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:9415; }","duration":"120.661646ms","start":"2026-09-10T02:12:33.794399Z","end":"2026-09-10T02:12:33.915025Z","steps":["trace[1995953606] 'agreement among raft nodes before linearized reading' (duration: 120.48685ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:33.915084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.598243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-09-10T02:12:33.915182Z","caller":"traceutil/trace.go:171","msg":"trace[1102052279] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:9415; }","duration":"120.736718ms","start":"2026-09-10T02:12:33.794422Z","end":"2026-09-10T02:12:33.915158Z","steps":["trace[1102052279] 'agreement among raft nodes before linearized reading' (duration: 120.447959ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:34.03647Z","caller":"traceutil/trace.go:171","msg":"trace[2042544674] transaction","detail":"{read_only:false; response_revision:9417; number_of_response:1; }","duration":"109.97642ms","start":"2026-09-10T02:12:33.926458Z","end":"2026-09-10T02:12:34.036435Z","steps":["trace[2042544674] 'process raft request' (duration: 109.814436ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:34.036616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.815545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-09-10T02:12:34.036692Z","caller":"traceutil/trace.go:171","msg":"trace[1026837218] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:9417; }","duration":"108.96086ms","start":"2026-09-10T02:12:33.927712Z","end":"2026-09-10T02:12:34.036673Z","steps":["trace[1026837218] 'agreement among raft nodes before linearized reading' (duration: 108.709211ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:34.156659Z","caller":"traceutil/trace.go:171","msg":"trace[1349773453] linearizableReadLoop","detail":"{readStateIndex:9748; appliedIndex:9746; }","duration":"113.651262ms","start":"2026-09-10T02:12:34.042987Z","end":"2026-09-10T02:12:34.156638Z","steps":["trace[1349773453] 'read index received' (duration: 27.64955ms)","trace[1349773453] 'applied index is now lower than readState.Index' (duration: 86.000722ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:34.156724Z","caller":"traceutil/trace.go:171","msg":"trace[2007423031] transaction","detail":"{read_only:false; response_revision:9419; number_of_response:1; }","duration":"113.752365ms","start":"2026-09-10T02:12:34.042943Z","end":"2026-09-10T02:12:34.156695Z","steps":["trace[2007423031] 'process raft request' (duration: 85.461545ms)","trace[2007423031] 'compare' (duration: 27.836736ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:34.156829Z","caller":"traceutil/trace.go:171","msg":"trace[110359491] transaction","detail":"{read_only:false; response_revision:9420; number_of_response:1; }","duration":"111.535607ms","start":"2026-09-10T02:12:34.045286Z","end":"2026-09-10T02:12:34.156822Z","steps":["trace[110359491] 'process raft request' (duration: 111.29249ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:34.157123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.131788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-09-10T02:12:34.157153Z","caller":"traceutil/trace.go:171","msg":"trace[2078037149] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:9420; }","duration":"114.20648ms","start":"2026-09-10T02:12:34.042937Z","end":"2026-09-10T02:12:34.157144Z","steps":["trace[2078037149] 'agreement among raft nodes before linearized reading' (duration: 114.063465ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:34.15729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.287502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-09-10T02:12:34.157309Z","caller":"traceutil/trace.go:171","msg":"trace[787449666] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:9420; }","duration":"114.336894ms","start":"2026-09-10T02:12:34.042966Z","end":"2026-09-10T02:12:34.157303Z","steps":["trace[787449666] 'agreement among raft nodes before linearized reading' (duration: 114.278362ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:34.157509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.88188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-glance\" ","response":"range_response_count:1 size:3286"} {"level":"info","ts":"2026-09-10T02:12:34.157538Z","caller":"traceutil/trace.go:171","msg":"trace[2137754567] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-glance; range_end:; response_count:1; response_revision:9420; }","duration":"112.93207ms","start":"2026-09-10T02:12:34.044599Z","end":"2026-09-10T02:12:34.157532Z","steps":["trace[2137754567] 'agreement among raft nodes before linearized reading' (duration: 112.872149ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:34.357407Z","caller":"traceutil/trace.go:171","msg":"trace[990335699] linearizableReadLoop","detail":"{readStateIndex:9752; appliedIndex:9751; }","duration":"144.444828ms","start":"2026-09-10T02:12:34.212937Z","end":"2026-09-10T02:12:34.357382Z","steps":["trace[990335699] 'read index received' (duration: 134.477685ms)","trace[990335699] 'applied index is now lower than readState.Index' (duration: 9.963193ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:34.357682Z","caller":"traceutil/trace.go:171","msg":"trace[1011875536] transaction","detail":"{read_only:false; response_revision:9423; number_of_response:1; }","duration":"149.238193ms","start":"2026-09-10T02:12:34.208404Z","end":"2026-09-10T02:12:34.357642Z","steps":["trace[1011875536] 'process raft request' (duration: 138.931979ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:34.35784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.886831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-09-10T02:12:34.357907Z","caller":"traceutil/trace.go:171","msg":"trace[286325679] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:9423; }","duration":"145.053166ms","start":"2026-09-10T02:12:34.212838Z","end":"2026-09-10T02:12:34.357891Z","steps":["trace[286325679] 'agreement among raft nodes before linearized reading' (duration: 144.816609ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:34.455202Z","caller":"traceutil/trace.go:171","msg":"trace[1404688357] transaction","detail":"{read_only:false; response_revision:9424; number_of_response:1; }","duration":"240.168385ms","start":"2026-09-10T02:12:34.214991Z","end":"2026-09-10T02:12:34.455159Z","steps":["trace[1404688357] 'process raft request' (duration: 239.911477ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:34.455466Z","caller":"traceutil/trace.go:171","msg":"trace[423881030] transaction","detail":"{read_only:false; response_revision:9426; number_of_response:1; }","duration":"206.792642ms","start":"2026-09-10T02:12:34.248645Z","end":"2026-09-10T02:12:34.455437Z","steps":["trace[423881030] 'process raft request' (duration: 206.465441ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:34.455466Z","caller":"traceutil/trace.go:171","msg":"trace[1696038520] transaction","detail":"{read_only:false; response_revision:9425; number_of_response:1; }","duration":"231.253606ms","start":"2026-09-10T02:12:34.224184Z","end":"2026-09-10T02:12:34.455437Z","steps":["trace[1696038520] 'process raft request' (duration: 230.878644ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:34.455698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.595168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:112184"} {"level":"info","ts":"2026-09-10T02:12:34.455775Z","caller":"traceutil/trace.go:171","msg":"trace[104108677] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:9426; }","duration":"240.753222ms","start":"2026-09-10T02:12:34.215007Z","end":"2026-09-10T02:12:34.455761Z","steps":["trace[104108677] 'agreement among raft nodes before linearized reading' (duration: 240.433643ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:34.525516Z","caller":"traceutil/trace.go:171","msg":"trace[464812137] transaction","detail":"{read_only:false; response_revision:9427; number_of_response:1; }","duration":"163.781605ms","start":"2026-09-10T02:12:34.361686Z","end":"2026-09-10T02:12:34.525468Z","steps":["trace[464812137] 'process raft request' (duration: 163.528516ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:34.525569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.568877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:20130"} {"level":"info","ts":"2026-09-10T02:12:34.525769Z","caller":"traceutil/trace.go:171","msg":"trace[1647173169] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:9427; }","duration":"160.814575ms","start":"2026-09-10T02:12:34.364935Z","end":"2026-09-10T02:12:34.525749Z","steps":["trace[1647173169] 'agreement among raft nodes before linearized reading' (duration: 160.489856ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:34.601541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.070432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-glance-server\" ","response":"range_response_count:1 size:9537"} {"level":"warn","ts":"2026-09-10T02:12:34.601576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.149778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-glance-default-user\" ","response":"range_response_count:1 size:1309"} {"level":"info","ts":"2026-09-10T02:12:34.601593Z","caller":"traceutil/trace.go:171","msg":"trace[1182003342] transaction","detail":"{read_only:false; response_revision:9428; number_of_response:1; }","duration":"134.623819ms","start":"2026-09-10T02:12:34.466925Z","end":"2026-09-10T02:12:34.601549Z","steps":["trace[1182003342] 'process raft request' (duration: 134.294679ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:34.60164Z","caller":"traceutil/trace.go:171","msg":"trace[547535593] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-glance-default-user; range_end:; response_count:1; response_revision:9428; }","duration":"141.23015ms","start":"2026-09-10T02:12:34.460394Z","end":"2026-09-10T02:12:34.601624Z","steps":["trace[547535593] 'agreement among raft nodes before linearized reading' (duration: 141.068165ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:34.60164Z","caller":"traceutil/trace.go:171","msg":"trace[1706304643] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-glance-server; range_end:; response_count:1; response_revision:9428; }","duration":"131.193816ms","start":"2026-09-10T02:12:34.470421Z","end":"2026-09-10T02:12:34.601615Z","steps":["trace[1706304643] 'agreement among raft nodes before linearized reading' (duration: 130.974219ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:34.63642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.939567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T02:12:34.636484Z","caller":"traceutil/trace.go:171","msg":"trace[1370182091] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:9429; }","duration":"104.013709ms","start":"2026-09-10T02:12:34.532453Z","end":"2026-09-10T02:12:34.636467Z","steps":["trace[1370182091] 'agreement among raft nodes before linearized reading' (duration: 103.877755ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:34.636507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.167386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-09-10T02:12:34.636545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.360021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-glance-server-0.18d3d3ccfc819534\" ","response":"range_response_count:1 size:1006"} {"level":"info","ts":"2026-09-10T02:12:34.636582Z","caller":"traceutil/trace.go:171","msg":"trace[2076953675] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9429; }","duration":"107.280739ms","start":"2026-09-10T02:12:34.529285Z","end":"2026-09-10T02:12:34.636565Z","steps":["trace[2076953675] 'agreement among raft nodes before linearized reading' (duration: 107.042192ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:34.636601Z","caller":"traceutil/trace.go:171","msg":"trace[2111251420] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-glance-server-0.18d3d3ccfc819534; range_end:; response_count:1; response_revision:9429; }","duration":"107.464435ms","start":"2026-09-10T02:12:34.52912Z","end":"2026-09-10T02:12:34.636585Z","steps":["trace[2111251420] 'agreement among raft nodes before linearized reading' (duration: 107.254389ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:34.636589Z","caller":"traceutil/trace.go:171","msg":"trace[22764602] transaction","detail":"{read_only:false; response_revision:9429; number_of_response:1; }","duration":"104.574067ms","start":"2026-09-10T02:12:34.531884Z","end":"2026-09-10T02:12:34.636458Z","steps":["trace[22764602] 'process raft request' (duration: 101.305538ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:34.787229Z","caller":"traceutil/trace.go:171","msg":"trace[1872059965] linearizableReadLoop","detail":"{readStateIndex:9760; appliedIndex:9758; }","duration":"150.906975ms","start":"2026-09-10T02:12:34.636298Z","end":"2026-09-10T02:12:34.787205Z","steps":["trace[1872059965] 'read index received' (duration: 103.660409ms)","trace[1872059965] 'applied index is now lower than readState.Index' (duration: 47.245466ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:34.787277Z","caller":"traceutil/trace.go:171","msg":"trace[593130774] transaction","detail":"{read_only:false; response_revision:9430; number_of_response:1; }","duration":"180.817753ms","start":"2026-09-10T02:12:34.606409Z","end":"2026-09-10T02:12:34.787227Z","steps":["trace[593130774] 'process raft request' (duration: 133.536837ms)","trace[593130774] 'compare' (duration: 47.024448ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:34.787333Z","caller":"traceutil/trace.go:171","msg":"trace[2110243106] transaction","detail":"{read_only:false; response_revision:9431; number_of_response:1; }","duration":"161.142205ms","start":"2026-09-10T02:12:34.626178Z","end":"2026-09-10T02:12:34.78732Z","steps":["trace[2110243106] 'process raft request' (duration: 160.96918ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:34.787502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.081669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-glance-nodes\" ","response":"range_response_count:1 size:1255"} {"level":"info","ts":"2026-09-10T02:12:34.787598Z","caller":"traceutil/trace.go:171","msg":"trace[203306123] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-glance-nodes; range_end:; response_count:1; response_revision:9431; }","duration":"178.230334ms","start":"2026-09-10T02:12:34.609346Z","end":"2026-09-10T02:12:34.787576Z","steps":["trace[203306123] 'agreement among raft nodes before linearized reading' (duration: 177.977296ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:34.838832Z","caller":"traceutil/trace.go:171","msg":"trace[1371211805] transaction","detail":"{read_only:false; response_revision:9432; number_of_response:1; }","duration":"197.5315ms","start":"2026-09-10T02:12:34.641272Z","end":"2026-09-10T02:12:34.838804Z","steps":["trace[1371211805] 'process raft request' (duration: 197.379935ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:34.839008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.83526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/local-path-storage/\" range_end:\"/registry/resourcequotas/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-10T02:12:34.839067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.863031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:20130"} {"level":"info","ts":"2026-09-10T02:12:34.839082Z","caller":"traceutil/trace.go:171","msg":"trace[571324259] range","detail":"{range_begin:/registry/resourcequotas/local-path-storage/; range_end:/registry/resourcequotas/local-path-storage0; response_count:0; response_revision:9432; }","duration":"197.938643ms","start":"2026-09-10T02:12:34.641126Z","end":"2026-09-10T02:12:34.839065Z","steps":["trace[571324259] 'agreement among raft nodes before linearized reading' (duration: 197.812349ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:34.839115Z","caller":"traceutil/trace.go:171","msg":"trace[1100110944] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:9432; }","duration":"197.940353ms","start":"2026-09-10T02:12:34.64116Z","end":"2026-09-10T02:12:34.839101Z","steps":["trace[1100110944] 'agreement among raft nodes before linearized reading' (duration: 197.726925ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:34.839751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.10477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225408"} {"level":"info","ts":"2026-09-10T02:12:34.839817Z","caller":"traceutil/trace.go:171","msg":"trace[858127927] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:9432; }","duration":"153.220433ms","start":"2026-09-10T02:12:34.68658Z","end":"2026-09-10T02:12:34.8398Z","steps":["trace[858127927] 'agreement among raft nodes before linearized reading' (duration: 152.265634ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:35.066868Z","caller":"traceutil/trace.go:171","msg":"trace[1984915303] transaction","detail":"{read_only:false; response_revision:9437; number_of_response:1; }","duration":"116.657944ms","start":"2026-09-10T02:12:34.950142Z","end":"2026-09-10T02:12:35.0668Z","steps":["trace[1984915303] 'process raft request' (duration: 93.362707ms)","trace[1984915303] 'compare' (duration: 23.08716ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:35.066869Z","caller":"traceutil/trace.go:171","msg":"trace[1919951628] linearizableReadLoop","detail":"{readStateIndex:9766; appliedIndex:9765; }","duration":"112.518377ms","start":"2026-09-10T02:12:34.954311Z","end":"2026-09-10T02:12:35.066829Z","steps":["trace[1919951628] 'read index received' (duration: 89.20674ms)","trace[1919951628] 'applied index is now lower than readState.Index' (duration: 23.307467ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:12:35.067074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.741244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-glance-server\" ","response":"range_response_count:1 size:9601"} {"level":"info","ts":"2026-09-10T02:12:35.067136Z","caller":"traceutil/trace.go:171","msg":"trace[831753376] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-glance-server; range_end:; response_count:1; response_revision:9438; }","duration":"112.864138ms","start":"2026-09-10T02:12:34.954258Z","end":"2026-09-10T02:12:35.067122Z","steps":["trace[831753376] 'agreement among raft nodes before linearized reading' (duration: 112.617701ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:35.067306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.514138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-09-10T02:12:35.067383Z","caller":"traceutil/trace.go:171","msg":"trace[1471743088] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:9438; }","duration":"111.635031ms","start":"2026-09-10T02:12:34.955725Z","end":"2026-09-10T02:12:35.06736Z","steps":["trace[1471743088] 'agreement among raft nodes before linearized reading' (duration: 111.460276ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:35.0674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.76212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3684"} {"level":"info","ts":"2026-09-10T02:12:35.0675Z","caller":"traceutil/trace.go:171","msg":"trace[1351520146] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:9438; }","duration":"100.899325ms","start":"2026-09-10T02:12:34.966583Z","end":"2026-09-10T02:12:35.067482Z","steps":["trace[1351520146] 'agreement among raft nodes before linearized reading' (duration: 100.627157ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:35.429764Z","caller":"traceutil/trace.go:171","msg":"trace[1381962686] linearizableReadLoop","detail":"{readStateIndex:9772; appliedIndex:9770; }","duration":"136.991371ms","start":"2026-09-10T02:12:35.292744Z","end":"2026-09-10T02:12:35.429736Z","steps":["trace[1381962686] 'read index received' (duration: 51.330419ms)","trace[1381962686] 'applied index is now lower than readState.Index' (duration: 85.659342ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:35.429785Z","caller":"traceutil/trace.go:171","msg":"trace[1793932217] transaction","detail":"{read_only:false; response_revision:9442; number_of_response:1; }","duration":"138.163276ms","start":"2026-09-10T02:12:35.291579Z","end":"2026-09-10T02:12:35.429743Z","steps":["trace[1793932217] 'process raft request' (duration: 52.482564ms)","trace[1793932217] 'compare' (duration: 85.077474ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:35.429949Z","caller":"traceutil/trace.go:171","msg":"trace[1861538836] transaction","detail":"{read_only:false; response_revision:9443; number_of_response:1; }","duration":"138.177927ms","start":"2026-09-10T02:12:35.291715Z","end":"2026-09-10T02:12:35.429893Z","steps":["trace[1861538836] 'process raft request' (duration: 137.896778ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:35.430278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.511787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-glance\" ","response":"range_response_count:1 size:1445"} {"level":"info","ts":"2026-09-10T02:12:35.43035Z","caller":"traceutil/trace.go:171","msg":"trace[4088687] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-glance; range_end:; response_count:1; response_revision:9443; }","duration":"137.61609ms","start":"2026-09-10T02:12:35.292712Z","end":"2026-09-10T02:12:35.430328Z","steps":["trace[4088687] 'agreement among raft nodes before linearized reading' (duration: 137.417254ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:35.506269Z","caller":"traceutil/trace.go:171","msg":"trace[1644740146] transaction","detail":"{read_only:false; response_revision:9444; number_of_response:1; }","duration":"104.003719ms","start":"2026-09-10T02:12:35.402232Z","end":"2026-09-10T02:12:35.506235Z","steps":["trace[1644740146] 'process raft request' (duration: 103.615407ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:35.506624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.214026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-09-10T02:12:35.506722Z","caller":"traceutil/trace.go:171","msg":"trace[911793189] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:9444; }","duration":"213.363971ms","start":"2026-09-10T02:12:35.293337Z","end":"2026-09-10T02:12:35.506701Z","steps":["trace[911793189] 'agreement among raft nodes before linearized reading' (duration: 213.088013ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:35.507015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.665309ms","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-09-10T02:12:35.50714Z","caller":"traceutil/trace.go:171","msg":"trace[1409626565] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9444; }","duration":"104.859975ms","start":"2026-09-10T02:12:35.402257Z","end":"2026-09-10T02:12:35.507117Z","steps":["trace[1409626565] 'agreement among raft nodes before linearized reading' (duration: 104.575477ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:35.652285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.823984ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-10T02:12:35.652443Z","caller":"traceutil/trace.go:171","msg":"trace[943577543] transaction","detail":"{read_only:false; response_revision:9445; number_of_response:1; }","duration":"138.848258ms","start":"2026-09-10T02:12:35.513572Z","end":"2026-09-10T02:12:35.652421Z","steps":["trace[943577543] 'process raft request' (duration: 34.764046ms)","trace[943577543] 'compare' (duration: 103.636538ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:35.674274Z","caller":"traceutil/trace.go:171","msg":"trace[830516245] linearizableReadLoop","detail":"{readStateIndex:9775; appliedIndex:9773; }","duration":"160.413932ms","start":"2026-09-10T02:12:35.513816Z","end":"2026-09-10T02:12:35.67423Z","steps":["trace[830516245] 'read index received' (duration: 34.536408ms)","trace[830516245] 'applied index is now lower than readState.Index' (duration: 125.876244ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:35.674506Z","caller":"traceutil/trace.go:171","msg":"trace[439683143] transaction","detail":"{read_only:false; response_revision:9446; number_of_response:1; }","duration":"160.728602ms","start":"2026-09-10T02:12:35.513743Z","end":"2026-09-10T02:12:35.674472Z","steps":["trace[439683143] 'process raft request' (duration: 160.195466ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:35.675273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.426883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:233276"} {"level":"info","ts":"2026-09-10T02:12:35.675368Z","caller":"traceutil/trace.go:171","msg":"trace[403705020] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:9446; }","duration":"161.585008ms","start":"2026-09-10T02:12:35.51377Z","end":"2026-09-10T02:12:35.675355Z","steps":["trace[403705020] 'agreement among raft nodes before linearized reading' (duration: 160.762513ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:35.690815Z","caller":"traceutil/trace.go:171","msg":"trace[1247876990] transaction","detail":"{read_only:false; response_revision:9447; number_of_response:1; }","duration":"111.199768ms","start":"2026-09-10T02:12:35.579589Z","end":"2026-09-10T02:12:35.690789Z","steps":["trace[1247876990] 'process raft request' (duration: 111.045733ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:35.690882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.155538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-glance-server\" ","response":"range_response_count:1 size:9601"} {"level":"info","ts":"2026-09-10T02:12:35.690927Z","caller":"traceutil/trace.go:171","msg":"trace[798535786] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-glance-server; range_end:; response_count:1; response_revision:9447; }","duration":"166.253281ms","start":"2026-09-10T02:12:35.52466Z","end":"2026-09-10T02:12:35.690913Z","steps":["trace[798535786] 'agreement among raft nodes before linearized reading' (duration: 166.093856ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:35.691193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.578479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:112184"} {"level":"info","ts":"2026-09-10T02:12:35.691238Z","caller":"traceutil/trace.go:171","msg":"trace[1900838972] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:9447; }","duration":"163.654971ms","start":"2026-09-10T02:12:35.527573Z","end":"2026-09-10T02:12:35.691228Z","steps":["trace[1900838972] 'agreement among raft nodes before linearized reading' (duration: 163.389993ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:36.363827Z","caller":"traceutil/trace.go:171","msg":"trace[462631176] linearizableReadLoop","detail":"{readStateIndex:9783; appliedIndex:9782; }","duration":"161.96783ms","start":"2026-09-10T02:12:36.201828Z","end":"2026-09-10T02:12:36.363796Z","steps":["trace[462631176] 'read index received' (duration: 69.703678ms)","trace[462631176] 'applied index is now lower than readState.Index' (duration: 92.262862ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:36.363962Z","caller":"traceutil/trace.go:171","msg":"trace[345551032] transaction","detail":"{read_only:false; response_revision:9453; number_of_response:1; }","duration":"164.821117ms","start":"2026-09-10T02:12:36.199097Z","end":"2026-09-10T02:12:36.363918Z","steps":["trace[345551032] 'process raft request' (duration: 72.465861ms)","trace[345551032] 'compare' (duration: 92.057106ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:12:36.364089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.231558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1443"} {"level":"info","ts":"2026-09-10T02:12:36.364142Z","caller":"traceutil/trace.go:171","msg":"trace[1082647134] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:9453; }","duration":"162.32266ms","start":"2026-09-10T02:12:36.201805Z","end":"2026-09-10T02:12:36.364128Z","steps":["trace[1082647134] 'agreement among raft nodes before linearized reading' (duration: 162.102323ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:36.504658Z","caller":"traceutil/trace.go:171","msg":"trace[448027101] transaction","detail":"{read_only:false; response_revision:9454; number_of_response:1; }","duration":"116.094426ms","start":"2026-09-10T02:12:36.388528Z","end":"2026-09-10T02:12:36.504622Z","steps":["trace[448027101] 'process raft request' (duration: 102.827294ms)","trace[448027101] 'compare' (duration: 13.085077ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:37.58577Z","caller":"traceutil/trace.go:171","msg":"trace[434013443] transaction","detail":"{read_only:false; response_revision:9461; number_of_response:1; }","duration":"252.213221ms","start":"2026-09-10T02:12:37.333527Z","end":"2026-09-10T02:12:37.58574Z","steps":["trace[434013443] 'process raft request' (duration: 252.052826ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:38.133107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.75749ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-10T02:12:38.133368Z","caller":"traceutil/trace.go:171","msg":"trace[560494327] transaction","detail":"{read_only:false; response_revision:9462; number_of_response:1; }","duration":"785.330755ms","start":"2026-09-10T02:12:37.347986Z","end":"2026-09-10T02:12:38.133316Z","steps":["trace[560494327] 'process raft request' (duration: 286.211954ms)","trace[560494327] 'compare' (duration: 498.446681ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:38.133469Z","caller":"traceutil/trace.go:171","msg":"trace[97441570] linearizableReadLoop","detail":"{readStateIndex:9792; appliedIndex:9790; }","duration":"697.351802ms","start":"2026-09-10T02:12:37.436091Z","end":"2026-09-10T02:12:38.133443Z","steps":["trace[97441570] 'read index received' (duration: 149.604745ms)","trace[97441570] 'applied index is now lower than readState.Index' (duration: 547.745467ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:12:38.133577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:37.347954Z","time spent":"785.51048ms","remote":"127.0.0.1:38850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":853,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-10T02:12:38.133766Z","caller":"traceutil/trace.go:171","msg":"trace[226225018] transaction","detail":"{read_only:false; response_revision:9463; number_of_response:1; }","duration":"621.561961ms","start":"2026-09-10T02:12:37.512163Z","end":"2026-09-10T02:12:38.133725Z","steps":["trace[226225018] 'process raft request' (duration: 621.078845ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:38.133854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.749576ms","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-09-10T02:12:38.1339Z","caller":"traceutil/trace.go:171","msg":"trace[1351830393] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9463; }","duration":"697.89387ms","start":"2026-09-10T02:12:37.435992Z","end":"2026-09-10T02:12:38.133886Z","steps":["trace[1351830393] 'agreement among raft nodes before linearized reading' (duration: 697.724255ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:38.133937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:37.435971Z","time spent":"697.957492ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-10T02:12:38.13396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:37.51213Z","time spent":"621.727906ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T02:12:38.343862Z","caller":"traceutil/trace.go:171","msg":"trace[1406028730] transaction","detail":"{read_only:false; response_revision:9464; number_of_response:1; }","duration":"647.708835ms","start":"2026-09-10T02:12:37.696115Z","end":"2026-09-10T02:12:38.343823Z","steps":["trace[1406028730] 'process raft request' (duration: 605.710949ms)","trace[1406028730] 'compare' (duration: 41.707337ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:12:38.344075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:37.696094Z","time spent":"647.853619ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T02:12:38.368647Z","caller":"traceutil/trace.go:171","msg":"trace[662508951] transaction","detail":"{read_only:false; response_revision:9465; number_of_response:1; }","duration":"572.159889ms","start":"2026-09-10T02:12:37.796463Z","end":"2026-09-10T02:12:38.368623Z","steps":["trace[662508951] 'process raft request' (duration: 571.979604ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:38.368789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:37.79643Z","time spent":"572.278374ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T02:12:38.368854Z","caller":"traceutil/trace.go:171","msg":"trace[1525224538] linearizableReadLoop","detail":"{readStateIndex:9795; appliedIndex:9793; }","duration":"235.261816ms","start":"2026-09-10T02:12:38.133558Z","end":"2026-09-10T02:12:38.36882Z","steps":["trace[1525224538] 'read index received' (duration: 168.284091ms)","trace[1525224538] 'applied index is now lower than readState.Index' (duration: 66.974885ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:12:38.369124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.756716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d070c311-1974-4845-b1be-4738e1c1496f\" ","response":"range_response_count:1 size:3641"} {"level":"warn","ts":"2026-09-10T02:12:38.369188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.161482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-68xqc\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-09-10T02:12:38.369209Z","caller":"traceutil/trace.go:171","msg":"trace[1336566001] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d070c311-1974-4845-b1be-4738e1c1496f; range_end:; response_count:1; response_revision:9466; }","duration":"403.880599ms","start":"2026-09-10T02:12:37.965309Z","end":"2026-09-10T02:12:38.36919Z","steps":["trace[1336566001] 'agreement among raft nodes before linearized reading' (duration: 403.615621ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:38.369261Z","caller":"traceutil/trace.go:171","msg":"trace[1820853075] range","detail":"{range_begin:/registry/pods/openstack/keepalived-68xqc; range_end:; response_count:1; response_revision:9466; }","duration":"684.270736ms","start":"2026-09-10T02:12:37.684972Z","end":"2026-09-10T02:12:38.369243Z","steps":["trace[1820853075] 'agreement among raft nodes before linearized reading' (duration: 684.028769ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:38.36914Z","caller":"traceutil/trace.go:171","msg":"trace[1211587473] transaction","detail":"{read_only:false; response_revision:9466; number_of_response:1; }","duration":"229.943654ms","start":"2026-09-10T02:12:38.139123Z","end":"2026-09-10T02:12:38.369067Z","steps":["trace[1211587473] 'process raft request' (duration: 229.457179ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:38.369269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:37.965285Z","time spent":"403.970102ms","remote":"127.0.0.1:38930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3665,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d070c311-1974-4845-b1be-4738e1c1496f\" "} {"level":"warn","ts":"2026-09-10T02:12:38.369322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:37.684959Z","time spent":"684.349248ms","remote":"127.0.0.1:38930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6555,"request content":"key:\"/registry/pods/openstack/keepalived-68xqc\" "} {"level":"warn","ts":"2026-09-10T02:12:38.36933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.897534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d070c311-1974-4845-b1be-4738e1c1496f\" ","response":"range_response_count:1 size:3641"} {"level":"info","ts":"2026-09-10T02:12:38.369833Z","caller":"traceutil/trace.go:171","msg":"trace[1914290474] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d070c311-1974-4845-b1be-4738e1c1496f; range_end:; response_count:1; response_revision:9466; }","duration":"283.44954ms","start":"2026-09-10T02:12:38.086365Z","end":"2026-09-10T02:12:38.369814Z","steps":["trace[1914290474] 'agreement among raft nodes before linearized reading' (duration: 282.706278ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:38.369417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.264105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T02:12:38.369943Z","caller":"traceutil/trace.go:171","msg":"trace[1517403614] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9466; }","duration":"232.822952ms","start":"2026-09-10T02:12:38.137104Z","end":"2026-09-10T02:12:38.369926Z","steps":["trace[1517403614] 'agreement among raft nodes before linearized reading' (duration: 232.256945ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:38.36943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.342958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"} {"level":"info","ts":"2026-09-10T02:12:38.370121Z","caller":"traceutil/trace.go:171","msg":"trace[207329785] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:9466; }","duration":"819.050989ms","start":"2026-09-10T02:12:37.551042Z","end":"2026-09-10T02:12:38.370093Z","steps":["trace[207329785] 'agreement among raft nodes before linearized reading' (duration: 818.267916ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:38.37019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:37.551009Z","time spent":"819.162304ms","remote":"127.0.0.1:38866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":380,"request content":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" "} {"level":"warn","ts":"2026-09-10T02:12:38.369437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.836095ms","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-09-10T02:12:38.370274Z","caller":"traceutil/trace.go:171","msg":"trace[1055040052] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9466; }","duration":"690.713142ms","start":"2026-09-10T02:12:37.679545Z","end":"2026-09-10T02:12:38.370258Z","steps":["trace[1055040052] 'agreement among raft nodes before linearized reading' (duration: 689.755402ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:38.370327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:37.679527Z","time spent":"690.785423ms","remote":"127.0.0.1:39016","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":"warn","ts":"2026-09-10T02:12:38.369396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.765903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-10T02:12:38.37041Z","caller":"traceutil/trace.go:171","msg":"trace[1782869469] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:9466; }","duration":"876.800475ms","start":"2026-09-10T02:12:37.493588Z","end":"2026-09-10T02:12:38.370389Z","steps":["trace[1782869469] 'agreement among raft nodes before linearized reading' (duration: 875.588538ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:38.370471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:37.493564Z","time spent":"876.889696ms","remote":"127.0.0.1:38912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1959,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"info","ts":"2026-09-10T02:12:38.634161Z","caller":"traceutil/trace.go:171","msg":"trace[1542823141] linearizableReadLoop","detail":"{readStateIndex:9798; appliedIndex:9797; }","duration":"214.691762ms","start":"2026-09-10T02:12:38.419447Z","end":"2026-09-10T02:12:38.634139Z","steps":["trace[1542823141] 'read index received' (duration: 214.514866ms)","trace[1542823141] 'applied index is now lower than readState.Index' (duration: 175.916µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:38.634237Z","caller":"traceutil/trace.go:171","msg":"trace[2029013406] transaction","detail":"{read_only:false; response_revision:9468; number_of_response:1; }","duration":"253.218352ms","start":"2026-09-10T02:12:38.380992Z","end":"2026-09-10T02:12:38.63421Z","steps":["trace[2029013406] 'process raft request' (duration: 252.948804ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:38.634309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.839626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-09-10T02:12:38.634513Z","caller":"traceutil/trace.go:171","msg":"trace[994993558] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:9468; }","duration":"215.001411ms","start":"2026-09-10T02:12:38.41941Z","end":"2026-09-10T02:12:38.634412Z","steps":["trace[994993558] 'agreement among raft nodes before linearized reading' (duration: 214.814945ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:38.658069Z","caller":"traceutil/trace.go:171","msg":"trace[1721725978] transaction","detail":"{read_only:false; response_revision:9469; number_of_response:1; }","duration":"125.520713ms","start":"2026-09-10T02:12:38.532494Z","end":"2026-09-10T02:12:38.658015Z","steps":["trace[1721725978] 'process raft request' (duration: 125.301996ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:38.823812Z","caller":"traceutil/trace.go:171","msg":"trace[1518434745] transaction","detail":"{read_only:false; response_revision:9470; number_of_response:1; }","duration":"160.266119ms","start":"2026-09-10T02:12:38.663518Z","end":"2026-09-10T02:12:38.823784Z","steps":["trace[1518434745] 'process raft request' (duration: 159.796504ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:40.155254Z","caller":"traceutil/trace.go:171","msg":"trace[1468092059] transaction","detail":"{read_only:false; response_revision:9476; number_of_response:1; }","duration":"145.891711ms","start":"2026-09-10T02:12:40.009337Z","end":"2026-09-10T02:12:40.155228Z","steps":["trace[1468092059] 'process raft request' (duration: 145.711916ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:40.357178Z","caller":"traceutil/trace.go:171","msg":"trace[592641452] transaction","detail":"{read_only:false; response_revision:9477; number_of_response:1; }","duration":"218.261339ms","start":"2026-09-10T02:12:40.138889Z","end":"2026-09-10T02:12:40.35715Z","steps":["trace[592641452] 'process raft request' (duration: 201.968824ms)","trace[592641452] 'compare' (duration: 15.946214ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:12:40.357369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.742926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T02:12:40.357489Z","caller":"traceutil/trace.go:171","msg":"trace[1485472854] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9477; }","duration":"220.915631ms","start":"2026-09-10T02:12:40.136549Z","end":"2026-09-10T02:12:40.357465Z","steps":["trace[1485472854] 'agreement among raft nodes before linearized reading' (duration: 220.714825ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:40.357062Z","caller":"traceutil/trace.go:171","msg":"trace[715233306] linearizableReadLoop","detail":"{readStateIndex:9807; appliedIndex:9806; }","duration":"201.608954ms","start":"2026-09-10T02:12:40.15537Z","end":"2026-09-10T02:12:40.356979Z","steps":["trace[715233306] 'read index received' (duration: 185.459993ms)","trace[715233306] 'applied index is now lower than readState.Index' (duration: 16.147241ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:12:40.369912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.88606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-10T02:12:40.369983Z","caller":"traceutil/trace.go:171","msg":"trace[357433293] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:9478; }","duration":"143.000484ms","start":"2026-09-10T02:12:40.226964Z","end":"2026-09-10T02:12:40.369964Z","steps":["trace[357433293] 'agreement among raft nodes before linearized reading' (duration: 142.86437ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:40.370111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.083831ms","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-09-10T02:12:40.37017Z","caller":"traceutil/trace.go:171","msg":"trace[2111337734] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9478; }","duration":"210.188874ms","start":"2026-09-10T02:12:40.159966Z","end":"2026-09-10T02:12:40.370155Z","steps":["trace[2111337734] 'agreement among raft nodes before linearized reading' (duration: 209.992598ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:40.76755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.825755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.128\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-10T02:12:40.767651Z","caller":"traceutil/trace.go:171","msg":"trace[775905330] range","detail":"{range_begin:/registry/masterleases/162.253.55.128; range_end:; response_count:1; response_revision:9482; }","duration":"106.97297ms","start":"2026-09-10T02:12:40.660654Z","end":"2026-09-10T02:12:40.767627Z","steps":["trace[775905330] 'range keys from in-memory index tree' (duration: 104.911487ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:40.768222Z","caller":"traceutil/trace.go:171","msg":"trace[1297773597] transaction","detail":"{read_only:false; response_revision:9483; number_of_response:1; }","duration":"104.089111ms","start":"2026-09-10T02:12:40.664119Z","end":"2026-09-10T02:12:40.768208Z","steps":["trace[1297773597] 'process raft request' (duration: 56.810514ms)","trace[1297773597] 'compare' (duration: 46.444002ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:41.227584Z","caller":"traceutil/trace.go:171","msg":"trace[1438018078] transaction","detail":"{read_only:false; response_revision:9486; number_of_response:1; }","duration":"102.165574ms","start":"2026-09-10T02:12:41.125388Z","end":"2026-09-10T02:12:41.227553Z","steps":["trace[1438018078] 'process raft request' (duration: 102.001399ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:41.781369Z","caller":"traceutil/trace.go:171","msg":"trace[823767494] linearizableReadLoop","detail":"{readStateIndex:9821; appliedIndex:9820; }","duration":"122.13416ms","start":"2026-09-10T02:12:41.659208Z","end":"2026-09-10T02:12:41.781342Z","steps":["trace[823767494] 'read index received' (duration: 122.010826ms)","trace[823767494] 'applied index is now lower than readState.Index' (duration: 122.334µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:41.781485Z","caller":"traceutil/trace.go:171","msg":"trace[834977808] transaction","detail":"{read_only:false; number_of_response:1; response_revision:9489; }","duration":"147.470679ms","start":"2026-09-10T02:12:41.633985Z","end":"2026-09-10T02:12:41.781456Z","steps":["trace[834977808] 'process raft request' (duration: 147.15451ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:41.781796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.555692ms","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-09-10T02:12:41.781847Z","caller":"traceutil/trace.go:171","msg":"trace[450468635] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9489; }","duration":"122.672346ms","start":"2026-09-10T02:12:41.659162Z","end":"2026-09-10T02:12:41.781834Z","steps":["trace[450468635] 'agreement among raft nodes before linearized reading' (duration: 122.272284ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:42.363465Z","caller":"traceutil/trace.go:171","msg":"trace[2140951974] transaction","detail":"{read_only:false; response_revision:9497; number_of_response:1; }","duration":"153.898375ms","start":"2026-09-10T02:12:42.209493Z","end":"2026-09-10T02:12:42.363391Z","steps":["trace[2140951974] 'process raft request' (duration: 153.631986ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:43.065379Z","caller":"traceutil/trace.go:171","msg":"trace[1837494379] transaction","detail":"{read_only:false; response_revision:9507; number_of_response:1; }","duration":"115.804188ms","start":"2026-09-10T02:12:42.949539Z","end":"2026-09-10T02:12:43.065343Z","steps":["trace[1837494379] 'process raft request' (duration: 115.431377ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:43.248921Z","caller":"traceutil/trace.go:171","msg":"trace[843408694] linearizableReadLoop","detail":"{readStateIndex:9841; appliedIndex:9840; }","duration":"108.97125ms","start":"2026-09-10T02:12:43.139897Z","end":"2026-09-10T02:12:43.248869Z","steps":["trace[843408694] 'read index received' (duration: 64.933223ms)","trace[843408694] 'applied index is now lower than readState.Index' (duration: 44.036847ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:43.248981Z","caller":"traceutil/trace.go:171","msg":"trace[1952707571] transaction","detail":"{read_only:false; response_revision:9509; number_of_response:1; }","duration":"170.20679ms","start":"2026-09-10T02:12:43.078722Z","end":"2026-09-10T02:12:43.248928Z","steps":["trace[1952707571] 'process raft request' (duration: 126.08557ms)","trace[1952707571] 'compare' (duration: 43.78406ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:12:43.249125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.206007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T02:12:43.249214Z","caller":"traceutil/trace.go:171","msg":"trace[1532567630] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9509; }","duration":"109.345531ms","start":"2026-09-10T02:12:43.139849Z","end":"2026-09-10T02:12:43.249194Z","steps":["trace[1532567630] 'agreement among raft nodes before linearized reading' (duration: 109.124274ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:44.148063Z","caller":"traceutil/trace.go:171","msg":"trace[374413408] transaction","detail":"{read_only:false; response_revision:9512; number_of_response:1; }","duration":"103.198565ms","start":"2026-09-10T02:12:44.044839Z","end":"2026-09-10T02:12:44.148037Z","steps":["trace[374413408] 'process raft request' (duration: 103.03184ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:44.598366Z","caller":"traceutil/trace.go:171","msg":"trace[627035186] transaction","detail":"{read_only:false; response_revision:9514; number_of_response:1; }","duration":"158.566296ms","start":"2026-09-10T02:12:44.439767Z","end":"2026-09-10T02:12:44.598334Z","steps":["trace[627035186] 'process raft request' (duration: 138.011562ms)","trace[627035186] 'compare' (duration: 20.175532ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:44.598531Z","caller":"traceutil/trace.go:171","msg":"trace[1416305066] transaction","detail":"{read_only:false; response_revision:9515; number_of_response:1; }","duration":"135.144865ms","start":"2026-09-10T02:12:44.463361Z","end":"2026-09-10T02:12:44.598506Z","steps":["trace[1416305066] 'process raft request' (duration: 134.897008ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:44.959958Z","caller":"traceutil/trace.go:171","msg":"trace[1246603325] transaction","detail":"{read_only:false; response_revision:9518; number_of_response:1; }","duration":"161.883478ms","start":"2026-09-10T02:12:44.798048Z","end":"2026-09-10T02:12:44.959932Z","steps":["trace[1246603325] 'process raft request' (duration: 161.697552ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:46.370816Z","caller":"traceutil/trace.go:171","msg":"trace[1729871730] transaction","detail":"{read_only:false; response_revision:9525; number_of_response:1; }","duration":"109.91327ms","start":"2026-09-10T02:12:46.260869Z","end":"2026-09-10T02:12:46.370782Z","steps":["trace[1729871730] 'process raft request' (duration: 109.684372ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:46.847446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.816525ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-10T02:12:46.84764Z","caller":"traceutil/trace.go:171","msg":"trace[538935453] transaction","detail":"{read_only:false; response_revision:9526; number_of_response:1; }","duration":"466.802949ms","start":"2026-09-10T02:12:46.38075Z","end":"2026-09-10T02:12:46.847553Z","steps":["trace[538935453] 'process raft request' (duration: 280.770028ms)","trace[538935453] 'compare' (duration: 185.508106ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:12:46.847861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:46.380719Z","time spent":"467.045717ms","remote":"127.0.0.1:38920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":885,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T02:12:47.024817Z","caller":"traceutil/trace.go:171","msg":"trace[610538996] linearizableReadLoop","detail":"{readStateIndex:9863; appliedIndex:9858; }","duration":"540.038425ms","start":"2026-09-10T02:12:46.484756Z","end":"2026-09-10T02:12:47.024795Z","steps":["trace[610538996] 'read index received' (duration: 176.79395ms)","trace[610538996] 'applied index is now lower than readState.Index' (duration: 363.243505ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:47.024951Z","caller":"traceutil/trace.go:171","msg":"trace[812252856] transaction","detail":"{read_only:false; response_revision:9529; number_of_response:1; }","duration":"643.096194ms","start":"2026-09-10T02:12:46.381772Z","end":"2026-09-10T02:12:47.024868Z","steps":["trace[812252856] 'process raft request' (duration: 642.871847ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:47.024945Z","caller":"traceutil/trace.go:171","msg":"trace[910794486] transaction","detail":"{read_only:false; response_revision:9530; number_of_response:1; }","duration":"564.213908ms","start":"2026-09-10T02:12:46.4607Z","end":"2026-09-10T02:12:47.024914Z","steps":["trace[910794486] 'process raft request' (duration: 563.978141ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:47.025045Z","caller":"traceutil/trace.go:171","msg":"trace[607506685] transaction","detail":"{read_only:false; response_revision:9531; number_of_response:1; }","duration":"421.049651ms","start":"2026-09-10T02:12:46.603981Z","end":"2026-09-10T02:12:47.025031Z","steps":["trace[607506685] 'process raft request' (duration: 420.740461ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:47.025116Z","caller":"traceutil/trace.go:171","msg":"trace[1566495525] transaction","detail":"{read_only:false; response_revision:9532; number_of_response:1; }","duration":"419.612506ms","start":"2026-09-10T02:12:46.605476Z","end":"2026-09-10T02:12:47.025089Z","steps":["trace[1566495525] 'process raft request' (duration: 419.280116ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:47.025134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:46.46067Z","time spent":"564.379613ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T02:12:47.025186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:46.603954Z","time spent":"421.141892ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T02:12:47.025226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:46.605446Z","time spent":"419.73065ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T02:12:47.025238Z","caller":"traceutil/trace.go:171","msg":"trace[457714296] transaction","detail":"{read_only:false; response_revision:9528; number_of_response:1; }","duration":"643.558049ms","start":"2026-09-10T02:12:46.381664Z","end":"2026-09-10T02:12:47.025222Z","steps":["trace[457714296] 'process raft request' (duration: 642.91756ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:47.025133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:46.381764Z","time spent":"643.27959ms","remote":"127.0.0.1:39018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T02:12:47.0253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.534489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T02:12:47.025102Z","caller":"traceutil/trace.go:171","msg":"trace[105616663] transaction","detail":"{read_only:false; response_revision:9527; number_of_response:1; }","duration":"643.761794ms","start":"2026-09-10T02:12:46.381232Z","end":"2026-09-10T02:12:47.024994Z","steps":["trace[105616663] 'process raft request' (duration: 612.424993ms)","trace[105616663] 'compare' (duration: 30.788285ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:47.025356Z","caller":"traceutil/trace.go:171","msg":"trace[1560819615] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:9532; }","duration":"540.634112ms","start":"2026-09-10T02:12:46.484706Z","end":"2026-09-10T02:12:47.02534Z","steps":["trace[1560819615] 'agreement among raft nodes before linearized reading' (duration: 540.534659ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:47.0254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:46.484683Z","time spent":"540.707724ms","remote":"127.0.0.1:39112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":29,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"warn","ts":"2026-09-10T02:12:47.025403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:46.381187Z","time spent":"644.167917ms","remote":"127.0.0.1:38920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T02:12:47.025404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:46.381636Z","time spent":"643.658451ms","remote":"127.0.0.1:39018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1415,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T02:12:47.086072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.493571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-09-10T02:12:47.086272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.6917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-glance\" ","response":"range_response_count:1 size:3306"} {"level":"warn","ts":"2026-09-10T02:12:47.086319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.459814ms","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-09-10T02:12:47.086382Z","caller":"traceutil/trace.go:171","msg":"trace[82216348] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-glance; range_end:; response_count:1; response_revision:9533; }","duration":"102.899816ms","start":"2026-09-10T02:12:46.983466Z","end":"2026-09-10T02:12:47.086366Z","steps":["trace[82216348] 'agreement among raft nodes before linearized reading' (duration: 102.456562ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:47.086403Z","caller":"traceutil/trace.go:171","msg":"trace[1352704448] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9533; }","duration":"427.591648ms","start":"2026-09-10T02:12:46.658795Z","end":"2026-09-10T02:12:47.086387Z","steps":["trace[1352704448] 'agreement among raft nodes before linearized reading' (duration: 427.348071ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:47.086448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:46.658777Z","time spent":"427.663161ms","remote":"127.0.0.1:39016","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-09-10T02:12:47.086081Z","caller":"traceutil/trace.go:171","msg":"trace[257595979] transaction","detail":"{read_only:false; response_revision:9533; number_of_response:1; }","duration":"120.431459ms","start":"2026-09-10T02:12:46.965612Z","end":"2026-09-10T02:12:47.086044Z","steps":["trace[257595979] 'process raft request' (duration: 120.132649ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:47.086194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.765603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-68xqc\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-09-10T02:12:47.086673Z","caller":"traceutil/trace.go:171","msg":"trace[2087800352] range","detail":"{range_begin:/registry/pods/openstack/keepalived-68xqc; range_end:; response_count:1; response_revision:9533; }","duration":"425.273888ms","start":"2026-09-10T02:12:46.661378Z","end":"2026-09-10T02:12:47.086651Z","steps":["trace[2087800352] 'agreement among raft nodes before linearized reading' (duration: 424.702381ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:47.086743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:46.661367Z","time spent":"425.35522ms","remote":"127.0.0.1:38930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6555,"request content":"key:\"/registry/pods/openstack/keepalived-68xqc\" "} {"level":"info","ts":"2026-09-10T02:12:47.086267Z","caller":"traceutil/trace.go:171","msg":"trace[888175617] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9533; }","duration":"466.726007ms","start":"2026-09-10T02:12:46.619516Z","end":"2026-09-10T02:12:47.086242Z","steps":["trace[888175617] 'agreement among raft nodes before linearized reading' (duration: 466.382826ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:47.087043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:12:46.619504Z","time spent":"467.49347ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-10T02:12:47.245115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.526317ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-10T02:12:47.245308Z","caller":"traceutil/trace.go:171","msg":"trace[1644116974] transaction","detail":"{read_only:false; response_revision:9535; number_of_response:1; }","duration":"153.313577ms","start":"2026-09-10T02:12:47.091944Z","end":"2026-09-10T02:12:47.245257Z","steps":["trace[1644116974] 'process raft request' (duration: 43.565363ms)","trace[1644116974] 'compare' (duration: 109.386683ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:47.245379Z","caller":"traceutil/trace.go:171","msg":"trace[1283661613] linearizableReadLoop","detail":"{readStateIndex:9868; appliedIndex:9867; }","duration":"109.099874ms","start":"2026-09-10T02:12:47.136253Z","end":"2026-09-10T02:12:47.245353Z","steps":["trace[1283661613] 'read index received' (duration: 43.702µs)","trace[1283661613] 'applied index is now lower than readState.Index' (duration: 109.054072ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:12:47.245518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.253069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T02:12:47.245603Z","caller":"traceutil/trace.go:171","msg":"trace[419637609] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9535; }","duration":"109.369602ms","start":"2026-09-10T02:12:47.136211Z","end":"2026-09-10T02:12:47.245581Z","steps":["trace[419637609] 'agreement among raft nodes before linearized reading' (duration: 109.249539ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:47.381042Z","caller":"traceutil/trace.go:171","msg":"trace[767249537] linearizableReadLoop","detail":"{readStateIndex:9872; appliedIndex:9869; }","duration":"108.499135ms","start":"2026-09-10T02:12:47.272493Z","end":"2026-09-10T02:12:47.380992Z","steps":["trace[767249537] 'read index received' (duration: 25.659609ms)","trace[767249537] 'applied index is now lower than readState.Index' (duration: 82.838606ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:47.3813Z","caller":"traceutil/trace.go:171","msg":"trace[45929441] transaction","detail":"{read_only:false; response_revision:9537; number_of_response:1; }","duration":"131.70493ms","start":"2026-09-10T02:12:47.249583Z","end":"2026-09-10T02:12:47.381288Z","steps":["trace[45929441] 'process raft request' (duration: 123.701578ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:47.381517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.998741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1857"} {"level":"info","ts":"2026-09-10T02:12:47.381588Z","caller":"traceutil/trace.go:171","msg":"trace[2028252248] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:9538; }","duration":"109.110584ms","start":"2026-09-10T02:12:47.27246Z","end":"2026-09-10T02:12:47.381571Z","steps":["trace[2028252248] 'agreement among raft nodes before linearized reading' (duration: 108.896056ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:47.381949Z","caller":"traceutil/trace.go:171","msg":"trace[290674681] transaction","detail":"{read_only:false; response_revision:9538; number_of_response:1; }","duration":"123.258324ms","start":"2026-09-10T02:12:47.258678Z","end":"2026-09-10T02:12:47.381936Z","steps":["trace[290674681] 'process raft request' (duration: 122.239562ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:47.772929Z","caller":"traceutil/trace.go:171","msg":"trace[173556128] transaction","detail":"{read_only:false; response_revision:9540; number_of_response:1; }","duration":"111.687452ms","start":"2026-09-10T02:12:47.661217Z","end":"2026-09-10T02:12:47.772905Z","steps":["trace[173556128] 'process raft request' (duration: 111.486436ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:47.978917Z","caller":"traceutil/trace.go:171","msg":"trace[157215146] transaction","detail":"{read_only:false; response_revision:9541; number_of_response:1; }","duration":"156.309417ms","start":"2026-09-10T02:12:47.822577Z","end":"2026-09-10T02:12:47.978887Z","steps":["trace[157215146] 'process raft request' (duration: 156.145612ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:48.19348Z","caller":"traceutil/trace.go:171","msg":"trace[975699156] transaction","detail":"{read_only:false; response_revision:9543; number_of_response:1; }","duration":"147.802269ms","start":"2026-09-10T02:12:48.045649Z","end":"2026-09-10T02:12:48.193451Z","steps":["trace[975699156] 'process raft request' (duration: 102.676559ms)","trace[975699156] 'compare' (duration: 44.334357ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:49.222076Z","caller":"traceutil/trace.go:171","msg":"trace[17872520] transaction","detail":"{read_only:false; response_revision:9545; number_of_response:1; }","duration":"182.450292ms","start":"2026-09-10T02:12:49.039594Z","end":"2026-09-10T02:12:49.222044Z","steps":["trace[17872520] 'process raft request' (duration: 182.232885ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:49.263568Z","caller":"traceutil/trace.go:171","msg":"trace[1115476372] transaction","detail":"{read_only:false; response_revision:9546; number_of_response:1; }","duration":"221.924072ms","start":"2026-09-10T02:12:49.041582Z","end":"2026-09-10T02:12:49.263506Z","steps":["trace[1115476372] 'process raft request' (duration: 221.694605ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:49.263855Z","caller":"traceutil/trace.go:171","msg":"trace[124751553] transaction","detail":"{read_only:false; response_revision:9547; number_of_response:1; }","duration":"222.101397ms","start":"2026-09-10T02:12:49.041726Z","end":"2026-09-10T02:12:49.263828Z","steps":["trace[124751553] 'process raft request' (duration: 221.727646ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:49.264229Z","caller":"traceutil/trace.go:171","msg":"trace[849596140] linearizableReadLoop","detail":"{readStateIndex:9882; appliedIndex:9878; }","duration":"149.267614ms","start":"2026-09-10T02:12:49.114945Z","end":"2026-09-10T02:12:49.264213Z","steps":["trace[849596140] 'read index received' (duration: 106.859146ms)","trace[849596140] 'applied index is now lower than readState.Index' (duration: 42.407528ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:49.264385Z","caller":"traceutil/trace.go:171","msg":"trace[2055279132] transaction","detail":"{read_only:false; response_revision:9548; number_of_response:1; }","duration":"168.778956ms","start":"2026-09-10T02:12:49.09559Z","end":"2026-09-10T02:12:49.264369Z","steps":["trace[2055279132] 'process raft request' (duration: 168.257241ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:49.26468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.714637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-09-10T02:12:49.264822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.309155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-68xqc\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-09-10T02:12:49.264933Z","caller":"traceutil/trace.go:171","msg":"trace[701168460] range","detail":"{range_begin:/registry/pods/openstack/keepalived-68xqc; range_end:; response_count:1; response_revision:9548; }","duration":"146.445398ms","start":"2026-09-10T02:12:49.118468Z","end":"2026-09-10T02:12:49.264913Z","steps":["trace[701168460] 'agreement among raft nodes before linearized reading' (duration: 146.201801ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:49.265099Z","caller":"traceutil/trace.go:171","msg":"trace[1156893689] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9548; }","duration":"149.817771ms","start":"2026-09-10T02:12:49.114908Z","end":"2026-09-10T02:12:49.264726Z","steps":["trace[1156893689] 'agreement among raft nodes before linearized reading' (duration: 149.647605ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:49.264989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.70455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T02:12:49.265345Z","caller":"traceutil/trace.go:171","msg":"trace[305325635] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9548; }","duration":"131.973059ms","start":"2026-09-10T02:12:49.133178Z","end":"2026-09-10T02:12:49.265151Z","steps":["trace[305325635] 'agreement among raft nodes before linearized reading' (duration: 131.604078ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:49.386298Z","caller":"traceutil/trace.go:171","msg":"trace[1500602752] linearizableReadLoop","detail":"{readStateIndex:9883; appliedIndex:9882; }","duration":"114.808698ms","start":"2026-09-10T02:12:49.271465Z","end":"2026-09-10T02:12:49.386273Z","steps":["trace[1500602752] 'read index received' (duration: 111.068875ms)","trace[1500602752] 'applied index is now lower than readState.Index' (duration: 3.738493ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:49.386313Z","caller":"traceutil/trace.go:171","msg":"trace[294650636] transaction","detail":"{read_only:false; response_revision:9549; number_of_response:1; }","duration":"116.687164ms","start":"2026-09-10T02:12:49.269595Z","end":"2026-09-10T02:12:49.386283Z","steps":["trace[294650636] 'process raft request' (duration: 113.039374ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:12:49.386645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.171389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:234984"} {"level":"info","ts":"2026-09-10T02:12:49.386682Z","caller":"traceutil/trace.go:171","msg":"trace[1611531504] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:9549; }","duration":"115.247452ms","start":"2026-09-10T02:12:49.271427Z","end":"2026-09-10T02:12:49.386675Z","steps":["trace[1611531504] 'agreement among raft nodes before linearized reading' (duration: 114.931491ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:49.407885Z","caller":"traceutil/trace.go:171","msg":"trace[1695396306] transaction","detail":"{read_only:false; response_revision:9550; number_of_response:1; }","duration":"135.896568ms","start":"2026-09-10T02:12:49.27191Z","end":"2026-09-10T02:12:49.407807Z","steps":["trace[1695396306] 'process raft request' (duration: 135.688372ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:49.545257Z","caller":"traceutil/trace.go:171","msg":"trace[399445570] linearizableReadLoop","detail":"{readStateIndex:9886; appliedIndex:9884; }","duration":"126.765541ms","start":"2026-09-10T02:12:49.418471Z","end":"2026-09-10T02:12:49.545237Z","steps":["trace[399445570] 'read index received' (duration: 88.256941ms)","trace[399445570] 'applied index is now lower than readState.Index' (duration: 38.50785ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:12:49.545609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.120601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-10T02:12:49.54569Z","caller":"traceutil/trace.go:171","msg":"trace[1441159146] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:9552; }","duration":"127.242715ms","start":"2026-09-10T02:12:49.418432Z","end":"2026-09-10T02:12:49.545675Z","steps":["trace[1441159146] 'agreement among raft nodes before linearized reading' (duration: 127.0843ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:49.545609Z","caller":"traceutil/trace.go:171","msg":"trace[2005261976] transaction","detail":"{read_only:false; response_revision:9551; number_of_response:1; }","duration":"132.272087ms","start":"2026-09-10T02:12:49.413303Z","end":"2026-09-10T02:12:49.545575Z","steps":["trace[2005261976] 'process raft request' (duration: 93.413137ms)","trace[2005261976] 'compare' (duration: 38.377636ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:12:49.546036Z","caller":"traceutil/trace.go:171","msg":"trace[481942857] transaction","detail":"{read_only:false; response_revision:9552; number_of_response:1; }","duration":"130.39826ms","start":"2026-09-10T02:12:49.415594Z","end":"2026-09-10T02:12:49.545992Z","steps":["trace[481942857] 'process raft request' (duration: 129.602167ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:50.420609Z","caller":"traceutil/trace.go:171","msg":"trace[605346976] transaction","detail":"{read_only:false; response_revision:9554; number_of_response:1; }","duration":"160.834476ms","start":"2026-09-10T02:12:50.258427Z","end":"2026-09-10T02:12:50.419262Z","steps":["trace[605346976] 'process raft request' (duration: 160.667911ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:51.376335Z","caller":"traceutil/trace.go:171","msg":"trace[2110919811] transaction","detail":"{read_only:false; response_revision:9558; number_of_response:1; }","duration":"105.485274ms","start":"2026-09-10T02:12:51.270726Z","end":"2026-09-10T02:12:51.376211Z","steps":["trace[2110919811] 'process raft request' (duration: 105.264647ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:12:51.376466Z","caller":"traceutil/trace.go:171","msg":"trace[813788430] transaction","detail":"{read_only:false; response_revision:9559; number_of_response:1; }","duration":"105.586087ms","start":"2026-09-10T02:12:51.270832Z","end":"2026-09-10T02:12:51.376418Z","steps":["trace[813788430] 'process raft request' (duration: 105.33455ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:13:07.680796Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3e8b7bea2e3a32b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-10T02:13:07.687792Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-09-10T02:13:07.687891Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-09-10T02:13:25.89164Z","caller":"traceutil/trace.go:171","msg":"trace[93310459] linearizableReadLoop","detail":"{readStateIndex:10274; appliedIndex:10273; }","duration":"104.360431ms","start":"2026-09-10T02:13:25.787259Z","end":"2026-09-10T02:13:25.891619Z","steps":["trace[93310459] 'read index received' (duration: 104.199456ms)","trace[93310459] 'applied index is now lower than readState.Index' (duration: 159.775µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:13:25.891802Z","caller":"traceutil/trace.go:171","msg":"trace[409348869] transaction","detail":"{read_only:false; response_revision:9932; number_of_response:1; }","duration":"109.94892ms","start":"2026-09-10T02:13:25.781811Z","end":"2026-09-10T02:13:25.89176Z","steps":["trace[409348869] 'process raft request' (duration: 109.660021ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:13:25.891872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.590528ms","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-09-10T02:13:25.891907Z","caller":"traceutil/trace.go:171","msg":"trace[575639232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9932; }","duration":"104.659409ms","start":"2026-09-10T02:13:25.787236Z","end":"2026-09-10T02:13:25.891896Z","steps":["trace[575639232] 'agreement among raft nodes before linearized reading' (duration: 104.518605ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:13:40.832675Z","caller":"traceutil/trace.go:171","msg":"trace[454323069] transaction","detail":"{read_only:false; response_revision:10014; number_of_response:1; }","duration":"129.060489ms","start":"2026-09-10T02:13:40.703585Z","end":"2026-09-10T02:13:40.832645Z","steps":["trace[454323069] 'process raft request' (duration: 128.962036ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:13:40.832736Z","caller":"traceutil/trace.go:171","msg":"trace[2104944531] transaction","detail":"{read_only:false; response_revision:10013; number_of_response:1; }","duration":"132.755012ms","start":"2026-09-10T02:13:40.699942Z","end":"2026-09-10T02:13:40.832697Z","steps":["trace[2104944531] 'process raft request' (duration: 85.795845ms)","trace[2104944531] 'compare' (duration: 46.522924ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:14:37.265808Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8055} {"level":"info","ts":"2026-09-10T02:14:37.355115Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8055,"took":"85.824897ms","hash":1451490414,"current-db-size-bytes":55672832,"current-db-size":"56 MB","current-db-size-in-use-bytes":25272320,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-09-10T02:14:37.35519Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1451490414,"revision":8055,"compact-revision":5781} {"level":"info","ts":"2026-09-10T02:18:58.653123Z","caller":"traceutil/trace.go:171","msg":"trace[1435101948] transaction","detail":"{read_only:false; response_revision:12324; number_of_response:1; }","duration":"122.398396ms","start":"2026-09-10T02:18:58.530692Z","end":"2026-09-10T02:18:58.653091Z","steps":["trace[1435101948] 'process raft request' (duration: 122.147859ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:18:58.832816Z","caller":"traceutil/trace.go:171","msg":"trace[330956205] transaction","detail":"{read_only:false; response_revision:12325; number_of_response:1; }","duration":"136.510455ms","start":"2026-09-10T02:18:58.696276Z","end":"2026-09-10T02:18:58.832786Z","steps":["trace[330956205] 'process raft request' (duration: 112.720553ms)","trace[330956205] 'compare' (duration: 23.602126ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:19:20.51787Z","caller":"traceutil/trace.go:171","msg":"trace[909821639] transaction","detail":"{read_only:false; response_revision:12447; number_of_response:1; }","duration":"187.757431ms","start":"2026-09-10T02:19:20.330067Z","end":"2026-09-10T02:19:20.517825Z","steps":["trace[909821639] 'process raft request' (duration: 187.530685ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:19:20.559011Z","caller":"traceutil/trace.go:171","msg":"trace[83158942] transaction","detail":"{read_only:false; response_revision:12448; number_of_response:1; }","duration":"139.378793ms","start":"2026-09-10T02:19:20.419594Z","end":"2026-09-10T02:19:20.558973Z","steps":["trace[83158942] 'process raft request' (duration: 139.205938ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:19:37.274231Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10418} {"level":"info","ts":"2026-09-10T02:19:37.365824Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10418,"took":"88.459226ms","hash":3395490516,"current-db-size-bytes":55672832,"current-db-size":"56 MB","current-db-size-in-use-bytes":25333760,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-09-10T02:19:37.365906Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3395490516,"revision":10418,"compact-revision":8055} {"level":"info","ts":"2026-09-10T02:24:37.282818Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12589} {"level":"info","ts":"2026-09-10T02:24:37.371922Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12589,"took":"85.805805ms","hash":3282319580,"current-db-size-bytes":55672832,"current-db-size":"56 MB","current-db-size-in-use-bytes":27688960,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-10T02:24:37.372011Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3282319580,"revision":12589,"compact-revision":10418} {"level":"info","ts":"2026-09-10T02:25:26.215575Z","caller":"traceutil/trace.go:171","msg":"trace[916233053] transaction","detail":"{read_only:false; response_revision:14920; number_of_response:1; }","duration":"100.14747ms","start":"2026-09-10T02:25:26.115393Z","end":"2026-09-10T02:25:26.21554Z","steps":["trace[916233053] 'process raft request' (duration: 99.633895ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:25:54.694981Z","caller":"traceutil/trace.go:171","msg":"trace[1200019879] transaction","detail":"{read_only:false; response_revision:15072; number_of_response:1; }","duration":"126.355087ms","start":"2026-09-10T02:25:54.568609Z","end":"2026-09-10T02:25:54.694964Z","steps":["trace[1200019879] 'process raft request' (duration: 126.234533ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:26:11.242766Z","caller":"traceutil/trace.go:171","msg":"trace[348117434] transaction","detail":"{read_only:false; response_revision:15174; number_of_response:1; }","duration":"152.735887ms","start":"2026-09-10T02:26:11.090005Z","end":"2026-09-10T02:26:11.242741Z","steps":["trace[348117434] 'process raft request' (duration: 152.556012ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:26:11.345733Z","caller":"traceutil/trace.go:171","msg":"trace[701108744] linearizableReadLoop","detail":"{readStateIndex:15698; appliedIndex:15696; }","duration":"209.443239ms","start":"2026-09-10T02:26:11.136263Z","end":"2026-09-10T02:26:11.345706Z","steps":["trace[701108744] 'read index received' (duration: 106.394531ms)","trace[701108744] 'applied index is now lower than readState.Index' (duration: 103.047498ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:26:11.345836Z","caller":"traceutil/trace.go:171","msg":"trace[911593823] transaction","detail":"{read_only:false; response_revision:15175; number_of_response:1; }","duration":"247.94612ms","start":"2026-09-10T02:26:11.09788Z","end":"2026-09-10T02:26:11.345826Z","steps":["trace[911593823] 'process raft request' (duration: 247.682221ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:26:11.34613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.851512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T02:26:11.346163Z","caller":"traceutil/trace.go:171","msg":"trace[1574322625] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15175; }","duration":"209.947535ms","start":"2026-09-10T02:26:11.136207Z","end":"2026-09-10T02:26:11.346154Z","steps":["trace[1574322625] 'agreement among raft nodes before linearized reading' (duration: 209.878883ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:26:12.086733Z","caller":"traceutil/trace.go:171","msg":"trace[1985505474] linearizableReadLoop","detail":"{readStateIndex:15700; appliedIndex:15699; }","duration":"215.319469ms","start":"2026-09-10T02:26:11.871389Z","end":"2026-09-10T02:26:12.086709Z","steps":["trace[1985505474] 'read index received' (duration: 215.119683ms)","trace[1985505474] 'applied index is now lower than readState.Index' (duration: 198.636µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:26:12.086827Z","caller":"traceutil/trace.go:171","msg":"trace[256006402] transaction","detail":"{read_only:false; response_revision:15177; number_of_response:1; }","duration":"231.330984ms","start":"2026-09-10T02:26:11.855459Z","end":"2026-09-10T02:26:12.08679Z","steps":["trace[256006402] 'process raft request' (duration: 231.094787ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:26:12.086936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.529134ms","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-09-10T02:26:12.087003Z","caller":"traceutil/trace.go:171","msg":"trace[1152013606] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15177; }","duration":"215.608927ms","start":"2026-09-10T02:26:11.871379Z","end":"2026-09-10T02:26:12.086988Z","steps":["trace[1152013606] 'agreement among raft nodes before linearized reading' (duration: 215.424281ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:26:12.087133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.10993ms","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-09-10T02:26:12.087183Z","caller":"traceutil/trace.go:171","msg":"trace[493885755] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15177; }","duration":"213.211204ms","start":"2026-09-10T02:26:11.873957Z","end":"2026-09-10T02:26:12.087168Z","steps":["trace[493885755] 'agreement among raft nodes before linearized reading' (duration: 212.942246ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:26:12.303222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.252716ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-10T02:26:12.30351Z","caller":"traceutil/trace.go:171","msg":"trace[1834674360] linearizableReadLoop","detail":"{readStateIndex:15702; appliedIndex:15700; }","duration":"169.305121ms","start":"2026-09-10T02:26:12.134186Z","end":"2026-09-10T02:26:12.303491Z","steps":["trace[1834674360] 'read index received' (duration: 36.001433ms)","trace[1834674360] 'applied index is now lower than readState.Index' (duration: 133.302438ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:26:12.303607Z","caller":"traceutil/trace.go:171","msg":"trace[1010010401] transaction","detail":"{read_only:false; response_revision:15179; number_of_response:1; }","duration":"211.507342ms","start":"2026-09-10T02:26:12.09209Z","end":"2026-09-10T02:26:12.303597Z","steps":["trace[1010010401] 'process raft request' (duration: 211.285245ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:26:12.303711Z","caller":"traceutil/trace.go:171","msg":"trace[1032583295] transaction","detail":"{read_only:false; response_revision:15178; number_of_response:1; }","duration":"212.330818ms","start":"2026-09-10T02:26:12.09134Z","end":"2026-09-10T02:26:12.303671Z","steps":["trace[1032583295] 'process raft request' (duration: 78.852514ms)","trace[1032583295] 'compare' (duration: 132.136233ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:26:12.303834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.650131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-10T02:26:12.303865Z","caller":"traceutil/trace.go:171","msg":"trace[1766826257] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:15179; }","duration":"169.749704ms","start":"2026-09-10T02:26:12.134106Z","end":"2026-09-10T02:26:12.303856Z","steps":["trace[1766826257] 'agreement among raft nodes before linearized reading' (duration: 169.62825ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:26:13.436904Z","caller":"traceutil/trace.go:171","msg":"trace[809023060] transaction","detail":"{read_only:false; response_revision:15190; number_of_response:1; }","duration":"151.348465ms","start":"2026-09-10T02:26:13.285495Z","end":"2026-09-10T02:26:13.436843Z","steps":["trace[809023060] 'process raft request' (duration: 109.551476ms)","trace[809023060] 'compare' (duration: 41.641695ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:26:36.639915Z","caller":"traceutil/trace.go:171","msg":"trace[1483589668] transaction","detail":"{read_only:false; response_revision:15499; number_of_response:1; }","duration":"177.341726ms","start":"2026-09-10T02:26:36.462518Z","end":"2026-09-10T02:26:36.639859Z","steps":["trace[1483589668] 'process raft request' (duration: 177.163181ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:26:36.640112Z","caller":"traceutil/trace.go:171","msg":"trace[1369800319] transaction","detail":"{read_only:false; response_revision:15500; number_of_response:1; }","duration":"176.081477ms","start":"2026-09-10T02:26:36.463982Z","end":"2026-09-10T02:26:36.640064Z","steps":["trace[1369800319] 'process raft request' (duration: 175.773198ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:26:36.639868Z","caller":"traceutil/trace.go:171","msg":"trace[674974657] transaction","detail":"{read_only:false; response_revision:15498; number_of_response:1; }","duration":"177.344406ms","start":"2026-09-10T02:26:36.462466Z","end":"2026-09-10T02:26:36.63981Z","steps":["trace[674974657] 'process raft request' (duration: 155.294706ms)","trace[674974657] 'compare' (duration: 21.221094ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:26:37.055784Z","caller":"traceutil/trace.go:171","msg":"trace[538843646] transaction","detail":"{read_only:false; response_revision:15501; number_of_response:1; }","duration":"210.468701ms","start":"2026-09-10T02:26:36.84528Z","end":"2026-09-10T02:26:37.055748Z","steps":["trace[538843646] 'process raft request' (duration: 210.275635ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:26:37.153201Z","caller":"traceutil/trace.go:171","msg":"trace[1028619303] transaction","detail":"{read_only:false; response_revision:15503; number_of_response:1; }","duration":"301.017721ms","start":"2026-09-10T02:26:36.852155Z","end":"2026-09-10T02:26:37.153173Z","steps":["trace[1028619303] 'process raft request' (duration: 300.935048ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:26:37.153223Z","caller":"traceutil/trace.go:171","msg":"trace[954834785] transaction","detail":"{read_only:false; response_revision:15502; number_of_response:1; }","duration":"306.797006ms","start":"2026-09-10T02:26:36.846375Z","end":"2026-09-10T02:26:37.153172Z","steps":["trace[954834785] 'process raft request' (duration: 302.928219ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:26:37.153369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:26:36.852121Z","time spent":"301.168655ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T02:26:37.153439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:26:36.846349Z","time spent":"306.976562ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T02:26:37.15357Z","caller":"traceutil/trace.go:171","msg":"trace[76326413] linearizableReadLoop","detail":"{readStateIndex:16041; appliedIndex:16037; }","duration":"229.230551ms","start":"2026-09-10T02:26:36.924326Z","end":"2026-09-10T02:26:37.153557Z","steps":["trace[76326413] 'read index received' (duration: 131.285777ms)","trace[76326413] 'applied index is now lower than readState.Index' (duration: 97.943724ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:26:37.1537Z","caller":"traceutil/trace.go:171","msg":"trace[937595236] transaction","detail":"{read_only:false; response_revision:15504; number_of_response:1; }","duration":"296.600177ms","start":"2026-09-10T02:26:36.857043Z","end":"2026-09-10T02:26:37.153643Z","steps":["trace[937595236] 'process raft request' (duration: 296.08692ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:26:37.153796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.486809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-68xqc\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-09-10T02:26:37.153842Z","caller":"traceutil/trace.go:171","msg":"trace[29508353] range","detail":"{range_begin:/registry/pods/openstack/keepalived-68xqc; range_end:; response_count:1; response_revision:15504; }","duration":"229.610832ms","start":"2026-09-10T02:26:36.924218Z","end":"2026-09-10T02:26:37.153829Z","steps":["trace[29508353] 'agreement among raft nodes before linearized reading' (duration: 229.418856ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:26:37.154111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.040673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-10T02:26:37.154251Z","caller":"traceutil/trace.go:171","msg":"trace[860888426] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:15505; }","duration":"141.214178ms","start":"2026-09-10T02:26:37.012992Z","end":"2026-09-10T02:26:37.154207Z","steps":["trace[860888426] 'agreement among raft nodes before linearized reading' (duration: 140.912299ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:27:31.183766Z","caller":"traceutil/trace.go:171","msg":"trace[448519649] transaction","detail":"{read_only:false; response_revision:16143; number_of_response:1; }","duration":"123.282244ms","start":"2026-09-10T02:27:31.060452Z","end":"2026-09-10T02:27:31.183734Z","steps":["trace[448519649] 'process raft request' (duration: 123.020505ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:27:55.657575Z","caller":"traceutil/trace.go:171","msg":"trace[1948017866] transaction","detail":"{read_only:false; response_revision:16271; number_of_response:1; }","duration":"328.61323ms","start":"2026-09-10T02:27:55.328926Z","end":"2026-09-10T02:27:55.657539Z","steps":["trace[1948017866] 'process raft request' (duration: 327.482455ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:27:55.657512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.871091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-09-10T02:27:55.657783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:27:55.328871Z","time spent":"328.803625ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T02:27:55.657844Z","caller":"traceutil/trace.go:171","msg":"trace[979944277] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16271; }","duration":"312.16714ms","start":"2026-09-10T02:27:55.345578Z","end":"2026-09-10T02:27:55.657745Z","steps":["trace[979944277] 'agreement among raft nodes before linearized reading' (duration: 311.744367ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:27:55.657934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:27:55.345555Z","time spent":"312.345534ms","remote":"127.0.0.1:39016","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-09-10T02:27:55.657297Z","caller":"traceutil/trace.go:171","msg":"trace[325753909] linearizableReadLoop","detail":"{readStateIndex:16828; appliedIndex:16827; }","duration":"311.637254ms","start":"2026-09-10T02:27:55.34562Z","end":"2026-09-10T02:27:55.657257Z","steps":["trace[325753909] 'read index received' (duration: 310.960153ms)","trace[325753909] 'applied index is now lower than readState.Index' (duration: 674.681µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:27:55.964003Z","caller":"traceutil/trace.go:171","msg":"trace[877267166] linearizableReadLoop","detail":"{readStateIndex:16829; appliedIndex:16828; }","duration":"305.263139ms","start":"2026-09-10T02:27:55.658714Z","end":"2026-09-10T02:27:55.963977Z","steps":["trace[877267166] 'read index received' (duration: 247.091882ms)","trace[877267166] 'applied index is now lower than readState.Index' (duration: 58.170057ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:27:55.964175Z","caller":"traceutil/trace.go:171","msg":"trace[1988648256] transaction","detail":"{read_only:false; response_revision:16272; number_of_response:1; }","duration":"475.336025ms","start":"2026-09-10T02:27:55.4887Z","end":"2026-09-10T02:27:55.964036Z","steps":["trace[1988648256] 'process raft request' (duration: 417.094126ms)","trace[1988648256] 'compare' (duration: 58.069204ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:27:55.964329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.342387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-10T02:27:55.964419Z","caller":"traceutil/trace.go:171","msg":"trace[790773751] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:16272; }","duration":"430.487292ms","start":"2026-09-10T02:27:55.533912Z","end":"2026-09-10T02:27:55.964399Z","steps":["trace[790773751] 'agreement among raft nodes before linearized reading' (duration: 430.151692ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:27:55.964454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:27:55.533896Z","time spent":"430.549114ms","remote":"127.0.0.1:38946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":176,"response size":32,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-09-10T02:27:55.96454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:27:55.48867Z","time spent":"475.670195ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T02:27:55.964246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.125815ms","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-09-10T02:27:55.965289Z","caller":"traceutil/trace.go:171","msg":"trace[1720832992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:16272; }","duration":"607.227409ms","start":"2026-09-10T02:27:55.358039Z","end":"2026-09-10T02:27:55.965266Z","steps":["trace[1720832992] 'agreement among raft nodes before linearized reading' (duration: 606.071714ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:27:55.96541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:27:55.358017Z","time spent":"607.370744ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-10T02:27:55.967304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.678687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-10T02:27:55.967393Z","caller":"traceutil/trace.go:171","msg":"trace[2015892040] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:16276; }","duration":"291.802401ms","start":"2026-09-10T02:27:55.675569Z","end":"2026-09-10T02:27:55.967371Z","steps":["trace[2015892040] 'agreement among raft nodes before linearized reading' (duration: 291.616715ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:27:55.967453Z","caller":"traceutil/trace.go:171","msg":"trace[294323057] transaction","detail":"{read_only:false; response_revision:16274; number_of_response:1; }","duration":"278.359901ms","start":"2026-09-10T02:27:55.689063Z","end":"2026-09-10T02:27:55.967422Z","steps":["trace[294323057] 'process raft request' (duration: 277.96149ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:27:55.967596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.416887ms","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":"info","ts":"2026-09-10T02:27:55.967636Z","caller":"traceutil/trace.go:171","msg":"trace[1250596664] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:16276; }","duration":"205.485019ms","start":"2026-09-10T02:27:55.762139Z","end":"2026-09-10T02:27:55.967624Z","steps":["trace[1250596664] 'agreement among raft nodes before linearized reading' (duration: 205.414057ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:27:55.967645Z","caller":"traceutil/trace.go:171","msg":"trace[662038349] transaction","detail":"{read_only:false; response_revision:16275; number_of_response:1; }","duration":"261.692816ms","start":"2026-09-10T02:27:55.705924Z","end":"2026-09-10T02:27:55.967616Z","steps":["trace[662038349] 'process raft request' (duration: 261.15571ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:27:55.967691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.297681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-zbqtp\" ","response":"range_response_count:1 size:20644"} {"level":"info","ts":"2026-09-10T02:27:55.967752Z","caller":"traceutil/trace.go:171","msg":"trace[1036548017] transaction","detail":"{read_only:false; response_revision:16276; number_of_response:1; }","duration":"255.995504ms","start":"2026-09-10T02:27:55.711743Z","end":"2026-09-10T02:27:55.967739Z","steps":["trace[1036548017] 'process raft request' (duration: 255.400425ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:27:55.967817Z","caller":"traceutil/trace.go:171","msg":"trace[1325684379] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-zbqtp; range_end:; response_count:1; response_revision:16276; }","duration":"170.480567ms","start":"2026-09-10T02:27:55.797279Z","end":"2026-09-10T02:27:55.967759Z","steps":["trace[1325684379] 'agreement among raft nodes before linearized reading' (duration: 170.083815ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:27:55.967885Z","caller":"traceutil/trace.go:171","msg":"trace[931589142] transaction","detail":"{read_only:false; response_revision:16273; number_of_response:1; }","duration":"295.837134ms","start":"2026-09-10T02:27:55.672007Z","end":"2026-09-10T02:27:55.967844Z","steps":["trace[931589142] 'process raft request' (duration: 294.887675ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:29:37.290636Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14594} {"level":"info","ts":"2026-09-10T02:29:37.387876Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14594,"took":"94.656065ms","hash":2773032486,"current-db-size-bytes":55672832,"current-db-size":"56 MB","current-db-size-in-use-bytes":30687232,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-10T02:29:37.387946Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2773032486,"revision":14594,"compact-revision":12589} {"level":"warn","ts":"2026-09-10T02:31:17.034997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.67321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-10T02:31:17.035087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.618678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"info","ts":"2026-09-10T02:31:17.035173Z","caller":"traceutil/trace.go:171","msg":"trace[545901350] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17832; }","duration":"113.707141ms","start":"2026-09-10T02:31:16.921446Z","end":"2026-09-10T02:31:17.035153Z","steps":["trace[545901350] 'range keys from in-memory index tree' (duration: 113.484214ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:31:17.035152Z","caller":"traceutil/trace.go:171","msg":"trace[1255426551] range","detail":"{range_begin:/registry/jobs/openstack/neutron-rabbit-init; range_end:; response_count:0; response_revision:17832; }","duration":"113.831905ms","start":"2026-09-10T02:31:16.921261Z","end":"2026-09-10T02:31:17.035092Z","steps":["trace[1255426551] 'range keys from in-memory index tree' (duration: 113.583977ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:31:17.035012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.74941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"warn","ts":"2026-09-10T02:31:17.035005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.304147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/neutron-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-10T02:31:17.0355Z","caller":"traceutil/trace.go:171","msg":"trace[185627027] range","detail":"{range_begin:/registry/jobs/openstack/neutron-rabbit-init; range_end:; response_count:0; response_revision:17832; }","duration":"105.837752ms","start":"2026-09-10T02:31:16.929632Z","end":"2026-09-10T02:31:17.03547Z","steps":["trace[185627027] 'range keys from in-memory index tree' (duration: 105.198043ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:31:17.035722Z","caller":"traceutil/trace.go:171","msg":"trace[123568029] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17832; }","duration":"108.188864ms","start":"2026-09-10T02:31:16.927194Z","end":"2026-09-10T02:31:17.035382Z","steps":["trace[123568029] 'range keys from in-memory index tree' (duration: 107.507214ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:34:26.516821Z","caller":"traceutil/trace.go:171","msg":"trace[479704636] linearizableReadLoop","detail":"{readStateIndex:19689; appliedIndex:19688; }","duration":"120.419074ms","start":"2026-09-10T02:34:26.396372Z","end":"2026-09-10T02:34:26.516791Z","steps":["trace[479704636] 'read index received' (duration: 120.185757ms)","trace[479704636] 'applied index is now lower than readState.Index' (duration: 232.377µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:34:26.516938Z","caller":"traceutil/trace.go:171","msg":"trace[1365784971] transaction","detail":"{read_only:false; response_revision:19037; number_of_response:1; }","duration":"129.653235ms","start":"2026-09-10T02:34:26.387194Z","end":"2026-09-10T02:34:26.516847Z","steps":["trace[1365784971] 'process raft request' (duration: 129.430398ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:34:26.517266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.986515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-09-10T02:34:26.517324Z","caller":"traceutil/trace.go:171","msg":"trace[682754130] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:19037; }","duration":"102.11541ms","start":"2026-09-10T02:34:26.415193Z","end":"2026-09-10T02:34:26.517309Z","steps":["trace[682754130] 'agreement among raft nodes before linearized reading' (duration: 101.868062ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:34:26.517966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.850779ms","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-09-10T02:34:26.518202Z","caller":"traceutil/trace.go:171","msg":"trace[1055365310] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19037; }","duration":"121.858928ms","start":"2026-09-10T02:34:26.396317Z","end":"2026-09-10T02:34:26.518176Z","steps":["trace[1055365310] 'agreement among raft nodes before linearized reading' (duration: 120.615812ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:34:28.440457Z","caller":"traceutil/trace.go:171","msg":"trace[2111618018] transaction","detail":"{read_only:false; response_revision:19051; number_of_response:1; }","duration":"111.871735ms","start":"2026-09-10T02:34:28.328554Z","end":"2026-09-10T02:34:28.440426Z","steps":["trace[2111618018] 'process raft request' (duration: 111.790253ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:34:28.44077Z","caller":"traceutil/trace.go:171","msg":"trace[1952784776] transaction","detail":"{read_only:false; response_revision:19050; number_of_response:1; }","duration":"117.120315ms","start":"2026-09-10T02:34:28.32363Z","end":"2026-09-10T02:34:28.440751Z","steps":["trace[1952784776] 'process raft request' (duration: 60.593399ms)","trace[1952784776] 'compare' (duration: 55.897866ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:34:28.607936Z","caller":"traceutil/trace.go:171","msg":"trace[642787720] linearizableReadLoop","detail":"{readStateIndex:19706; appliedIndex:19704; }","duration":"103.498412ms","start":"2026-09-10T02:34:28.504409Z","end":"2026-09-10T02:34:28.607907Z","steps":["trace[642787720] 'read index received' (duration: 20.765051ms)","trace[642787720] 'applied index is now lower than readState.Index' (duration: 82.732501ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:34:28.607982Z","caller":"traceutil/trace.go:171","msg":"trace[1131463289] transaction","detail":"{read_only:false; response_revision:19054; number_of_response:1; }","duration":"116.29327ms","start":"2026-09-10T02:34:28.491653Z","end":"2026-09-10T02:34:28.607946Z","steps":["trace[1131463289] 'process raft request' (duration: 116.102914ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:34:28.608237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.80463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1936"} {"level":"info","ts":"2026-09-10T02:34:28.608279Z","caller":"traceutil/trace.go:171","msg":"trace[329512171] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:19054; }","duration":"103.871152ms","start":"2026-09-10T02:34:28.504396Z","end":"2026-09-10T02:34:28.608267Z","steps":["trace[329512171] 'agreement among raft nodes before linearized reading' (duration: 103.651076ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:34:29.459745Z","caller":"traceutil/trace.go:171","msg":"trace[53731413] transaction","detail":"{read_only:false; response_revision:19064; number_of_response:1; }","duration":"160.607434ms","start":"2026-09-10T02:34:29.299092Z","end":"2026-09-10T02:34:29.459699Z","steps":["trace[53731413] 'process raft request' (duration: 114.33481ms)","trace[53731413] 'compare' (duration: 46.086128ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:34:29.607407Z","caller":"traceutil/trace.go:171","msg":"trace[886406430] transaction","detail":"{read_only:false; response_revision:19066; number_of_response:1; }","duration":"129.15031ms","start":"2026-09-10T02:34:29.478212Z","end":"2026-09-10T02:34:29.607362Z","steps":["trace[886406430] 'process raft request' (duration: 92.676893ms)","trace[886406430] 'compare' (duration: 36.24634ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:34:29.620538Z","caller":"traceutil/trace.go:171","msg":"trace[1004757736] transaction","detail":"{read_only:false; response_revision:19067; number_of_response:1; }","duration":"131.887172ms","start":"2026-09-10T02:34:29.488606Z","end":"2026-09-10T02:34:29.620494Z","steps":["trace[1004757736] 'process raft request' (duration: 131.743408ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:34:32.776621Z","caller":"traceutil/trace.go:171","msg":"trace[443877120] linearizableReadLoop","detail":"{readStateIndex:19755; appliedIndex:19754; }","duration":"121.464997ms","start":"2026-09-10T02:34:32.655128Z","end":"2026-09-10T02:34:32.776592Z","steps":["trace[443877120] 'read index received' (duration: 121.153008ms)","trace[443877120] 'applied index is now lower than readState.Index' (duration: 310.799µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:34:32.776699Z","caller":"traceutil/trace.go:171","msg":"trace[156410060] transaction","detail":"{read_only:false; response_revision:19102; number_of_response:1; }","duration":"266.991432ms","start":"2026-09-10T02:34:32.50967Z","end":"2026-09-10T02:34:32.776662Z","steps":["trace[156410060] 'process raft request' (duration: 266.709413ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:34:32.776984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.819317ms","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-09-10T02:34:32.777034Z","caller":"traceutil/trace.go:171","msg":"trace[173794482] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19102; }","duration":"121.981202ms","start":"2026-09-10T02:34:32.655039Z","end":"2026-09-10T02:34:32.77702Z","steps":["trace[173794482] 'agreement among raft nodes before linearized reading' (duration: 121.723044ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:34:32.777482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.584872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-mc5d8\" ","response":"range_response_count:1 size:9792"} {"level":"info","ts":"2026-09-10T02:34:32.777515Z","caller":"traceutil/trace.go:171","msg":"trace[1405034136] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-mc5d8; range_end:; response_count:1; response_revision:19102; }","duration":"100.661665ms","start":"2026-09-10T02:34:32.676845Z","end":"2026-09-10T02:34:32.777507Z","steps":["trace[1405034136] 'agreement among raft nodes before linearized reading' (duration: 100.569132ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:34:32.777731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.034062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-09-10T02:34:32.778531Z","caller":"traceutil/trace.go:171","msg":"trace[1970846877] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:19102; }","duration":"116.744253ms","start":"2026-09-10T02:34:32.661577Z","end":"2026-09-10T02:34:32.778321Z","steps":["trace[1970846877] 'agreement among raft nodes before linearized reading' (duration: 115.286449ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:34:37.300325Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16894} {"level":"info","ts":"2026-09-10T02:34:37.408127Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16894,"took":"103.554443ms","hash":2472377822,"current-db-size-bytes":55672832,"current-db-size":"56 MB","current-db-size-in-use-bytes":31936512,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-10T02:34:37.408232Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2472377822,"revision":16894,"compact-revision":14594} {"level":"warn","ts":"2026-09-10T02:34:41.170628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.81876ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-10T02:34:41.1709Z","caller":"traceutil/trace.go:171","msg":"trace[1769519252] linearizableReadLoop","detail":"{readStateIndex:19811; appliedIndex:19809; }","duration":"207.946681ms","start":"2026-09-10T02:34:40.962866Z","end":"2026-09-10T02:34:41.170813Z","steps":["trace[1769519252] 'read index received' (duration: 9.735266ms)","trace[1769519252] 'applied index is now lower than readState.Index' (duration: 198.209985ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:34:41.170897Z","caller":"traceutil/trace.go:171","msg":"trace[1603313044] transaction","detail":"{read_only:false; response_revision:19155; number_of_response:1; }","duration":"208.010112ms","start":"2026-09-10T02:34:40.962837Z","end":"2026-09-10T02:34:41.170847Z","steps":["trace[1603313044] 'process raft request' (duration: 17.652076ms)","trace[1603313044] 'compare' (duration: 189.673816ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:34:41.172093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.220359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:94 size:946796"} {"level":"info","ts":"2026-09-10T02:34:41.172722Z","caller":"traceutil/trace.go:171","msg":"trace[1606850699] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:94; response_revision:19155; }","duration":"209.852169ms","start":"2026-09-10T02:34:40.962834Z","end":"2026-09-10T02:34:41.172686Z","steps":["trace[1606850699] 'agreement among raft nodes before linearized reading' (duration: 208.129357ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:34:41.665865Z","caller":"traceutil/trace.go:171","msg":"trace[864203131] transaction","detail":"{read_only:false; response_revision:19156; number_of_response:1; }","duration":"117.450114ms","start":"2026-09-10T02:34:41.548383Z","end":"2026-09-10T02:34:41.665833Z","steps":["trace[864203131] 'process raft request' (duration: 117.265349ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:34:42.37322Z","caller":"traceutil/trace.go:171","msg":"trace[1225289230] transaction","detail":"{read_only:false; response_revision:19158; number_of_response:1; }","duration":"537.233404ms","start":"2026-09-10T02:34:41.835957Z","end":"2026-09-10T02:34:42.37319Z","steps":["trace[1225289230] 'process raft request' (duration: 536.985136ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:34:42.37385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:34:41.835927Z","time spent":"537.376169ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T02:34:42.402007Z","caller":"traceutil/trace.go:171","msg":"trace[640520776] linearizableReadLoop","detail":"{readStateIndex:19816; appliedIndex:19813; }","duration":"480.199964ms","start":"2026-09-10T02:34:41.921779Z","end":"2026-09-10T02:34:42.401979Z","steps":["trace[640520776] 'read index received' (duration: 450.995997ms)","trace[640520776] 'applied index is now lower than readState.Index' (duration: 29.202427ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:34:42.402202Z","caller":"traceutil/trace.go:171","msg":"trace[473501888] transaction","detail":"{read_only:false; response_revision:19159; number_of_response:1; }","duration":"532.841292ms","start":"2026-09-10T02:34:41.869303Z","end":"2026-09-10T02:34:42.402144Z","steps":["trace[473501888] 'process raft request' (duration: 532.401379ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:34:42.402341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:34:41.869275Z","time spent":"532.967256ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T02:34:42.4025Z","caller":"traceutil/trace.go:171","msg":"trace[789532877] transaction","detail":"{read_only:false; response_revision:19160; number_of_response:1; }","duration":"531.877242ms","start":"2026-09-10T02:34:41.870614Z","end":"2026-09-10T02:34:42.402491Z","steps":["trace[789532877] 'process raft request' (duration: 531.271334ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:34:42.402544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:34:41.870602Z","time spent":"531.916173ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T02:34:42.402619Z","caller":"traceutil/trace.go:171","msg":"trace[1721904947] transaction","detail":"{read_only:false; response_revision:19161; number_of_response:1; }","duration":"432.60727ms","start":"2026-09-10T02:34:41.970003Z","end":"2026-09-10T02:34:42.40261Z","steps":["trace[1721904947] 'process raft request' (duration: 431.921359ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:34:42.402658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:34:41.96997Z","time spent":"432.665591ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T02:34:42.402774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.001707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-10T02:34:42.402802Z","caller":"traceutil/trace.go:171","msg":"trace[963129088] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:19161; }","duration":"481.072509ms","start":"2026-09-10T02:34:41.921722Z","end":"2026-09-10T02:34:42.402794Z","steps":["trace[963129088] 'agreement among raft nodes before linearized reading' (duration: 480.994247ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:34:42.402831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:34:41.921704Z","time spent":"481.116101ms","remote":"127.0.0.1:39196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":15,"response size":32,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-09-10T02:34:42.403087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.013124ms","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-09-10T02:34:42.403157Z","caller":"traceutil/trace.go:171","msg":"trace[1471912657] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:19161; }","duration":"467.141087ms","start":"2026-09-10T02:34:41.935998Z","end":"2026-09-10T02:34:42.403139Z","steps":["trace[1471912657] 'agreement among raft nodes before linearized reading' (duration: 466.994722ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:34:42.403192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.480263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-10T02:34:42.4032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:34:41.935984Z","time spent":"467.2077ms","remote":"127.0.0.1:41016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":32,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-09-10T02:34:42.403226Z","caller":"traceutil/trace.go:171","msg":"trace[742324577] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19161; }","duration":"251.542065ms","start":"2026-09-10T02:34:42.151675Z","end":"2026-09-10T02:34:42.403217Z","steps":["trace[742324577] 'agreement among raft nodes before linearized reading' (duration: 251.487593ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:34:42.403448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.377949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-09-10T02:34:42.403491Z","caller":"traceutil/trace.go:171","msg":"trace[1038378237] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:19161; }","duration":"308.471041ms","start":"2026-09-10T02:34:42.095011Z","end":"2026-09-10T02:34:42.403482Z","steps":["trace[1038378237] 'agreement among raft nodes before linearized reading' (duration: 308.340258ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:34:42.403514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:34:42.094985Z","time spent":"308.523173ms","remote":"127.0.0.1:39016","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-09-10T02:34:50.743766Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3e8b7bea2e3a32b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-10T02:34:50.754645Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-09-10T02:34:50.754823Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-09-10T02:39:37.308197Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19128} {"level":"info","ts":"2026-09-10T02:39:37.415942Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19128,"took":"104.148152ms","hash":1627440777,"current-db-size-bytes":55672832,"current-db-size":"56 MB","current-db-size-in-use-bytes":33546240,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-09-10T02:39:37.416044Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1627440777,"revision":19128,"compact-revision":16894} {"level":"info","ts":"2026-09-10T02:40:59.348833Z","caller":"traceutil/trace.go:171","msg":"trace[850409474] transaction","detail":"{read_only:false; response_revision:22022; number_of_response:1; }","duration":"128.153931ms","start":"2026-09-10T02:40:59.220618Z","end":"2026-09-10T02:40:59.348772Z","steps":["trace[850409474] 'process raft request' (duration: 127.965075ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:41:14.893063Z","caller":"traceutil/trace.go:171","msg":"trace[2099617635] transaction","detail":"{read_only:false; response_revision:22104; number_of_response:1; }","duration":"134.06331ms","start":"2026-09-10T02:41:14.758967Z","end":"2026-09-10T02:41:14.893031Z","steps":["trace[2099617635] 'process raft request' (duration: 133.854814ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:41:15.615459Z","caller":"traceutil/trace.go:171","msg":"trace[347758481] linearizableReadLoop","detail":"{readStateIndex:22856; appliedIndex:22855; }","duration":"158.391969ms","start":"2026-09-10T02:41:15.457036Z","end":"2026-09-10T02:41:15.615428Z","steps":["trace[347758481] 'read index received' (duration: 158.234823ms)","trace[347758481] 'applied index is now lower than readState.Index' (duration: 155.786µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:41:15.615655Z","caller":"traceutil/trace.go:171","msg":"trace[1402679258] transaction","detail":"{read_only:false; response_revision:22105; number_of_response:1; }","duration":"158.518244ms","start":"2026-09-10T02:41:15.456999Z","end":"2026-09-10T02:41:15.615517Z","steps":["trace[1402679258] 'process raft request' (duration: 158.255215ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:41:15.615749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.699568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-09-10T02:41:15.616749Z","caller":"traceutil/trace.go:171","msg":"trace[1350026217] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22105; }","duration":"159.782971ms","start":"2026-09-10T02:41:15.456936Z","end":"2026-09-10T02:41:15.616719Z","steps":["trace[1350026217] 'agreement among raft nodes before linearized reading' (duration: 158.649077ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:41:15.639399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.13461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-10T02:41:15.639606Z","caller":"traceutil/trace.go:171","msg":"trace[1946617862] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:22106; }","duration":"156.381458ms","start":"2026-09-10T02:41:15.483203Z","end":"2026-09-10T02:41:15.639584Z","steps":["trace[1946617862] 'agreement among raft nodes before linearized reading' (duration: 156.030227ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:41:15.639563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.052608ms","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-09-10T02:41:15.639932Z","caller":"traceutil/trace.go:171","msg":"trace[1936286596] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22106; }","duration":"158.488162ms","start":"2026-09-10T02:41:15.481421Z","end":"2026-09-10T02:41:15.639909Z","steps":["trace[1936286596] 'agreement among raft nodes before linearized reading' (duration: 157.7737ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:41:15.964268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.238081ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-10T02:41:15.964522Z","caller":"traceutil/trace.go:171","msg":"trace[1515594613] transaction","detail":"{read_only:false; response_revision:22108; number_of_response:1; }","duration":"297.843822ms","start":"2026-09-10T02:41:15.666653Z","end":"2026-09-10T02:41:15.964497Z","steps":["trace[1515594613] 'process raft request' (duration: 297.741769ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:41:15.964571Z","caller":"traceutil/trace.go:171","msg":"trace[1527622222] transaction","detail":"{read_only:false; response_revision:22107; number_of_response:1; }","duration":"342.974722ms","start":"2026-09-10T02:41:15.621556Z","end":"2026-09-10T02:41:15.964531Z","steps":["trace[1527622222] 'process raft request' (duration: 109.36692ms)","trace[1527622222] 'compare' (duration: 233.086367ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:41:15.964739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:41:15.621532Z","time spent":"343.119516ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T02:41:16.397888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.831934ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-09-10T02:41:16.39822Z","caller":"traceutil/trace.go:171","msg":"trace[1945853190] linearizableReadLoop","detail":"{readStateIndex:22860; appliedIndex:22859; }","duration":"309.609839ms","start":"2026-09-10T02:41:16.088589Z","end":"2026-09-10T02:41:16.398199Z","steps":["trace[1945853190] 'read index received' (duration: 4.357282ms)","trace[1945853190] 'applied index is now lower than readState.Index' (duration: 305.251177ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:41:16.398412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.808265ms","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-09-10T02:41:16.398476Z","caller":"traceutil/trace.go:171","msg":"trace[577468777] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22108; }","duration":"309.914229ms","start":"2026-09-10T02:41:16.088547Z","end":"2026-09-10T02:41:16.398462Z","steps":["trace[577468777] 'agreement among raft nodes before linearized reading' (duration: 309.730923ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:41:16.398488Z","caller":"traceutil/trace.go:171","msg":"trace[1771205419] transaction","detail":"{read_only:false; response_revision:22109; number_of_response:1; }","duration":"273.453991ms","start":"2026-09-10T02:41:16.125021Z","end":"2026-09-10T02:41:16.398475Z","steps":["trace[1771205419] 'process raft request' (duration: 273.002778ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:41:16.398503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:41:16.088522Z","time spent":"309.976311ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-10T02:41:16.566841Z","caller":"traceutil/trace.go:171","msg":"trace[2003598137] transaction","detail":"{read_only:false; response_revision:22110; number_of_response:1; }","duration":"429.723446ms","start":"2026-09-10T02:41:16.137088Z","end":"2026-09-10T02:41:16.566812Z","steps":["trace[2003598137] 'process raft request' (duration: 348.211142ms)","trace[2003598137] 'compare' (duration: 80.963968ms)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:41:16.566998Z","caller":"traceutil/trace.go:171","msg":"trace[2120128172] linearizableReadLoop","detail":"{readStateIndex:22863; appliedIndex:22861; }","duration":"168.68463ms","start":"2026-09-10T02:41:16.398255Z","end":"2026-09-10T02:41:16.56694Z","steps":["trace[2120128172] 'read index received' (duration: 86.97773ms)","trace[2120128172] 'applied index is now lower than readState.Index' (duration: 81.70561ms)"],"step_count":2} {"level":"warn","ts":"2026-09-10T02:41:16.567029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:41:16.137062Z","time spent":"429.861349ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-10T02:41:16.567054Z","caller":"traceutil/trace.go:171","msg":"trace[606355623] transaction","detail":"{read_only:false; response_revision:22111; number_of_response:1; }","duration":"406.366736ms","start":"2026-09-10T02:41:16.160654Z","end":"2026-09-10T02:41:16.567021Z","steps":["trace[606355623] 'process raft request' (duration: 406.064127ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:41:16.567122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.658292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-10T02:41:16.567181Z","caller":"traceutil/trace.go:171","msg":"trace[1789871251] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22111; }","duration":"427.769456ms","start":"2026-09-10T02:41:16.139397Z","end":"2026-09-10T02:41:16.567167Z","steps":["trace[1789871251] 'agreement among raft nodes before linearized reading' (duration: 427.629801ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:41:16.567218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:41:16.139378Z","time spent":"427.830478ms","remote":"127.0.0.1:38780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-10T02:41:16.56722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:41:16.160627Z","time spent":"406.509741ms","remote":"127.0.0.1:39016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-10T02:41:16.567135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.83939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-10T02:41:16.567353Z","caller":"traceutil/trace.go:171","msg":"trace[1990270605] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:22111; }","duration":"433.110697ms","start":"2026-09-10T02:41:16.13422Z","end":"2026-09-10T02:41:16.56733Z","steps":["trace[1990270605] 'agreement among raft nodes before linearized reading' (duration: 432.85572ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:41:16.56742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:41:16.134197Z","time spent":"433.20209ms","remote":"127.0.0.1:33072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":30,"request content":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true "} {"level":"info","ts":"2026-09-10T02:41:16.573378Z","caller":"traceutil/trace.go:171","msg":"trace[1204878383] transaction","detail":"{read_only:false; response_revision:22112; number_of_response:1; }","duration":"170.426204ms","start":"2026-09-10T02:41:16.402926Z","end":"2026-09-10T02:41:16.573352Z","steps":["trace[1204878383] 'process raft request' (duration: 169.885697ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:44:37.317394Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21513} {"level":"info","ts":"2026-09-10T02:44:37.445545Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21513,"took":"124.296514ms","hash":264052616,"current-db-size-bytes":55672832,"current-db-size":"56 MB","current-db-size-in-use-bytes":30564352,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-10T02:44:37.445627Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":264052616,"revision":21513,"compact-revision":19128} {"level":"info","ts":"2026-09-10T02:45:31.64904Z","caller":"traceutil/trace.go:171","msg":"trace[967966391] transaction","detail":"{read_only:false; response_revision:24159; number_of_response:1; }","duration":"203.575079ms","start":"2026-09-10T02:45:31.445436Z","end":"2026-09-10T02:45:31.649011Z","steps":["trace[967966391] 'process raft request' (duration: 203.344932ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:45:47.059251Z","caller":"traceutil/trace.go:171","msg":"trace[12397139] linearizableReadLoop","detail":"{readStateIndex:25586; appliedIndex:25585; }","duration":"143.270819ms","start":"2026-09-10T02:45:46.915944Z","end":"2026-09-10T02:45:47.059214Z","steps":["trace[12397139] 'read index received' (duration: 143.014791ms)","trace[12397139] 'applied index is now lower than readState.Index' (duration: 255.048µs)"],"step_count":2} {"level":"info","ts":"2026-09-10T02:45:47.059296Z","caller":"traceutil/trace.go:171","msg":"trace[1489069374] transaction","detail":"{read_only:false; response_revision:24752; number_of_response:1; }","duration":"221.608417ms","start":"2026-09-10T02:45:46.837651Z","end":"2026-09-10T02:45:47.059259Z","steps":["trace[1489069374] 'process raft request' (duration: 221.38672ms)"],"step_count":1} {"level":"warn","ts":"2026-09-10T02:45:47.059437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.467045ms","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:6"} {"level":"info","ts":"2026-09-10T02:45:47.059541Z","caller":"traceutil/trace.go:171","msg":"trace[1648128829] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:24752; }","duration":"143.60542ms","start":"2026-09-10T02:45:46.915883Z","end":"2026-09-10T02:45:47.059489Z","steps":["trace[1648128829] 'agreement among raft nodes before linearized reading' (duration: 143.453534ms)"],"step_count":1} {"level":"info","ts":"2026-09-10T02:47:06.608259Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000676b.wal"} {"level":"info","ts":"2026-09-10T02:49:37.325013Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23600} {"level":"info","ts":"2026-09-10T02:49:37.459919Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23600,"took":"129.535384ms","hash":2460750291,"current-db-size-bytes":57360384,"current-db-size":"57 MB","current-db-size-in-use-bytes":42176512,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-09-10T02:49:37.460007Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2460750291,"revision":23600,"compact-revision":21513} {"level":"info","ts":"2026-09-10T02:54:37.330735Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26754} {"level":"info","ts":"2026-09-10T02:54:37.482071Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26754,"took":"146.684094ms","hash":3073508868,"current-db-size-bytes":57360384,"current-db-size":"57 MB","current-db-size-in-use-bytes":30584832,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-10T02:54:37.48215Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3073508868,"revision":26754,"compact-revision":23600} {"level":"info","ts":"2026-09-10T02:54:46.086611Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3e8b7bea2e3a32b","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-10T02:54:46.097177Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-09-10T02:54:46.097343Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}