{"level":"warn","ts":"2026-09-09T01:05:37.690216Z","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-09T01:05:37.690381Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.45: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.45:2380","--initial-cluster=instance=https://162.253.55.45:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.45:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.45: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-09T01:05:37.690504Z","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-09T01:05:37.690528Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.45:2380"]} {"level":"info","ts":"2026-09-09T01:05:37.69056Z","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-09T01:05:37.691789Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.45:2379"]} {"level":"info","ts":"2026-09-09T01:05:37.691961Z","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.45:2380"],"listen-peer-urls":["https://162.253.55.45:2380"],"advertise-client-urls":["https://162.253.55.45:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.45:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.45: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-09T01:05:37.696329Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.932492ms"} {"level":"info","ts":"2026-09-09T01:05:37.70316Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fbe9b088d8de907a","cluster-id":"332637b4e3714c3a"} {"level":"info","ts":"2026-09-09T01:05:37.703303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fbe9b088d8de907a switched to configuration voters=()"} {"level":"info","ts":"2026-09-09T01:05:37.70337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fbe9b088d8de907a became follower at term 0"} {"level":"info","ts":"2026-09-09T01:05:37.703399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fbe9b088d8de907a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-09T01:05:37.703412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fbe9b088d8de907a became follower at term 1"} {"level":"info","ts":"2026-09-09T01:05:37.70348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fbe9b088d8de907a switched to configuration voters=(18152233874894000250)"} {"level":"warn","ts":"2026-09-09T01:05:37.709483Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-09T01:05:37.712603Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-09T01:05:37.714751Z","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-09T01:05:37.718102Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fbe9b088d8de907a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-09T01:05:37.718498Z","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-09T01:05:37.718638Z","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-09T01:05:37.718711Z","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-09T01:05:37.71866Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fbe9b088d8de907a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-09T01:05:37.720618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fbe9b088d8de907a switched to configuration voters=(18152233874894000250)"} {"level":"info","ts":"2026-09-09T01:05:37.721137Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"332637b4e3714c3a","local-member-id":"fbe9b088d8de907a","added-peer-id":"fbe9b088d8de907a","added-peer-peer-urls":["https://162.253.55.45:2380"]} {"level":"info","ts":"2026-09-09T01:05:37.723438Z","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-09T01:05:37.72362Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.45:2380"} {"level":"info","ts":"2026-09-09T01:05:37.723764Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.45:2380"} {"level":"info","ts":"2026-09-09T01:05:37.723905Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fbe9b088d8de907a","initial-advertise-peer-urls":["https://162.253.55.45:2380"],"listen-peer-urls":["https://162.253.55.45:2380"],"advertise-client-urls":["https://162.253.55.45:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.45:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-09T01:05:37.723987Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-09T01:05:38.004786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fbe9b088d8de907a is starting a new election at term 1"} {"level":"info","ts":"2026-09-09T01:05:38.004874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fbe9b088d8de907a became pre-candidate at term 1"} {"level":"info","ts":"2026-09-09T01:05:38.004921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fbe9b088d8de907a received MsgPreVoteResp from fbe9b088d8de907a at term 1"} {"level":"info","ts":"2026-09-09T01:05:38.004945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fbe9b088d8de907a became candidate at term 2"} {"level":"info","ts":"2026-09-09T01:05:38.004955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fbe9b088d8de907a received MsgVoteResp from fbe9b088d8de907a at term 2"} {"level":"info","ts":"2026-09-09T01:05:38.004979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fbe9b088d8de907a became leader at term 2"} {"level":"info","ts":"2026-09-09T01:05:38.004992Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fbe9b088d8de907a elected leader fbe9b088d8de907a at term 2"} {"level":"info","ts":"2026-09-09T01:05:38.006449Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fbe9b088d8de907a","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.45:2379]}","request-path":"/0/members/fbe9b088d8de907a/attributes","cluster-id":"332637b4e3714c3a","publish-timeout":"7s"} {"level":"info","ts":"2026-09-09T01:05:38.006478Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T01:05:38.00647Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-09T01:05:38.006654Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-09T01:05:38.006993Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-09T01:05:38.007064Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-09T01:05:38.008121Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"332637b4e3714c3a","local-member-id":"fbe9b088d8de907a","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T01:05:38.008231Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T01:05:38.00827Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-09T01:05:38.010141Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.45:2379"} {"level":"info","ts":"2026-09-09T01:05:38.011196Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-09T01:06:24.774285Z","caller":"traceutil/trace.go:171","msg":"trace[502698445] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"144.845341ms","start":"2026-09-09T01:06:24.6294Z","end":"2026-09-09T01:06:24.774246Z","steps":["trace[502698445] 'process raft request' (duration: 144.586153ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:06:25.781999Z","caller":"traceutil/trace.go:171","msg":"trace[1123282535] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"532.033881ms","start":"2026-09-09T01:06:25.249928Z","end":"2026-09-09T01:06:25.781962Z","steps":["trace[1123282535] 'process raft request' (duration: 496.069949ms)","trace[1123282535] 'compare' (duration: 35.664833ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:06:25.782685Z","caller":"traceutil/trace.go:171","msg":"trace[864684245] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"480.917241ms","start":"2026-09-09T01:06:25.301744Z","end":"2026-09-09T01:06:25.782661Z","steps":["trace[864684245] 'process raft request' (duration: 480.715705ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:06:25.782977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:06:25.249886Z","time spent":"532.230388ms","remote":"127.0.0.1:37192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:06:25.783134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:06:25.301714Z","time spent":"481.055515ms","remote":"127.0.0.1:37338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-09T01:06:42.540272Z","caller":"traceutil/trace.go:171","msg":"trace[1650454928] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"119.108318ms","start":"2026-09-09T01:06:42.42114Z","end":"2026-09-09T01:06:42.540249Z","steps":["trace[1650454928] 'read index received' (duration: 118.907812ms)","trace[1650454928] 'applied index is now lower than readState.Index' (duration: 199.916µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:06:42.540359Z","caller":"traceutil/trace.go:171","msg":"trace[387308050] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"210.690458ms","start":"2026-09-09T01:06:42.329624Z","end":"2026-09-09T01:06:42.540314Z","steps":["trace[387308050] 'process raft request' (duration: 210.498882ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:06:42.540413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.290864ms","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-09T01:06:42.540489Z","caller":"traceutil/trace.go:171","msg":"trace[1274504913] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:776; }","duration":"119.440028ms","start":"2026-09-09T01:06:42.421041Z","end":"2026-09-09T01:06:42.540482Z","steps":["trace[1274504913] 'agreement among raft nodes before linearized reading' (duration: 119.302854ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:07:21.7479Z","caller":"traceutil/trace.go:171","msg":"trace[1475871210] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"161.492754ms","start":"2026-09-09T01:07:21.586372Z","end":"2026-09-09T01:07:21.747865Z","steps":["trace[1475871210] 'process raft request' (duration: 161.307137ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:10.794007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.313001ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:08:10.794144Z","caller":"traceutil/trace.go:171","msg":"trace[2008115872] linearizableReadLoop","detail":"{readStateIndex:1966; appliedIndex:1965; }","duration":"272.802171ms","start":"2026-09-09T01:08:10.521324Z","end":"2026-09-09T01:08:10.794126Z","steps":["trace[2008115872] 'read index received' (duration: 49.371µs)","trace[2008115872] 'applied index is now lower than readState.Index' (duration: 272.75145ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:08:10.794179Z","caller":"traceutil/trace.go:171","msg":"trace[1650004031] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"339.00113ms","start":"2026-09-09T01:08:10.455128Z","end":"2026-09-09T01:08:10.794129Z","steps":["trace[1650004031] 'process raft request' (duration: 37.228805ms)","trace[1650004031] 'compare' (duration: 301.150525ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:08:10.794352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:08:10.455098Z","time spent":"339.162705ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:08:10.794393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.212692ms","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-09T01:08:10.794425Z","caller":"traceutil/trace.go:171","msg":"trace[507190533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1886; }","duration":"270.245083ms","start":"2026-09-09T01:08:10.524169Z","end":"2026-09-09T01:08:10.794415Z","steps":["trace[507190533] 'agreement among raft nodes before linearized reading' (duration: 270.096739ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:08:10.794507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.917821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-09-09T01:08:10.794513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.152532ms","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-09T01:08:10.794618Z","caller":"traceutil/trace.go:171","msg":"trace[1844680495] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1886; }","duration":"107.065715ms","start":"2026-09-09T01:08:10.687525Z","end":"2026-09-09T01:08:10.794591Z","steps":["trace[1844680495] 'agreement among raft nodes before linearized reading' (duration: 106.782607ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:10.794664Z","caller":"traceutil/trace.go:171","msg":"trace[629210581] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1886; }","duration":"273.331247ms","start":"2026-09-09T01:08:10.521276Z","end":"2026-09-09T01:08:10.794607Z","steps":["trace[629210581] 'agreement among raft nodes before linearized reading' (duration: 272.957126ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:11.056305Z","caller":"traceutil/trace.go:171","msg":"trace[1191228773] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"257.261567ms","start":"2026-09-09T01:08:10.799021Z","end":"2026-09-09T01:08:11.056283Z","steps":["trace[1191228773] 'process raft request' (duration: 199.429203ms)","trace[1191228773] 'compare' (duration: 57.534795ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:08:11.056678Z","caller":"traceutil/trace.go:171","msg":"trace[86607808] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"257.145622ms","start":"2026-09-09T01:08:10.799519Z","end":"2026-09-09T01:08:11.056665Z","steps":["trace[86607808] 'process raft request' (duration: 256.666118ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:11.056743Z","caller":"traceutil/trace.go:171","msg":"trace[1091334113] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"256.951606ms","start":"2026-09-09T01:08:10.799743Z","end":"2026-09-09T01:08:11.056695Z","steps":["trace[1091334113] 'process raft request' (duration: 256.875964ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:11.05679Z","caller":"traceutil/trace.go:171","msg":"trace[364652721] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"257.189373ms","start":"2026-09-09T01:08:10.799544Z","end":"2026-09-09T01:08:11.056733Z","steps":["trace[364652721] 'process raft request' (duration: 256.886194ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:11.328084Z","caller":"traceutil/trace.go:171","msg":"trace[54521800] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"196.475652ms","start":"2026-09-09T01:08:11.131569Z","end":"2026-09-09T01:08:11.328044Z","steps":["trace[54521800] 'process raft request' (duration: 162.112244ms)","trace[54521800] 'compare' (duration: 33.971736ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:08:22.907134Z","caller":"traceutil/trace.go:171","msg":"trace[1635768587] transaction","detail":"{read_only:false; response_revision:1987; number_of_response:1; }","duration":"171.388637ms","start":"2026-09-09T01:08:22.735719Z","end":"2026-09-09T01:08:22.907108Z","steps":["trace[1635768587] 'process raft request' (duration: 171.213732ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:08:22.988356Z","caller":"traceutil/trace.go:171","msg":"trace[1579564192] transaction","detail":"{read_only:false; response_revision:1988; number_of_response:1; }","duration":"157.203885ms","start":"2026-09-09T01:08:22.831103Z","end":"2026-09-09T01:08:22.988307Z","steps":["trace[1579564192] 'process raft request' (duration: 145.511128ms)","trace[1579564192] 'compare' (duration: 11.47134ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:08:23.506041Z","caller":"traceutil/trace.go:171","msg":"trace[1352170415] transaction","detail":"{read_only:false; response_revision:1994; number_of_response:1; }","duration":"130.428398ms","start":"2026-09-09T01:08:23.375559Z","end":"2026-09-09T01:08:23.505987Z","steps":["trace[1352170415] 'process raft request' (duration: 130.077418ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:09:00.450821Z","caller":"traceutil/trace.go:171","msg":"trace[717202666] transaction","detail":"{read_only:false; response_revision:2207; number_of_response:1; }","duration":"124.242604ms","start":"2026-09-09T01:09:00.326558Z","end":"2026-09-09T01:09:00.450801Z","steps":["trace[717202666] 'process raft request' (duration: 124.134131ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:09:01.23429Z","caller":"traceutil/trace.go:171","msg":"trace[46098303] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"100.830673ms","start":"2026-09-09T01:09:01.133425Z","end":"2026-09-09T01:09:01.234256Z","steps":["trace[46098303] 'process raft request' (duration: 100.577065ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:09:06.718499Z","caller":"traceutil/trace.go:171","msg":"trace[1105632123] linearizableReadLoop","detail":"{readStateIndex:2332; appliedIndex:2331; }","duration":"242.488766ms","start":"2026-09-09T01:09:06.475976Z","end":"2026-09-09T01:09:06.718465Z","steps":["trace[1105632123] 'read index received' (duration: 171.751487ms)","trace[1105632123] 'applied index is now lower than readState.Index' (duration: 70.735559ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:09:06.718741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.740744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-09T01:09:06.718811Z","caller":"traceutil/trace.go:171","msg":"trace[87205975] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2238; }","duration":"242.862097ms","start":"2026-09-09T01:09:06.475934Z","end":"2026-09-09T01:09:06.718796Z","steps":["trace[87205975] 'agreement among raft nodes before linearized reading' (duration: 242.63458ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:09:53.20296Z","caller":"traceutil/trace.go:171","msg":"trace[336335626] transaction","detail":"{read_only:false; response_revision:2662; number_of_response:1; }","duration":"237.451447ms","start":"2026-09-09T01:09:52.965478Z","end":"2026-09-09T01:09:53.20293Z","steps":["trace[336335626] 'process raft request' (duration: 237.003533ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:09:53.228523Z","caller":"traceutil/trace.go:171","msg":"trace[689973052] transaction","detail":"{read_only:false; response_revision:2663; number_of_response:1; }","duration":"196.827323ms","start":"2026-09-09T01:09:53.031661Z","end":"2026-09-09T01:09:53.228488Z","steps":["trace[689973052] 'process raft request' (duration: 196.683809ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:10:16.360581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.77391ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:10:16.360859Z","caller":"traceutil/trace.go:171","msg":"trace[2125099907] transaction","detail":"{read_only:false; response_revision:2810; number_of_response:1; }","duration":"230.26184ms","start":"2026-09-09T01:10:16.130574Z","end":"2026-09-09T01:10:16.360836Z","steps":["trace[2125099907] 'process raft request' (duration: 230.130876ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:10:16.361274Z","caller":"traceutil/trace.go:171","msg":"trace[1890185586] transaction","detail":"{read_only:false; response_revision:2809; number_of_response:1; }","duration":"364.497263ms","start":"2026-09-09T01:10:15.996744Z","end":"2026-09-09T01:10:16.361241Z","steps":["trace[1890185586] 'process raft request' (duration: 115.96231ms)","trace[1890185586] 'compare' (duration: 247.329506ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:10:16.361447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:15.996716Z","time spent":"364.637707ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:10:21.738914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.045492ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:10:21.739069Z","caller":"traceutil/trace.go:171","msg":"trace[1913358228] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2836; }","duration":"172.231308ms","start":"2026-09-09T01:10:21.566817Z","end":"2026-09-09T01:10:21.739048Z","steps":["trace[1913358228] 'range keys from in-memory index tree' (duration: 172.026012ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:10:21.739579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.410829ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:10:21.739805Z","caller":"traceutil/trace.go:171","msg":"trace[426636923] transaction","detail":"{read_only:false; response_revision:2837; number_of_response:1; }","duration":"419.028108ms","start":"2026-09-09T01:10:21.320717Z","end":"2026-09-09T01:10:21.739745Z","steps":["trace[426636923] 'process raft request' (duration: 141.31975ms)","trace[426636923] 'compare' (duration: 276.922755ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:10:21.739896Z","caller":"traceutil/trace.go:171","msg":"trace[862491797] transaction","detail":"{read_only:false; response_revision:2838; number_of_response:1; }","duration":"192.078321ms","start":"2026-09-09T01:10:21.547794Z","end":"2026-09-09T01:10:21.739872Z","steps":["trace[862491797] 'process raft request' (duration: 191.924136ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:10:21.739924Z","caller":"traceutil/trace.go:171","msg":"trace[960877838] linearizableReadLoop","detail":"{readStateIndex:2953; appliedIndex:2952; }","duration":"337.753462ms","start":"2026-09-09T01:10:21.402126Z","end":"2026-09-09T01:10:21.739879Z","steps":["trace[960877838] 'read index received' (duration: 59.892758ms)","trace[960877838] 'applied index is now lower than readState.Index' (duration: 277.856184ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:10:21.740267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:21.320692Z","time spent":"419.190034ms","remote":"127.0.0.1:37052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:10:21.7403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.174145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-09T01:10:21.740358Z","caller":"traceutil/trace.go:171","msg":"trace[1600250836] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2838; }","duration":"338.263317ms","start":"2026-09-09T01:10:21.402086Z","end":"2026-09-09T01:10:21.740349Z","steps":["trace[1600250836] 'agreement among raft nodes before linearized reading' (duration: 337.902387ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:10:21.74092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:21.402066Z","time spent":"338.314979ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-09T01:10:22.345325Z","caller":"traceutil/trace.go:171","msg":"trace[1446234914] linearizableReadLoop","detail":"{readStateIndex:2956; appliedIndex:2954; }","duration":"599.691072ms","start":"2026-09-09T01:10:21.745601Z","end":"2026-09-09T01:10:22.345292Z","steps":["trace[1446234914] 'read index received' (duration: 85.67324ms)","trace[1446234914] 'applied index is now lower than readState.Index' (duration: 514.016762ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:10:22.345436Z","caller":"traceutil/trace.go:171","msg":"trace[728533716] transaction","detail":"{read_only:false; response_revision:2840; number_of_response:1; }","duration":"600.707794ms","start":"2026-09-09T01:10:21.744694Z","end":"2026-09-09T01:10:22.345402Z","steps":["trace[728533716] 'process raft request' (duration: 600.421755ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:10:22.345525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.902898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-09T01:10:22.345581Z","caller":"traceutil/trace.go:171","msg":"trace[886412489] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:2840; }","duration":"600.007471ms","start":"2026-09-09T01:10:21.745559Z","end":"2026-09-09T01:10:22.345566Z","steps":["trace[886412489] 'agreement among raft nodes before linearized reading' (duration: 599.883708ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:10:22.345588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:21.744685Z","time spent":"600.818627ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:10:22.345628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:21.74554Z","time spent":"600.078534ms","remote":"127.0.0.1:37270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-09-09T01:10:22.889371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.513119ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:10:22.889978Z","caller":"traceutil/trace.go:171","msg":"trace[886836161] linearizableReadLoop","detail":"{readStateIndex:2957; appliedIndex:2956; }","duration":"544.549259ms","start":"2026-09-09T01:10:22.34541Z","end":"2026-09-09T01:10:22.889959Z","steps":["trace[886836161] 'read index received' (duration: 109.236865ms)","trace[886836161] 'applied index is now lower than readState.Index' (duration: 435.310534ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:10:22.890029Z","caller":"traceutil/trace.go:171","msg":"trace[1994207307] transaction","detail":"{read_only:false; response_revision:2841; number_of_response:1; }","duration":"888.077156ms","start":"2026-09-09T01:10:22.001924Z","end":"2026-09-09T01:10:22.890001Z","steps":["trace[1994207307] 'process raft request' (duration: 452.703741ms)","trace[1994207307] 'compare' (duration: 434.333563ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:10:22.890138Z","caller":"traceutil/trace.go:171","msg":"trace[1982164112] transaction","detail":"{read_only:false; response_revision:2842; number_of_response:1; }","duration":"510.479315ms","start":"2026-09-09T01:10:22.37965Z","end":"2026-09-09T01:10:22.890129Z","steps":["trace[1982164112] 'process raft request' (duration: 509.839306ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:10:22.890131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:22.001888Z","time spent":"888.186889ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:10:22.890138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.037360737s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-09T01:10:22.890122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.686408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-09T01:10:22.890205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:22.379599Z","time spent":"510.558398ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:10:22.89021Z","caller":"traceutil/trace.go:171","msg":"trace[308846885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2842; }","duration":"1.037432669s","start":"2026-09-09T01:10:21.85274Z","end":"2026-09-09T01:10:22.890173Z","steps":["trace[308846885] 'agreement among raft nodes before linearized reading' (duration: 1.037247614s)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:10:22.890221Z","caller":"traceutil/trace.go:171","msg":"trace[2066438111] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:2842; }","duration":"954.881053ms","start":"2026-09-09T01:10:21.935301Z","end":"2026-09-09T01:10:22.890182Z","steps":["trace[2066438111] 'agreement among raft nodes before linearized reading' (duration: 954.691888ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:10:22.890243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:21.852729Z","time spent":"1.037508252s","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-09T01:10:22.89018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"925.313657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-09T01:10:22.89023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.037670677s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-09-09T01:10:22.89027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:21.93527Z","time spent":"954.987187ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true "} {"level":"info","ts":"2026-09-09T01:10:22.890311Z","caller":"traceutil/trace.go:171","msg":"trace[647694612] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2842; }","duration":"925.464191ms","start":"2026-09-09T01:10:21.964816Z","end":"2026-09-09T01:10:22.89028Z","steps":["trace[647694612] 'agreement among raft nodes before linearized reading' (duration: 925.213214ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:10:22.890329Z","caller":"traceutil/trace.go:171","msg":"trace[1553912888] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2842; }","duration":"1.037874743s","start":"2026-09-09T01:10:21.852431Z","end":"2026-09-09T01:10:22.890306Z","steps":["trace[1553912888] 'agreement among raft nodes before linearized reading' (duration: 1.037564774s)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:10:22.890373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:21.964752Z","time spent":"925.611815ms","remote":"127.0.0.1:37006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-09T01:10:22.890378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:21.852404Z","time spent":"1.037961825s","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-09T01:10:22.89038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044367769s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-09T01:10:22.890536Z","caller":"traceutil/trace.go:171","msg":"trace[1153055848] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2842; }","duration":"1.044542275s","start":"2026-09-09T01:10:21.845938Z","end":"2026-09-09T01:10:22.89048Z","steps":["trace[1153055848] 'agreement among raft nodes before linearized reading' (duration: 1.044084202s)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:10:22.890632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:21.84591Z","time spent":"1.044670659s","remote":"127.0.0.1:37256","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":"info","ts":"2026-09-09T01:10:22.89109Z","caller":"traceutil/trace.go:171","msg":"trace[1147894707] transaction","detail":"{read_only:false; response_revision:2843; number_of_response:1; }","duration":"510.558907ms","start":"2026-09-09T01:10:22.380498Z","end":"2026-09-09T01:10:22.891057Z","steps":["trace[1147894707] 'process raft request' (duration: 510.347591ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:10:22.89116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.147365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"warn","ts":"2026-09-09T01:10:22.891246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:22.380486Z","time spent":"510.665571ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:10:22.891283Z","caller":"traceutil/trace.go:171","msg":"trace[1083842462] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2843; }","duration":"282.308549ms","start":"2026-09-09T01:10:22.608958Z","end":"2026-09-09T01:10:22.891267Z","steps":["trace[1083842462] 'agreement among raft nodes before linearized reading' (duration: 282.042682ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:10:28.830908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.442141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-09-09T01:10:28.830999Z","caller":"traceutil/trace.go:171","msg":"trace[862806222] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2873; }","duration":"222.581745ms","start":"2026-09-09T01:10:28.608396Z","end":"2026-09-09T01:10:28.830977Z","steps":["trace[862806222] 'range keys from in-memory index tree' (duration: 222.251146ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:10:35.046341Z","caller":"traceutil/trace.go:171","msg":"trace[1938799019] transaction","detail":"{read_only:false; response_revision:2905; number_of_response:1; }","duration":"107.096701ms","start":"2026-09-09T01:10:34.939205Z","end":"2026-09-09T01:10:35.046301Z","steps":["trace[1938799019] 'process raft request' (duration: 106.822412ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:14:58.480716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.577875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-09T01:14:58.480861Z","caller":"traceutil/trace.go:171","msg":"trace[1885829811] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5215; }","duration":"282.756172ms","start":"2026-09-09T01:14:58.198079Z","end":"2026-09-09T01:14:58.480836Z","steps":["trace[1885829811] 'count revisions from in-memory index tree' (duration: 282.419751ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:14:58.480756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.987846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-07ee8a73-e008-48fb-b469-943c5c1803f6\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-09-09T01:14:58.480963Z","caller":"traceutil/trace.go:171","msg":"trace[1832371992] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-07ee8a73-e008-48fb-b469-943c5c1803f6; range_end:; response_count:1; response_revision:5215; }","duration":"278.246164ms","start":"2026-09-09T01:14:58.202691Z","end":"2026-09-09T01:14:58.480937Z","steps":["trace[1832371992] 'range keys from in-memory index tree' (duration: 277.81678ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:14:58.503846Z","caller":"traceutil/trace.go:171","msg":"trace[1416362738] linearizableReadLoop","detail":"{readStateIndex:5420; appliedIndex:5419; }","duration":"209.666708ms","start":"2026-09-09T01:14:58.294153Z","end":"2026-09-09T01:14:58.503819Z","steps":["trace[1416362738] 'read index received' (duration: 209.520194ms)","trace[1416362738] 'applied index is now lower than readState.Index' (duration: 145.594µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:14:58.503916Z","caller":"traceutil/trace.go:171","msg":"trace[744539444] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"279.494212ms","start":"2026-09-09T01:14:58.224393Z","end":"2026-09-09T01:14:58.503887Z","steps":["trace[744539444] 'process raft request' (duration: 279.289586ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:14:58.503955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.792692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:14:58.504001Z","caller":"traceutil/trace.go:171","msg":"trace[1699408555] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:5216; }","duration":"209.887944ms","start":"2026-09-09T01:14:58.2941Z","end":"2026-09-09T01:14:58.503988Z","steps":["trace[1699408555] 'agreement among raft nodes before linearized reading' (duration: 209.796052ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:15:00.054605Z","caller":"traceutil/trace.go:171","msg":"trace[1419981418] transaction","detail":"{read_only:false; response_revision:5245; number_of_response:1; }","duration":"114.136513ms","start":"2026-09-09T01:14:59.940423Z","end":"2026-09-09T01:15:00.05456Z","steps":["trace[1419981418] 'process raft request' (duration: 50.655821ms)","trace[1419981418] 'compare' (duration: 63.277635ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:15:13.243419Z","caller":"traceutil/trace.go:171","msg":"trace[1804354152] transaction","detail":"{read_only:false; response_revision:5490; number_of_response:1; }","duration":"232.187296ms","start":"2026-09-09T01:15:13.011202Z","end":"2026-09-09T01:15:13.243389Z","steps":["trace[1804354152] 'process raft request' (duration: 231.881507ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:15:13.264374Z","caller":"traceutil/trace.go:171","msg":"trace[540436103] transaction","detail":"{read_only:false; response_revision:5491; number_of_response:1; }","duration":"147.808586ms","start":"2026-09-09T01:15:13.116542Z","end":"2026-09-09T01:15:13.26435Z","steps":["trace[540436103] 'process raft request' (duration: 139.575387ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:15:21.24434Z","caller":"traceutil/trace.go:171","msg":"trace[609274827] transaction","detail":"{read_only:false; response_revision:5658; number_of_response:1; }","duration":"147.262659ms","start":"2026-09-09T01:15:21.096999Z","end":"2026-09-09T01:15:21.244262Z","steps":["trace[609274827] 'process raft request' (duration: 114.542581ms)","trace[609274827] 'compare' (duration: 32.304686ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:15:21.628756Z","caller":"traceutil/trace.go:171","msg":"trace[1210339830] transaction","detail":"{read_only:false; response_revision:5659; number_of_response:1; }","duration":"370.246507ms","start":"2026-09-09T01:15:21.258458Z","end":"2026-09-09T01:15:21.628705Z","steps":["trace[1210339830] 'process raft request' (duration: 275.682289ms)","trace[1210339830] 'compare' (duration: 93.927049ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:15:21.628762Z","caller":"traceutil/trace.go:171","msg":"trace[2129121409] transaction","detail":"{read_only:false; response_revision:5660; number_of_response:1; }","duration":"308.1067ms","start":"2026-09-09T01:15:21.320611Z","end":"2026-09-09T01:15:21.628717Z","steps":["trace[2129121409] 'process raft request' (duration: 307.952746ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:15:21.628821Z","caller":"traceutil/trace.go:171","msg":"trace[190959780] linearizableReadLoop","detail":"{readStateIndex:5878; appliedIndex:5876; }","duration":"317.170653ms","start":"2026-09-09T01:15:21.311617Z","end":"2026-09-09T01:15:21.628788Z","steps":["trace[190959780] 'read index received' (duration: 7.676141ms)","trace[190959780] 'applied index is now lower than readState.Index' (duration: 309.492671ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:15:21.62898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:15:21.258431Z","time spent":"370.428393ms","remote":"127.0.0.1:37192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6119,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:15:21.629016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:15:21.320575Z","time spent":"308.304586ms","remote":"127.0.0.1:37052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:15:21.629252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.8859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"} {"level":"warn","ts":"2026-09-09T01:15:21.629285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.373393ms","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-09T01:15:21.629351Z","caller":"traceutil/trace.go:171","msg":"trace[658871930] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5660; }","duration":"201.049765ms","start":"2026-09-09T01:15:21.428284Z","end":"2026-09-09T01:15:21.629333Z","steps":["trace[658871930] 'agreement among raft nodes before linearized reading' (duration: 200.764416ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:15:21.629373Z","caller":"traceutil/trace.go:171","msg":"trace[199280875] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5660; }","duration":"243.494416ms","start":"2026-09-09T01:15:21.385861Z","end":"2026-09-09T01:15:21.629355Z","steps":["trace[199280875] 'agreement among raft nodes before linearized reading' (duration: 243.28579ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:15:21.629254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.041127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-09T01:15:21.629451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.475252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:15:21.629509Z","caller":"traceutil/trace.go:171","msg":"trace[625971609] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:5660; }","duration":"304.298855ms","start":"2026-09-09T01:15:21.325162Z","end":"2026-09-09T01:15:21.629461Z","steps":["trace[625971609] 'agreement among raft nodes before linearized reading' (duration: 303.834711ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:15:21.629608Z","caller":"traceutil/trace.go:171","msg":"trace[2024494757] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:5660; }","duration":"317.973598ms","start":"2026-09-09T01:15:21.311543Z","end":"2026-09-09T01:15:21.629517Z","steps":["trace[2024494757] 'agreement among raft nodes before linearized reading' (duration: 317.416001ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:15:21.629605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:15:21.32515Z","time spent":"304.414689ms","remote":"127.0.0.1:37204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":79,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-09-09T01:15:21.629721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:15:21.311516Z","time spent":"318.135703ms","remote":"127.0.0.1:35150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true "} {"level":"info","ts":"2026-09-09T01:15:21.777106Z","caller":"traceutil/trace.go:171","msg":"trace[1898450117] transaction","detail":"{read_only:false; response_revision:5662; number_of_response:1; }","duration":"141.935868ms","start":"2026-09-09T01:15:21.63513Z","end":"2026-09-09T01:15:21.777065Z","steps":["trace[1898450117] 'process raft request' (duration: 102.670682ms)","trace[1898450117] 'compare' (duration: 38.975367ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:15:21.777133Z","caller":"traceutil/trace.go:171","msg":"trace[1103287995] transaction","detail":"{read_only:false; response_revision:5664; number_of_response:1; }","duration":"141.236007ms","start":"2026-09-09T01:15:21.63588Z","end":"2026-09-09T01:15:21.777116Z","steps":["trace[1103287995] 'process raft request' (duration: 141.161565ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:15:21.777239Z","caller":"traceutil/trace.go:171","msg":"trace[928935766] transaction","detail":"{read_only:false; response_revision:5663; number_of_response:1; }","duration":"141.372762ms","start":"2026-09-09T01:15:21.635815Z","end":"2026-09-09T01:15:21.777188Z","steps":["trace[928935766] 'process raft request' (duration: 141.099814ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:15:21.777336Z","caller":"traceutil/trace.go:171","msg":"trace[1570676949] transaction","detail":"{read_only:false; response_revision:5666; number_of_response:1; }","duration":"140.699351ms","start":"2026-09-09T01:15:21.636622Z","end":"2026-09-09T01:15:21.777321Z","steps":["trace[1570676949] 'process raft request' (duration: 140.592937ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:15:21.777337Z","caller":"traceutil/trace.go:171","msg":"trace[2141883398] linearizableReadLoop","detail":"{readStateIndex:5884; appliedIndex:5879; }","duration":"140.813145ms","start":"2026-09-09T01:15:21.63651Z","end":"2026-09-09T01:15:21.777324Z","steps":["trace[2141883398] 'read index received' (duration: 13.357283ms)","trace[2141883398] 'applied index is now lower than readState.Index' (duration: 127.434131ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:15:21.777498Z","caller":"traceutil/trace.go:171","msg":"trace[24015852] transaction","detail":"{read_only:false; response_revision:5667; number_of_response:1; }","duration":"140.176996ms","start":"2026-09-09T01:15:21.637283Z","end":"2026-09-09T01:15:21.77746Z","steps":["trace[24015852] 'process raft request' (duration: 139.97162ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:15:21.777531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.00312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19300"} {"level":"info","ts":"2026-09-09T01:15:21.777696Z","caller":"traceutil/trace.go:171","msg":"trace[853354611] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5667; }","duration":"141.203926ms","start":"2026-09-09T01:15:21.636462Z","end":"2026-09-09T01:15:21.777666Z","steps":["trace[853354611] 'agreement among raft nodes before linearized reading' (duration: 140.916837ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:15:21.777877Z","caller":"traceutil/trace.go:171","msg":"trace[1109390007] transaction","detail":"{read_only:false; response_revision:5665; number_of_response:1; }","duration":"141.294149ms","start":"2026-09-09T01:15:21.636053Z","end":"2026-09-09T01:15:21.777347Z","steps":["trace[1109390007] 'process raft request' (duration: 141.030352ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:15:38.043936Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2926} {"level":"info","ts":"2026-09-09T01:15:38.116251Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2926,"took":"70.773279ms","hash":1617704381,"current-db-size-bytes":56598528,"current-db-size":"57 MB","current-db-size-in-use-bytes":32354304,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-09T01:15:38.116345Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1617704381,"revision":2926,"compact-revision":-1} {"level":"info","ts":"2026-09-09T01:20:38.051711Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5849} {"level":"info","ts":"2026-09-09T01:20:38.145346Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5849,"took":"91.86186ms","hash":2580680346,"current-db-size-bytes":56598528,"current-db-size":"57 MB","current-db-size-in-use-bytes":26464256,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-09T01:20:38.145509Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2580680346,"revision":5849,"compact-revision":2926} {"level":"warn","ts":"2026-09-09T01:21:47.284685Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10410809976123684508,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-09T01:21:47.28788Z","caller":"traceutil/trace.go:171","msg":"trace[1232237796] linearizableReadLoop","detail":"{readStateIndex:8895; appliedIndex:8894; }","duration":"503.931272ms","start":"2026-09-09T01:21:46.783916Z","end":"2026-09-09T01:21:47.287848Z","steps":["trace[1232237796] 'read index received' (duration: 503.727395ms)","trace[1232237796] 'applied index is now lower than readState.Index' (duration: 202.907µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:21:47.287935Z","caller":"traceutil/trace.go:171","msg":"trace[361494556] transaction","detail":"{read_only:false; response_revision:8582; number_of_response:1; }","duration":"513.641366ms","start":"2026-09-09T01:21:46.774266Z","end":"2026-09-09T01:21:47.287907Z","steps":["trace[361494556] 'process raft request' (duration: 513.394438ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:21:47.288107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.185729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-09T01:21:47.288102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:21:46.774236Z","time spent":"513.74879ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:21:47.288134Z","caller":"traceutil/trace.go:171","msg":"trace[1111360234] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8582; }","duration":"504.256711ms","start":"2026-09-09T01:21:46.783869Z","end":"2026-09-09T01:21:47.288126Z","steps":["trace[1111360234] 'agreement among raft nodes before linearized reading' (duration: 504.109426ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:21:47.288153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:21:46.783859Z","time spent":"504.290192ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-09T01:21:47.288245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.480853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-09-09T01:21:47.28826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.468222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:21:47.288306Z","caller":"traceutil/trace.go:171","msg":"trace[245663043] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8582; }","duration":"323.541454ms","start":"2026-09-09T01:21:46.964748Z","end":"2026-09-09T01:21:47.288289Z","steps":["trace[245663043] 'agreement among raft nodes before linearized reading' (duration: 323.479302ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:21:47.288308Z","caller":"traceutil/trace.go:171","msg":"trace[1073455326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8582; }","duration":"462.580467ms","start":"2026-09-09T01:21:46.825704Z","end":"2026-09-09T01:21:47.288284Z","steps":["trace[1073455326] 'agreement among raft nodes before linearized reading' (duration: 462.399361ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:21:47.288362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:21:46.964726Z","time spent":"323.629387ms","remote":"127.0.0.1:37006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-09T01:21:47.288375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:21:46.825691Z","time spent":"462.676189ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-09T01:21:47.288501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.605412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xwlc2\" ","response":"range_response_count:1 size:6526"} {"level":"info","ts":"2026-09-09T01:21:47.288589Z","caller":"traceutil/trace.go:171","msg":"trace[692133398] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xwlc2; range_end:; response_count:1; response_revision:8582; }","duration":"283.713215ms","start":"2026-09-09T01:21:47.004853Z","end":"2026-09-09T01:21:47.288567Z","steps":["trace[692133398] 'agreement among raft nodes before linearized reading' (duration: 283.386095ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:21:56.105757Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000022f7.wal"} {"level":"info","ts":"2026-09-09T01:21:59.199563Z","caller":"traceutil/trace.go:171","msg":"trace[88328497] linearizableReadLoop","detail":"{readStateIndex:8962; appliedIndex:8961; }","duration":"233.762048ms","start":"2026-09-09T01:21:58.965746Z","end":"2026-09-09T01:21:59.199509Z","steps":["trace[88328497] 'read index received' (duration: 233.50067ms)","trace[88328497] 'applied index is now lower than readState.Index' (duration: 259.728µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:21:59.199638Z","caller":"traceutil/trace.go:171","msg":"trace[760425928] transaction","detail":"{read_only:false; response_revision:8647; number_of_response:1; }","duration":"234.395247ms","start":"2026-09-09T01:21:58.965193Z","end":"2026-09-09T01:21:59.199589Z","steps":["trace[760425928] 'process raft request' (duration: 234.054696ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:21:59.199774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.979885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:21:59.200613Z","caller":"traceutil/trace.go:171","msg":"trace[2112571552] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8647; }","duration":"234.82863ms","start":"2026-09-09T01:21:58.965722Z","end":"2026-09-09T01:21:59.200551Z","steps":["trace[2112571552] 'agreement among raft nodes before linearized reading' (duration: 233.910472ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:21:59.942414Z","caller":"traceutil/trace.go:171","msg":"trace[1931630678] transaction","detail":"{read_only:false; response_revision:8651; number_of_response:1; }","duration":"290.756029ms","start":"2026-09-09T01:21:59.651624Z","end":"2026-09-09T01:21:59.94238Z","steps":["trace[1931630678] 'process raft request' (duration: 290.523591ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:22:00.000238Z","caller":"traceutil/trace.go:171","msg":"trace[475015581] transaction","detail":"{read_only:false; response_revision:8652; number_of_response:1; }","duration":"334.27818ms","start":"2026-09-09T01:21:59.66593Z","end":"2026-09-09T01:22:00.000208Z","steps":["trace[475015581] 'process raft request' (duration: 334.058404ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:00.000474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:21:59.665897Z","time spent":"334.470846ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:22:00.000522Z","caller":"traceutil/trace.go:171","msg":"trace[295546166] linearizableReadLoop","detail":"{readStateIndex:8968; appliedIndex:8965; }","duration":"261.625334ms","start":"2026-09-09T01:21:59.73886Z","end":"2026-09-09T01:22:00.000485Z","steps":["trace[295546166] 'read index received' (duration: 203.301312ms)","trace[295546166] 'applied index is now lower than readState.Index' (duration: 58.322562ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:22:00.000753Z","caller":"traceutil/trace.go:171","msg":"trace[1059822794] transaction","detail":"{read_only:false; response_revision:8653; number_of_response:1; }","duration":"331.798644ms","start":"2026-09-09T01:21:59.66894Z","end":"2026-09-09T01:22:00.000739Z","steps":["trace[1059822794] 'process raft request' (duration: 331.207857ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:00.000944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:21:59.668923Z","time spent":"331.871667ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:22:00.001305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.44066ms","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-09T01:22:00.001384Z","caller":"traceutil/trace.go:171","msg":"trace[1128581097] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8653; }","duration":"262.566953ms","start":"2026-09-09T01:21:59.738804Z","end":"2026-09-09T01:22:00.001371Z","steps":["trace[1128581097] 'agreement among raft nodes before linearized reading' (duration: 262.388788ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:22:00.51735Z","caller":"traceutil/trace.go:171","msg":"trace[2017917881] transaction","detail":"{read_only:false; response_revision:8656; number_of_response:1; }","duration":"122.007904ms","start":"2026-09-09T01:22:00.3953Z","end":"2026-09-09T01:22:00.517308Z","steps":["trace[2017917881] 'process raft request' (duration: 121.84398ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:22:00.989805Z","caller":"traceutil/trace.go:171","msg":"trace[1853869823] transaction","detail":"{read_only:false; response_revision:8657; number_of_response:1; }","duration":"181.553793ms","start":"2026-09-09T01:22:00.808214Z","end":"2026-09-09T01:22:00.989767Z","steps":["trace[1853869823] 'process raft request' (duration: 181.355136ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:22:26.781866Z","caller":"traceutil/trace.go:171","msg":"trace[2021361620] transaction","detail":"{read_only:false; response_revision:8851; number_of_response:1; }","duration":"108.830245ms","start":"2026-09-09T01:22:26.673014Z","end":"2026-09-09T01:22:26.781844Z","steps":["trace[2021361620] 'process raft request' (duration: 108.669029ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:22:30.238716Z","caller":"traceutil/trace.go:171","msg":"trace[365553777] linearizableReadLoop","detail":"{readStateIndex:9191; appliedIndex:9190; }","duration":"140.416514ms","start":"2026-09-09T01:22:30.098271Z","end":"2026-09-09T01:22:30.238688Z","steps":["trace[365553777] 'read index received' (duration: 140.28911ms)","trace[365553777] 'applied index is now lower than readState.Index' (duration: 126.154µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:22:30.238756Z","caller":"traceutil/trace.go:171","msg":"trace[1916665529] transaction","detail":"{read_only:false; response_revision:8867; number_of_response:1; }","duration":"192.477514ms","start":"2026-09-09T01:22:30.046249Z","end":"2026-09-09T01:22:30.238727Z","steps":["trace[1916665529] 'process raft request' (duration: 192.251797ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:30.239246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.929779ms","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-09T01:22:30.239406Z","caller":"traceutil/trace.go:171","msg":"trace[1474570269] 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:8867; }","duration":"141.121675ms","start":"2026-09-09T01:22:30.098251Z","end":"2026-09-09T01:22:30.239372Z","steps":["trace[1474570269] 'agreement among raft nodes before linearized reading' (duration: 140.559128ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:22:30.488186Z","caller":"traceutil/trace.go:171","msg":"trace[940252463] transaction","detail":"{read_only:false; response_revision:8868; number_of_response:1; }","duration":"381.03092ms","start":"2026-09-09T01:22:30.107123Z","end":"2026-09-09T01:22:30.488154Z","steps":["trace[940252463] 'process raft request' (duration: 380.784702ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:30.488443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:22:30.107091Z","time spent":"381.204025ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:22:30.488754Z","caller":"traceutil/trace.go:171","msg":"trace[1675744630] linearizableReadLoop","detail":"{readStateIndex:9193; appliedIndex:9191; }","duration":"249.888428ms","start":"2026-09-09T01:22:30.2388Z","end":"2026-09-09T01:22:30.488688Z","steps":["trace[1675744630] 'read index received' (duration: 249.090813ms)","trace[1675744630] 'applied index is now lower than readState.Index' (duration: 792.365µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:22:30.488798Z","caller":"traceutil/trace.go:171","msg":"trace[1529766323] transaction","detail":"{read_only:false; response_revision:8869; number_of_response:1; }","duration":"364.23489ms","start":"2026-09-09T01:22:30.12447Z","end":"2026-09-09T01:22:30.488705Z","steps":["trace[1529766323] 'process raft request' (duration: 363.626661ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:30.489011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:22:30.124446Z","time spent":"364.444826ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:22:30.489057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.056257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-09T01:22:30.489259Z","caller":"traceutil/trace.go:171","msg":"trace[1229781017] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:8869; }","duration":"206.309914ms","start":"2026-09-09T01:22:30.282925Z","end":"2026-09-09T01:22:30.489235Z","steps":["trace[1229781017] 'agreement among raft nodes before linearized reading' (duration: 206.030106ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:30.489079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.578923ms","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-09T01:22:30.48938Z","caller":"traceutil/trace.go:171","msg":"trace[1058826466] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8869; }","duration":"316.912113ms","start":"2026-09-09T01:22:30.172444Z","end":"2026-09-09T01:22:30.489356Z","steps":["trace[1058826466] 'agreement among raft nodes before linearized reading' (duration: 316.455809ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:30.489168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.410682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-72081296-a4be-40f2-b659-62c7b012f65f\" ","response":"range_response_count:1 size:1450"} {"level":"warn","ts":"2026-09-09T01:22:30.489443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:22:30.172425Z","time spent":"317.000445ms","remote":"127.0.0.1:37256","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-09T01:22:30.48947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.159321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-09T01:22:30.489515Z","caller":"traceutil/trace.go:171","msg":"trace[796130945] range","detail":"{range_begin:/registry/persistentvolumes/pvc-72081296-a4be-40f2-b659-62c7b012f65f; range_end:; response_count:1; response_revision:8869; }","duration":"245.798164ms","start":"2026-09-09T01:22:30.24368Z","end":"2026-09-09T01:22:30.489478Z","steps":["trace[796130945] 'agreement among raft nodes before linearized reading' (duration: 245.261128ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:22:30.48962Z","caller":"traceutil/trace.go:171","msg":"trace[865350187] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8869; }","duration":"209.320496ms","start":"2026-09-09T01:22:30.280251Z","end":"2026-09-09T01:22:30.489572Z","steps":["trace[865350187] 'agreement among raft nodes before linearized reading' (duration: 208.82077ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:22:40.794687Z","caller":"traceutil/trace.go:171","msg":"trace[242191334] transaction","detail":"{read_only:false; response_revision:8926; number_of_response:1; }","duration":"108.633669ms","start":"2026-09-09T01:22:40.686021Z","end":"2026-09-09T01:22:40.794654Z","steps":["trace[242191334] 'process raft request' (duration: 98.214602ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:41.70299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.889116ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-09T01:22:41.70349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.57213ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:22:41.703585Z","caller":"traceutil/trace.go:171","msg":"trace[870076449] linearizableReadLoop","detail":"{readStateIndex:9254; appliedIndex:9253; }","duration":"251.576069ms","start":"2026-09-09T01:22:41.451993Z","end":"2026-09-09T01:22:41.703569Z","steps":["trace[870076449] 'read index received' (duration: 105.729411ms)","trace[870076449] 'applied index is now lower than readState.Index' (duration: 145.845568ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:22:41.70364Z","caller":"traceutil/trace.go:171","msg":"trace[889712495] transaction","detail":"{read_only:false; response_revision:8927; number_of_response:1; }","duration":"289.019836ms","start":"2026-09-09T01:22:41.414597Z","end":"2026-09-09T01:22:41.703617Z","steps":["trace[889712495] 'process raft request' (duration: 143.24139ms)","trace[889712495] 'compare' (duration: 145.413026ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:22:41.703707Z","caller":"traceutil/trace.go:171","msg":"trace[1554259410] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:8926; }","duration":"136.466194ms","start":"2026-09-09T01:22:41.567068Z","end":"2026-09-09T01:22:41.703534Z","steps":["trace[1554259410] 'range keys from in-memory index tree' (duration: 135.873405ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:41.703723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.729744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:22:41.703785Z","caller":"traceutil/trace.go:171","msg":"trace[937000967] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:8927; }","duration":"251.842037ms","start":"2026-09-09T01:22:41.451926Z","end":"2026-09-09T01:22:41.703769Z","steps":["trace[937000967] 'agreement among raft nodes before linearized reading' (duration: 251.718543ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:22:42.712952Z","caller":"traceutil/trace.go:171","msg":"trace[1283146771] transaction","detail":"{read_only:false; response_revision:8933; number_of_response:1; }","duration":"185.720879ms","start":"2026-09-09T01:22:42.527208Z","end":"2026-09-09T01:22:42.712929Z","steps":["trace[1283146771] 'process raft request' (duration: 185.586895ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:43.064368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.735299ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:22:43.064478Z","caller":"traceutil/trace.go:171","msg":"trace[1781112327] transaction","detail":"{read_only:false; response_revision:8934; number_of_response:1; }","duration":"510.714308ms","start":"2026-09-09T01:22:42.553734Z","end":"2026-09-09T01:22:43.064448Z","steps":["trace[1781112327] 'process raft request' (duration: 245.817554ms)","trace[1781112327] 'compare' (duration: 264.389877ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:22:43.064527Z","caller":"traceutil/trace.go:171","msg":"trace[1015654214] linearizableReadLoop","detail":"{readStateIndex:9261; appliedIndex:9260; }","duration":"482.372157ms","start":"2026-09-09T01:22:42.582149Z","end":"2026-09-09T01:22:43.064521Z","steps":["trace[1015654214] 'read index received' (duration: 130.934996ms)","trace[1015654214] 'applied index is now lower than readState.Index' (duration: 351.436321ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:22:43.064588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:22:42.553715Z","time spent":"510.82164ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:22:43.064505Z","caller":"traceutil/trace.go:171","msg":"trace[598455721] transaction","detail":"{read_only:false; response_revision:8935; number_of_response:1; }","duration":"264.896473ms","start":"2026-09-09T01:22:42.7996Z","end":"2026-09-09T01:22:43.064496Z","steps":["trace[598455721] 'process raft request' (duration: 264.842531ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:43.064702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.556323ms","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-09T01:22:43.064729Z","caller":"traceutil/trace.go:171","msg":"trace[189791219] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8935; }","duration":"482.617435ms","start":"2026-09-09T01:22:42.582104Z","end":"2026-09-09T01:22:43.064721Z","steps":["trace[189791219] 'agreement among raft nodes before linearized reading' (duration: 482.46453ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:43.064761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:22:42.582085Z","time spent":"482.669066ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-09T01:22:43.064904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.051909ms","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-09T01:22:43.064939Z","caller":"traceutil/trace.go:171","msg":"trace[848037666] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8935; }","duration":"461.105811ms","start":"2026-09-09T01:22:42.603823Z","end":"2026-09-09T01:22:43.064929Z","steps":["trace[848037666] 'agreement among raft nodes before linearized reading' (duration: 461.020218ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:43.064963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:22:42.603811Z","time spent":"461.145692ms","remote":"127.0.0.1:37256","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":"info","ts":"2026-09-09T01:22:43.881049Z","caller":"traceutil/trace.go:171","msg":"trace[1850114817] linearizableReadLoop","detail":"{readStateIndex:9275; appliedIndex:9274; }","duration":"146.998493ms","start":"2026-09-09T01:22:43.734021Z","end":"2026-09-09T01:22:43.881019Z","steps":["trace[1850114817] 'read index received' (duration: 146.920071ms)","trace[1850114817] 'applied index is now lower than readState.Index' (duration: 76.972µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:22:43.881416Z","caller":"traceutil/trace.go:171","msg":"trace[1363628407] transaction","detail":"{read_only:false; response_revision:8948; number_of_response:1; }","duration":"149.742887ms","start":"2026-09-09T01:22:43.731653Z","end":"2026-09-09T01:22:43.881396Z","steps":["trace[1363628407] 'process raft request' (duration: 149.205501ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:43.881787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.748556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-ldrw2\" ","response":"range_response_count:1 size:4661"} {"level":"info","ts":"2026-09-09T01:22:43.881844Z","caller":"traceutil/trace.go:171","msg":"trace[264255402] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-ldrw2; range_end:; response_count:1; response_revision:8948; }","duration":"147.829368ms","start":"2026-09-09T01:22:43.733999Z","end":"2026-09-09T01:22:43.881828Z","steps":["trace[264255402] 'agreement among raft nodes before linearized reading' (duration: 147.656143ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:43.890841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.338177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-ldrw2\" ","response":"range_response_count:1 size:4661"} {"level":"info","ts":"2026-09-09T01:22:43.890909Z","caller":"traceutil/trace.go:171","msg":"trace[1844172062] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-ldrw2; range_end:; response_count:1; response_revision:8949; }","duration":"156.44227ms","start":"2026-09-09T01:22:43.734452Z","end":"2026-09-09T01:22:43.890894Z","steps":["trace[1844172062] 'agreement among raft nodes before linearized reading' (duration: 156.205723ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:43.891121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.481981ms","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-09T01:22:43.891146Z","caller":"traceutil/trace.go:171","msg":"trace[1087654911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8949; }","duration":"155.521842ms","start":"2026-09-09T01:22:43.735617Z","end":"2026-09-09T01:22:43.891139Z","steps":["trace[1087654911] 'agreement among raft nodes before linearized reading' (duration: 155.45591ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:43.891133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.692137ms","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-09T01:22:43.891182Z","caller":"traceutil/trace.go:171","msg":"trace[194350512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8949; }","duration":"154.785599ms","start":"2026-09-09T01:22:43.736384Z","end":"2026-09-09T01:22:43.89117Z","steps":["trace[194350512] 'agreement among raft nodes before linearized reading' (duration: 154.653215ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:22:43.891457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.936582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xwlc2\" ","response":"range_response_count:1 size:6526"} {"level":"info","ts":"2026-09-09T01:22:43.891497Z","caller":"traceutil/trace.go:171","msg":"trace[707505806] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xwlc2; range_end:; response_count:1; response_revision:8949; }","duration":"151.009294ms","start":"2026-09-09T01:22:43.740478Z","end":"2026-09-09T01:22:43.891488Z","steps":["trace[707505806] 'agreement among raft nodes before linearized reading' (duration: 150.89615ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:23:51.477051Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"fbe9b088d8de907a","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-09T01:23:51.483894Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-09-09T01:23:51.483985Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-09-09T01:25:38.060358Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7993} {"level":"info","ts":"2026-09-09T01:25:38.129942Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7993,"took":"67.80931ms","hash":1245568683,"current-db-size-bytes":56598528,"current-db-size":"57 MB","current-db-size-in-use-bytes":28286976,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-09T01:25:38.130054Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1245568683,"revision":7993,"compact-revision":5849} {"level":"info","ts":"2026-09-09T01:30:38.067744Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10377} {"level":"info","ts":"2026-09-09T01:30:38.1539Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10377,"took":"84.067755ms","hash":92897598,"current-db-size-bytes":56598528,"current-db-size":"57 MB","current-db-size-in-use-bytes":25739264,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-09T01:30:38.153967Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":92897598,"revision":10377,"compact-revision":7993} {"level":"info","ts":"2026-09-09T01:35:38.073394Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12545} {"level":"info","ts":"2026-09-09T01:35:38.149409Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12545,"took":"73.925581ms","hash":3292950037,"current-db-size-bytes":56598528,"current-db-size":"57 MB","current-db-size-in-use-bytes":27615232,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-09T01:35:38.149484Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3292950037,"revision":12545,"compact-revision":10377} {"level":"info","ts":"2026-09-09T01:36:00.167998Z","caller":"traceutil/trace.go:171","msg":"trace[1868119897] linearizableReadLoop","detail":"{readStateIndex:15236; appliedIndex:15235; }","duration":"120.951204ms","start":"2026-09-09T01:36:00.047021Z","end":"2026-09-09T01:36:00.167973Z","steps":["trace[1868119897] 'read index received' (duration: 120.796699ms)","trace[1868119897] 'applied index is now lower than readState.Index' (duration: 153.405µs)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:36:00.168213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.18077ms","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-09T01:36:00.168253Z","caller":"traceutil/trace.go:171","msg":"trace[1140162130] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:14718; }","duration":"121.264163ms","start":"2026-09-09T01:36:00.04698Z","end":"2026-09-09T01:36:00.168244Z","steps":["trace[1140162130] 'agreement among raft nodes before linearized reading' (duration: 121.092828ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:36:00.168575Z","caller":"traceutil/trace.go:171","msg":"trace[816808144] transaction","detail":"{read_only:false; response_revision:14718; number_of_response:1; }","duration":"137.433154ms","start":"2026-09-09T01:36:00.031126Z","end":"2026-09-09T01:36:00.168559Z","steps":["trace[816808144] 'process raft request' (duration: 136.679072ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:36:03.162528Z","caller":"traceutil/trace.go:171","msg":"trace[985344083] transaction","detail":"{read_only:false; response_revision:14729; number_of_response:1; }","duration":"102.845951ms","start":"2026-09-09T01:36:03.059662Z","end":"2026-09-09T01:36:03.162508Z","steps":["trace[985344083] 'process raft request' (duration: 102.429068ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:36:23.490195Z","caller":"traceutil/trace.go:171","msg":"trace[617620968] linearizableReadLoop","detail":"{readStateIndex:15362; appliedIndex:15361; }","duration":"134.462613ms","start":"2026-09-09T01:36:23.355699Z","end":"2026-09-09T01:36:23.490162Z","steps":["trace[617620968] 'read index received' (duration: 132.030379ms)","trace[617620968] 'applied index is now lower than readState.Index' (duration: 2.430154ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:36:23.490189Z","caller":"traceutil/trace.go:171","msg":"trace[882162561] transaction","detail":"{read_only:false; response_revision:14840; number_of_response:1; }","duration":"128.739159ms","start":"2026-09-09T01:36:23.361424Z","end":"2026-09-09T01:36:23.490164Z","steps":["trace[882162561] 'process raft request' (duration: 128.683758ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:36:23.490222Z","caller":"traceutil/trace.go:171","msg":"trace[1318039792] transaction","detail":"{read_only:false; response_revision:14839; number_of_response:1; }","duration":"196.236345ms","start":"2026-09-09T01:36:23.293944Z","end":"2026-09-09T01:36:23.490181Z","steps":["trace[1318039792] 'process raft request' (duration: 193.866852ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:36:23.490435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.127562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"} {"level":"info","ts":"2026-09-09T01:36:23.490502Z","caller":"traceutil/trace.go:171","msg":"trace[485839789] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14840; }","duration":"199.230065ms","start":"2026-09-09T01:36:23.291254Z","end":"2026-09-09T01:36:23.490484Z","steps":["trace[485839789] 'agreement among raft nodes before linearized reading' (duration: 199.012758ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:36:41.514446Z","caller":"traceutil/trace.go:171","msg":"trace[29793620] linearizableReadLoop","detail":"{readStateIndex:15472; appliedIndex:15471; }","duration":"446.000829ms","start":"2026-09-09T01:36:41.068413Z","end":"2026-09-09T01:36:41.514414Z","steps":["trace[29793620] 'read index received' (duration: 445.674638ms)","trace[29793620] 'applied index is now lower than readState.Index' (duration: 324.701µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:36:41.514523Z","caller":"traceutil/trace.go:171","msg":"trace[1313085718] transaction","detail":"{read_only:false; response_revision:14944; number_of_response:1; }","duration":"458.711756ms","start":"2026-09-09T01:36:41.055785Z","end":"2026-09-09T01:36:41.514497Z","steps":["trace[1313085718] 'process raft request' (duration: 458.430048ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:36:41.514648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:36:41.055758Z","time spent":"458.81861ms","remote":"127.0.0.1:37192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12479,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:36:41.514705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.448152ms","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-09T01:36:41.514789Z","caller":"traceutil/trace.go:171","msg":"trace[1812414333] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:14944; }","duration":"243.591156ms","start":"2026-09-09T01:36:41.27118Z","end":"2026-09-09T01:36:41.514771Z","steps":["trace[1812414333] 'agreement among raft nodes before linearized reading' (duration: 243.459392ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:36:41.514922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.452723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" ","response":"range_response_count:1 size:1857"} {"level":"info","ts":"2026-09-09T01:36:41.515078Z","caller":"traceutil/trace.go:171","msg":"trace[1154110174] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:14944; }","duration":"446.681779ms","start":"2026-09-09T01:36:41.068362Z","end":"2026-09-09T01:36:41.515044Z","steps":["trace[1154110174] 'agreement among raft nodes before linearized reading' (duration: 446.217516ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:36:41.515114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.54159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:36:41.515176Z","caller":"traceutil/trace.go:171","msg":"trace[1252813668] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:14944; }","duration":"143.669674ms","start":"2026-09-09T01:36:41.371489Z","end":"2026-09-09T01:36:41.515159Z","steps":["trace[1252813668] 'agreement among raft nodes before linearized reading' (duration: 143.577931ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:36:41.515222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.195801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.45\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-09T01:36:41.515258Z","caller":"traceutil/trace.go:171","msg":"trace[51475206] range","detail":"{range_begin:/registry/masterleases/162.253.55.45; range_end:; response_count:1; response_revision:14944; }","duration":"190.270323ms","start":"2026-09-09T01:36:41.324979Z","end":"2026-09-09T01:36:41.51525Z","steps":["trace[51475206] 'agreement among raft nodes before linearized reading' (duration: 190.19398ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:36:41.515846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:36:41.068345Z","time spent":"447.473293ms","remote":"127.0.0.1:37168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1880,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" "} {"level":"warn","ts":"2026-09-09T01:38:32.587681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.668491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-09T01:38:32.587797Z","caller":"traceutil/trace.go:171","msg":"trace[1926430274] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:16082; }","duration":"107.800735ms","start":"2026-09-09T01:38:32.479977Z","end":"2026-09-09T01:38:32.587777Z","steps":["trace[1926430274] 'count revisions from in-memory index tree' (duration: 107.560498ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:38:32.681929Z","caller":"traceutil/trace.go:171","msg":"trace[512112911] linearizableReadLoop","detail":"{readStateIndex:16648; appliedIndex:16646; }","duration":"119.311836ms","start":"2026-09-09T01:38:32.562584Z","end":"2026-09-09T01:38:32.681896Z","steps":["trace[512112911] 'read index received' (duration: 7.086056ms)","trace[512112911] 'applied index is now lower than readState.Index' (duration: 112.22479ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:38:32.681979Z","caller":"traceutil/trace.go:171","msg":"trace[1663084465] transaction","detail":"{read_only:false; response_revision:16084; number_of_response:1; }","duration":"130.771965ms","start":"2026-09-09T01:38:32.551181Z","end":"2026-09-09T01:38:32.681953Z","steps":["trace[1663084465] 'process raft request' (duration: 130.587099ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:38:32.682198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.598234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-09-09T01:38:32.682259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.192069ms","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-09T01:38:32.682272Z","caller":"traceutil/trace.go:171","msg":"trace[88775749] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:16084; }","duration":"119.733109ms","start":"2026-09-09T01:38:32.56252Z","end":"2026-09-09T01:38:32.682253Z","steps":["trace[88775749] 'agreement among raft nodes before linearized reading' (duration: 119.497002ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:38:32.682305Z","caller":"traceutil/trace.go:171","msg":"trace[1639642907] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:16084; }","duration":"113.274001ms","start":"2026-09-09T01:38:32.569017Z","end":"2026-09-09T01:38:32.682291Z","steps":["trace[1639642907] 'agreement among raft nodes before linearized reading' (duration: 113.113266ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:38:32.960051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.408103ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-09T01:38:32.960181Z","caller":"traceutil/trace.go:171","msg":"trace[350780674] linearizableReadLoop","detail":"{readStateIndex:16649; appliedIndex:16648; }","duration":"164.304636ms","start":"2026-09-09T01:38:32.795853Z","end":"2026-09-09T01:38:32.960158Z","steps":["trace[350780674] 'read index received' (duration: 33.666686ms)","trace[350780674] 'applied index is now lower than readState.Index' (duration: 130.63593ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:38:32.960233Z","caller":"traceutil/trace.go:171","msg":"trace[1021122882] transaction","detail":"{read_only:false; response_revision:16085; number_of_response:1; }","duration":"274.574196ms","start":"2026-09-09T01:38:32.685608Z","end":"2026-09-09T01:38:32.960182Z","steps":["trace[1021122882] 'process raft request' (duration: 143.914735ms)","trace[1021122882] 'compare' (duration: 129.846587ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:38:32.960359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.487632ms","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-09T01:38:32.960418Z","caller":"traceutil/trace.go:171","msg":"trace[845992699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:16085; }","duration":"164.588994ms","start":"2026-09-09T01:38:32.795809Z","end":"2026-09-09T01:38:32.960398Z","steps":["trace[845992699] 'agreement among raft nodes before linearized reading' (duration: 164.43946ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:38:32.960428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.304853ms","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-09T01:38:32.960487Z","caller":"traceutil/trace.go:171","msg":"trace[1210202949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:16085; }","duration":"159.396467ms","start":"2026-09-09T01:38:32.80108Z","end":"2026-09-09T01:38:32.960476Z","steps":["trace[1210202949] 'agreement among raft nodes before linearized reading' (duration: 159.1953ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:40:38.08591Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14559} {"level":"info","ts":"2026-09-09T01:40:38.163006Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14559,"took":"74.436718ms","hash":2402695028,"current-db-size-bytes":56598528,"current-db-size":"57 MB","current-db-size-in-use-bytes":31133696,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-09T01:40:38.163061Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2402695028,"revision":14559,"compact-revision":12545} {"level":"warn","ts":"2026-09-09T01:44:41.042179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.722903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-09T01:44:41.042269Z","caller":"traceutil/trace.go:171","msg":"trace[846352716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18759; }","duration":"144.868137ms","start":"2026-09-09T01:44:40.897382Z","end":"2026-09-09T01:44:41.042251Z","steps":["trace[846352716] 'range keys from in-memory index tree' (duration: 144.562268ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:44:41.042311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.625618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-09T01:44:41.04238Z","caller":"traceutil/trace.go:171","msg":"trace[433195301] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:18759; }","duration":"140.754412ms","start":"2026-09-09T01:44:40.901608Z","end":"2026-09-09T01:44:41.042362Z","steps":["trace[433195301] 'count revisions from in-memory index tree' (duration: 140.498824ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:44:41.042432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.101894ms","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-09T01:44:41.042489Z","caller":"traceutil/trace.go:171","msg":"trace[1332752138] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18759; }","duration":"145.193438ms","start":"2026-09-09T01:44:40.89728Z","end":"2026-09-09T01:44:41.042473Z","steps":["trace[1332752138] 'range keys from in-memory index tree' (duration: 144.93783ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:44:48.216916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.948101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-09T01:44:48.217004Z","caller":"traceutil/trace.go:171","msg":"trace[1067463062] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:18800; }","duration":"186.095105ms","start":"2026-09-09T01:44:48.030888Z","end":"2026-09-09T01:44:48.216983Z","steps":["trace[1067463062] 'count revisions from in-memory index tree' (duration: 185.837578ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:44:48.217138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.489764ms","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-09T01:44:48.217184Z","caller":"traceutil/trace.go:171","msg":"trace[809511501] linearizableReadLoop","detail":"{readStateIndex:19455; appliedIndex:19454; }","duration":"143.456565ms","start":"2026-09-09T01:44:48.073707Z","end":"2026-09-09T01:44:48.217164Z","steps":["trace[809511501] 'read index received' (duration: 135.697278ms)","trace[809511501] 'applied index is now lower than readState.Index' (duration: 7.758227ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:44:48.217233Z","caller":"traceutil/trace.go:171","msg":"trace[668582168] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18800; }","duration":"160.585167ms","start":"2026-09-09T01:44:48.056622Z","end":"2026-09-09T01:44:48.217207Z","steps":["trace[668582168] 'range keys from in-memory index tree' (duration: 160.210446ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:44:48.217232Z","caller":"traceutil/trace.go:171","msg":"trace[170312407] transaction","detail":"{read_only:false; response_revision:18801; number_of_response:1; }","duration":"160.521125ms","start":"2026-09-09T01:44:48.056683Z","end":"2026-09-09T01:44:48.217204Z","steps":["trace[170312407] 'process raft request' (duration: 152.771179ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:44:48.217415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.708253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-sw8m2\" ","response":"range_response_count:1 size:9788"} {"level":"info","ts":"2026-09-09T01:44:48.217467Z","caller":"traceutil/trace.go:171","msg":"trace[2075413144] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-sw8m2; range_end:; response_count:1; response_revision:18801; }","duration":"143.800565ms","start":"2026-09-09T01:44:48.073654Z","end":"2026-09-09T01:44:48.217454Z","steps":["trace[2075413144] 'agreement among raft nodes before linearized reading' (duration: 143.63062ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:45:30.311281Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"fbe9b088d8de907a","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-09T01:45:30.317751Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-09-09T01:45:30.317875Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-09-09T01:45:38.091897Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16932} {"level":"info","ts":"2026-09-09T01:45:38.190848Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16932,"took":"96.220745ms","hash":81921533,"current-db-size-bytes":56598528,"current-db-size":"57 MB","current-db-size-in-use-bytes":32927744,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-09-09T01:45:38.190914Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":81921533,"revision":16932,"compact-revision":14559} {"level":"info","ts":"2026-09-09T01:50:35.620184Z","caller":"traceutil/trace.go:171","msg":"trace[1267249180] transaction","detail":"{read_only:false; response_revision:21495; number_of_response:1; }","duration":"118.872605ms","start":"2026-09-09T01:50:35.501286Z","end":"2026-09-09T01:50:35.620159Z","steps":["trace[1267249180] 'process raft request' (duration: 118.728311ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:50:38.098257Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19400} {"level":"info","ts":"2026-09-09T01:50:38.221772Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19400,"took":"119.714401ms","hash":2585407842,"current-db-size-bytes":56598528,"current-db-size":"57 MB","current-db-size-in-use-bytes":29757440,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-09-09T01:50:38.221836Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2585407842,"revision":19400,"compact-revision":16932} {"level":"info","ts":"2026-09-09T01:50:41.172465Z","caller":"traceutil/trace.go:171","msg":"trace[1898196039] linearizableReadLoop","detail":"{readStateIndex:22270; appliedIndex:22269; }","duration":"115.417611ms","start":"2026-09-09T01:50:41.057017Z","end":"2026-09-09T01:50:41.172435Z","steps":["trace[1898196039] 'read index received' (duration: 115.196514ms)","trace[1898196039] 'applied index is now lower than readState.Index' (duration: 220.267µs)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:50:41.172509Z","caller":"traceutil/trace.go:171","msg":"trace[1254137803] transaction","detail":"{read_only:false; response_revision:21526; number_of_response:1; }","duration":"116.698219ms","start":"2026-09-09T01:50:41.055783Z","end":"2026-09-09T01:50:41.172481Z","steps":["trace[1254137803] 'process raft request' (duration: 116.490613ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:50:41.17267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.629078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-09T01:50:41.172707Z","caller":"traceutil/trace.go:171","msg":"trace[852415763] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21526; }","duration":"115.7187ms","start":"2026-09-09T01:50:41.056977Z","end":"2026-09-09T01:50:41.172696Z","steps":["trace[852415763] 'agreement among raft nodes before linearized reading' (duration: 115.560156ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:50:51.518721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.468333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-09T01:50:51.518812Z","caller":"traceutil/trace.go:171","msg":"trace[1827854759] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:21578; }","duration":"144.614838ms","start":"2026-09-09T01:50:51.374173Z","end":"2026-09-09T01:50:51.518788Z","steps":["trace[1827854759] 'count revisions from in-memory index tree' (duration: 144.35679ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:50:51.518799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.26269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.45\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-09-09T01:50:51.51888Z","caller":"traceutil/trace.go:171","msg":"trace[1014638936] range","detail":"{range_begin:/registry/masterleases/162.253.55.45; range_end:; response_count:1; response_revision:21578; }","duration":"149.382374ms","start":"2026-09-09T01:50:51.369477Z","end":"2026-09-09T01:50:51.51886Z","steps":["trace[1014638936] 'range keys from in-memory index tree' (duration: 149.108766ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:50:57.050911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.607697ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-09T01:50:57.051104Z","caller":"traceutil/trace.go:171","msg":"trace[2124330073] transaction","detail":"{read_only:false; response_revision:21607; number_of_response:1; }","duration":"214.36972ms","start":"2026-09-09T01:50:56.836717Z","end":"2026-09-09T01:50:57.051087Z","steps":["trace[2124330073] 'process raft request' (duration: 47.454403ms)","trace[2124330073] 'compare' (duration: 166.081332ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:50:57.051482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.084888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-09T01:50:57.051577Z","caller":"traceutil/trace.go:171","msg":"trace[618997290] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:21607; }","duration":"208.254434ms","start":"2026-09-09T01:50:56.8433Z","end":"2026-09-09T01:50:57.051554Z","steps":["trace[618997290] 'agreement among raft nodes before linearized reading' (duration: 208.011076ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:50:57.051043Z","caller":"traceutil/trace.go:171","msg":"trace[1114811382] linearizableReadLoop","detail":"{readStateIndex:22355; appliedIndex:22354; }","duration":"207.649695ms","start":"2026-09-09T01:50:56.843372Z","end":"2026-09-09T01:50:57.051022Z","steps":["trace[1114811382] 'read index received' (duration: 40.672486ms)","trace[1114811382] 'applied index is now lower than readState.Index' (duration: 166.975799ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:50:57.303864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.870633ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-09T01:50:57.304096Z","caller":"traceutil/trace.go:171","msg":"trace[1466077253] transaction","detail":"{read_only:false; response_revision:21608; number_of_response:1; }","duration":"378.698789ms","start":"2026-09-09T01:50:56.925359Z","end":"2026-09-09T01:50:57.304058Z","steps":["trace[1466077253] 'process raft request' (duration: 263.548257ms)","trace[1466077253] 'compare' (duration: 114.74569ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:50:57.304135Z","caller":"traceutil/trace.go:171","msg":"trace[1612154308] linearizableReadLoop","detail":"{readStateIndex:22356; appliedIndex:22355; }","duration":"148.712753ms","start":"2026-09-09T01:50:57.155405Z","end":"2026-09-09T01:50:57.304118Z","steps":["trace[1612154308] 'read index received' (duration: 33.435747ms)","trace[1612154308] 'applied index is now lower than readState.Index' (duration: 115.275326ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:50:57.304283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:56.925335Z","time spent":"378.848133ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-09T01:50:57.304449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.055313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"} {"level":"info","ts":"2026-09-09T01:50:57.304488Z","caller":"traceutil/trace.go:171","msg":"trace[2034168132] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:21608; }","duration":"149.127675ms","start":"2026-09-09T01:50:57.155349Z","end":"2026-09-09T01:50:57.304477Z","steps":["trace[2034168132] 'agreement among raft nodes before linearized reading' (duration: 148.867138ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:50:57.624192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.860545ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-09T01:50:57.624483Z","caller":"traceutil/trace.go:171","msg":"trace[1823767853] transaction","detail":"{read_only:false; response_revision:21610; number_of_response:1; }","duration":"310.855954ms","start":"2026-09-09T01:50:57.313601Z","end":"2026-09-09T01:50:57.624457Z","steps":["trace[1823767853] 'process raft request' (duration: 143.464042ms)","trace[1823767853] 'compare' (duration: 166.739582ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:50:57.624567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:57.313582Z","time spent":"310.946277ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:50:57.62534Z","caller":"traceutil/trace.go:171","msg":"trace[1457591424] transaction","detail":"{read_only:false; response_revision:21611; number_of_response:1; }","duration":"311.36982ms","start":"2026-09-09T01:50:57.313955Z","end":"2026-09-09T01:50:57.625325Z","steps":["trace[1457591424] 'process raft request' (duration: 311.172354ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:50:57.625692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.706376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-09T01:50:57.62573Z","caller":"traceutil/trace.go:171","msg":"trace[764246149] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21612; }","duration":"227.787359ms","start":"2026-09-09T01:50:57.397936Z","end":"2026-09-09T01:50:57.625723Z","steps":["trace[764246149] 'agreement among raft nodes before linearized reading' (duration: 227.704645ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:50:57.625745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:57.313934Z","time spent":"311.740502ms","remote":"127.0.0.1:37256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-09T01:50:57.62558Z","caller":"traceutil/trace.go:171","msg":"trace[667038185] linearizableReadLoop","detail":"{readStateIndex:22360; appliedIndex:22357; }","duration":"227.567581ms","start":"2026-09-09T01:50:57.397977Z","end":"2026-09-09T01:50:57.625545Z","steps":["trace[667038185] 'read index received' (duration: 59.075567ms)","trace[667038185] 'applied index is now lower than readState.Index' (duration: 168.490804ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:50:57.625617Z","caller":"traceutil/trace.go:171","msg":"trace[1504247329] transaction","detail":"{read_only:false; response_revision:21612; number_of_response:1; }","duration":"268.293709ms","start":"2026-09-09T01:50:57.35731Z","end":"2026-09-09T01:50:57.625603Z","steps":["trace[1504247329] 'process raft request' (duration: 267.901858ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:50:57.858777Z","caller":"traceutil/trace.go:171","msg":"trace[1602652705] transaction","detail":"{read_only:false; response_revision:21613; number_of_response:1; }","duration":"159.980465ms","start":"2026-09-09T01:50:57.698758Z","end":"2026-09-09T01:50:57.858738Z","steps":["trace[1602652705] 'process raft request' (duration: 156.937473ms)"],"step_count":1} {"level":"warn","ts":"2026-09-09T01:50:58.20178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.509513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-09T01:50:58.20186Z","caller":"traceutil/trace.go:171","msg":"trace[179896026] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21613; }","duration":"235.627607ms","start":"2026-09-09T01:50:57.966214Z","end":"2026-09-09T01:50:58.201842Z","steps":["trace[179896026] 'range keys from in-memory index tree' (duration: 235.439481ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:50:58.435011Z","caller":"traceutil/trace.go:171","msg":"trace[1244480032] transaction","detail":"{read_only:false; response_revision:21614; number_of_response:1; }","duration":"203.038396ms","start":"2026-09-09T01:50:58.231936Z","end":"2026-09-09T01:50:58.434974Z","steps":["trace[1244480032] 'process raft request' (duration: 202.820888ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:50:58.530437Z","caller":"traceutil/trace.go:171","msg":"trace[927698825] linearizableReadLoop","detail":"{readStateIndex:22363; appliedIndex:22361; }","duration":"147.897478ms","start":"2026-09-09T01:50:58.382509Z","end":"2026-09-09T01:50:58.530407Z","steps":["trace[927698825] 'read index received' (duration: 52.264649ms)","trace[927698825] 'applied index is now lower than readState.Index' (duration: 95.631369ms)"],"step_count":2} {"level":"info","ts":"2026-09-09T01:50:58.530538Z","caller":"traceutil/trace.go:171","msg":"trace[1405031856] transaction","detail":"{read_only:false; response_revision:21615; number_of_response:1; }","duration":"295.858799ms","start":"2026-09-09T01:50:58.234645Z","end":"2026-09-09T01:50:58.530504Z","steps":["trace[1405031856] 'process raft request' (duration: 278.14148ms)","trace[1405031856] 'compare' (duration: 17.479292ms)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:50:58.530695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.164167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12210"} {"level":"info","ts":"2026-09-09T01:50:58.530733Z","caller":"traceutil/trace.go:171","msg":"trace[1208949944] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21615; }","duration":"148.248629ms","start":"2026-09-09T01:50:58.382473Z","end":"2026-09-09T01:50:58.530721Z","steps":["trace[1208949944] 'agreement among raft nodes before linearized reading' (duration: 148.084474ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:55:03.444245Z","caller":"traceutil/trace.go:171","msg":"trace[413251706] linearizableReadLoop","detail":"{readStateIndex:24876; appliedIndex:24875; }","duration":"140.329078ms","start":"2026-09-09T01:55:03.303863Z","end":"2026-09-09T01:55:03.444192Z","steps":["trace[413251706] 'read index received' (duration: 139.940176ms)","trace[413251706] 'applied index is now lower than readState.Index' (duration: 387.281µs)"],"step_count":2} {"level":"warn","ts":"2026-09-09T01:55:03.444428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.531754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/cert-manager-test/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes/cert-manager-test0\" limit:10000 ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-09T01:55:03.444471Z","caller":"traceutil/trace.go:171","msg":"trace[1587514789] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/cert-manager-test/; range_end:/registry/gateway.networking.k8s.io/grpcroutes/cert-manager-test0; response_count:0; response_revision:24055; }","duration":"140.631437ms","start":"2026-09-09T01:55:03.303827Z","end":"2026-09-09T01:55:03.444459Z","steps":["trace[1587514789] 'agreement among raft nodes before linearized reading' (duration: 140.525284ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:55:03.444342Z","caller":"traceutil/trace.go:171","msg":"trace[213601130] transaction","detail":"{read_only:false; response_revision:24055; number_of_response:1; }","duration":"148.206077ms","start":"2026-09-09T01:55:03.296069Z","end":"2026-09-09T01:55:03.444275Z","steps":["trace[213601130] 'process raft request' (duration: 147.825476ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:55:07.411297Z","caller":"traceutil/trace.go:171","msg":"trace[1346610600] transaction","detail":"{read_only:false; response_revision:24149; number_of_response:1; }","duration":"186.008807ms","start":"2026-09-09T01:55:07.225257Z","end":"2026-09-09T01:55:07.411266Z","steps":["trace[1346610600] 'process raft request' (duration: 185.810401ms)"],"step_count":1} {"level":"info","ts":"2026-09-09T01:55:38.109589Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21508} {"level":"info","ts":"2026-09-09T01:55:38.224853Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21508,"took":"110.506711ms","hash":2396796681,"current-db-size-bytes":56598528,"current-db-size":"57 MB","current-db-size-in-use-bytes":42545152,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-09-09T01:55:38.224931Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2396796681,"revision":21508,"compact-revision":19400} {"level":"info","ts":"2026-09-09T01:59:44.299764Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006afc.wal"} {"level":"info","ts":"2026-09-09T02:00:38.117696Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24496} {"level":"info","ts":"2026-09-09T02:00:38.271886Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24496,"took":"150.533703ms","hash":2930800467,"current-db-size-bytes":56598528,"current-db-size":"57 MB","current-db-size-in-use-bytes":31977472,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-09T02:00:38.27196Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2930800467,"revision":24496,"compact-revision":21508}