{"level":"warn","ts":"2026-10-19T01:49:19.686937Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-19T01:49:19.687051Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.43: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.43:2380","--initial-cluster=instance=https://162.253.55.43:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.43:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.43:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-19T01:49:19.687136Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-19T01:49:19.687161Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.43:2380"]} {"level":"info","ts":"2026-10-19T01:49:19.687187Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-19T01:49:19.687939Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"]} {"level":"info","ts":"2026-10-19T01:49:19.688028Z","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.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.43:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-19T01:49:19.691045Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.74218ms"} {"level":"info","ts":"2026-10-19T01:49:19.697035Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"14f8f2dfdaccebdb","cluster-id":"5f02ccb15672f35d"} {"level":"info","ts":"2026-10-19T01:49:19.697118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=()"} {"level":"info","ts":"2026-10-19T01:49:19.697137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 0"} {"level":"info","ts":"2026-10-19T01:49:19.697148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 14f8f2dfdaccebdb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-19T01:49:19.697154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 1"} {"level":"info","ts":"2026-10-19T01:49:19.697184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"} {"level":"warn","ts":"2026-10-19T01:49:19.702618Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-19T01:49:19.704422Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-19T01:49:19.706095Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-10-19T01:49:19.708852Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"14f8f2dfdaccebdb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-19T01:49:19.709228Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"14f8f2dfdaccebdb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-19T01:49:19.70938Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-19T01:49:19.70958Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-19T01:49:19.709601Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-19T01:49:19.711054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"} {"level":"info","ts":"2026-10-19T01:49:19.712021Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","added-peer-id":"14f8f2dfdaccebdb","added-peer-peer-urls":["https://162.253.55.43:2380"]} {"level":"info","ts":"2026-10-19T01:49:19.714729Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-19T01:49:19.714886Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.43:2380"} {"level":"info","ts":"2026-10-19T01:49:19.714949Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.43:2380"} {"level":"info","ts":"2026-10-19T01:49:19.715121Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"14f8f2dfdaccebdb","initial-advertise-peer-urls":["https://162.253.55.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-19T01:49:19.715226Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-19T01:49:19.797685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb is starting a new election at term 1"} {"level":"info","ts":"2026-10-19T01:49:19.797772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became pre-candidate at term 1"} {"level":"info","ts":"2026-10-19T01:49:19.797801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgPreVoteResp from 14f8f2dfdaccebdb at term 1"} {"level":"info","ts":"2026-10-19T01:49:19.797827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became candidate at term 2"} {"level":"info","ts":"2026-10-19T01:49:19.797839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgVoteResp from 14f8f2dfdaccebdb at term 2"} {"level":"info","ts":"2026-10-19T01:49:19.797856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became leader at term 2"} {"level":"info","ts":"2026-10-19T01:49:19.797878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 14f8f2dfdaccebdb elected leader 14f8f2dfdaccebdb at term 2"} {"level":"info","ts":"2026-10-19T01:49:19.798917Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"14f8f2dfdaccebdb","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.43:2379]}","request-path":"/0/members/14f8f2dfdaccebdb/attributes","cluster-id":"5f02ccb15672f35d","publish-timeout":"7s"} {"level":"info","ts":"2026-10-19T01:49:19.799141Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-19T01:49:19.799213Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-19T01:49:19.799354Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-19T01:49:19.799423Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-19T01:49:19.799481Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:49:19.801131Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:49:19.801341Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:49:19.801385Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-19T01:49:19.802956Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.43:2379"} {"level":"info","ts":"2026-10-19T01:49:19.803446Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-19T01:49:37.72633Z","caller":"traceutil/trace.go:171","msg":"trace[997971784] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"116.963563ms","start":"2026-10-19T01:49:37.609332Z","end":"2026-10-19T01:49:37.726295Z","steps":["trace[997971784] 'process raft request' (duration: 116.736377ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:50:13.677618Z","caller":"traceutil/trace.go:171","msg":"trace[1173192332] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:678; }","duration":"170.84644ms","start":"2026-10-19T01:50:13.506741Z","end":"2026-10-19T01:50:13.677587Z","steps":["trace[1173192332] 'read index received' (duration: 99.144417ms)","trace[1173192332] 'applied index is now lower than readState.Index' (duration: 71.700033ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:50:13.677829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.051426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:50:13.677934Z","caller":"traceutil/trace.go:171","msg":"trace[158490769] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:652; }","duration":"171.202919ms","start":"2026-10-19T01:50:13.506716Z","end":"2026-10-19T01:50:13.677919Z","steps":["trace[158490769] 'agreement among raft nodes before linearized reading' (duration: 171.037265ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:50:14.208549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.397473ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T01:50:14.208687Z","caller":"traceutil/trace.go:171","msg":"trace[1408576220] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:680; }","duration":"511.983877ms","start":"2026-10-19T01:50:13.696684Z","end":"2026-10-19T01:50:14.208668Z","steps":["trace[1408576220] 'read index received' (duration: 383.517655ms)","trace[1408576220] 'applied index is now lower than readState.Index' (duration: 128.464722ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:50:14.208734Z","caller":"traceutil/trace.go:171","msg":"trace[1041143446] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"512.057179ms","start":"2026-10-19T01:50:13.696643Z","end":"2026-10-19T01:50:14.2087Z","steps":["trace[1041143446] 'process raft request' (duration: 383.461014ms)","trace[1041143446] 'compare' (duration: 126.269955ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:50:14.208937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.226263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-19T01:50:14.209059Z","caller":"traceutil/trace.go:171","msg":"trace[1030942352] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:654; }","duration":"512.416798ms","start":"2026-10-19T01:50:13.696611Z","end":"2026-10-19T01:50:14.209028Z","steps":["trace[1030942352] 'agreement among raft nodes before linearized reading' (duration: 512.11242ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:50:14.208903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:50:13.696619Z","time spent":"512.186092ms","remote":"127.0.0.1:53142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T01:50:14.209144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:50:13.69658Z","time spent":"512.545291ms","remote":"127.0.0.1:52996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"info","ts":"2026-10-19T01:50:14.333286Z","caller":"traceutil/trace.go:171","msg":"trace[156456928] linearizableReadLoop","detail":"{readStateIndex:682; appliedIndex:681; }","duration":"124.54137ms","start":"2026-10-19T01:50:14.208713Z","end":"2026-10-19T01:50:14.333254Z","steps":["trace[156456928] 'read index received' (duration: 118.3292ms)","trace[156456928] 'applied index is now lower than readState.Index' (duration: 6.21071ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:50:14.333326Z","caller":"traceutil/trace.go:171","msg":"trace[53732386] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"228.425121ms","start":"2026-10-19T01:50:14.104869Z","end":"2026-10-19T01:50:14.333294Z","steps":["trace[53732386] 'process raft request' (duration: 222.472578ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:50:14.333612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.80833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-10-19T01:50:14.333632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.4435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-19T01:50:14.333658Z","caller":"traceutil/trace.go:171","msg":"trace[612898619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:655; }","duration":"365.924693ms","start":"2026-10-19T01:50:13.967721Z","end":"2026-10-19T01:50:14.333646Z","steps":["trace[612898619] 'agreement among raft nodes before linearized reading' (duration: 365.699877ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:50:14.333704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T01:50:13.967684Z","time spent":"366.011125ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-19T01:50:14.33378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.736808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-19T01:50:14.333912Z","caller":"traceutil/trace.go:171","msg":"trace[726202655] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:655; }","duration":"121.963004ms","start":"2026-10-19T01:50:14.211915Z","end":"2026-10-19T01:50:14.333878Z","steps":["trace[726202655] 'agreement among raft nodes before linearized reading' (duration: 121.659316ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:50:14.33389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.315622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-19T01:50:14.334034Z","caller":"traceutil/trace.go:171","msg":"trace[1428654636] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:655; }","duration":"178.591358ms","start":"2026-10-19T01:50:14.15539Z","end":"2026-10-19T01:50:14.333981Z","steps":["trace[1428654636] 'agreement among raft nodes before linearized reading' (duration: 177.965472ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:50:14.333697Z","caller":"traceutil/trace.go:171","msg":"trace[1008509347] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:655; }","duration":"212.567542ms","start":"2026-10-19T01:50:14.121106Z","end":"2026-10-19T01:50:14.333674Z","steps":["trace[1008509347] 'agreement among raft nodes before linearized reading' (duration: 212.304836ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:50:29.543118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.917083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-19T01:50:29.543165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.598145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:50:29.543256Z","caller":"traceutil/trace.go:171","msg":"trace[1485785050] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:823; }","duration":"180.084788ms","start":"2026-10-19T01:50:29.363123Z","end":"2026-10-19T01:50:29.543208Z","steps":["trace[1485785050] 'range keys from in-memory index tree' (duration: 179.77897ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:50:29.543257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.906362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:50:29.543321Z","caller":"traceutil/trace.go:171","msg":"trace[2013957989] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:823; }","duration":"221.820151ms","start":"2026-10-19T01:50:29.321469Z","end":"2026-10-19T01:50:29.54329Z","steps":["trace[2013957989] 'range keys from in-memory index tree' (duration: 221.522043ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:50:29.543341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.735983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:50:29.543398Z","caller":"traceutil/trace.go:171","msg":"trace[106862525] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:823; }","duration":"222.819857ms","start":"2026-10-19T01:50:29.320563Z","end":"2026-10-19T01:50:29.543383Z","steps":["trace[106862525] 'count revisions from in-memory index tree' (duration: 222.62517ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:50:29.543466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.694049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-19T01:50:29.543558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.94784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-19T01:50:29.543575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.398586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:50:29.543568Z","caller":"traceutil/trace.go:171","msg":"trace[1259701890] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:823; }","duration":"179.834222ms","start":"2026-10-19T01:50:29.36371Z","end":"2026-10-19T01:50:29.543544Z","steps":["trace[1259701890] 'range keys from in-memory index tree' (duration: 179.613987ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:50:29.543606Z","caller":"traceutil/trace.go:171","msg":"trace[897041644] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:823; }","duration":"244.045292ms","start":"2026-10-19T01:50:29.299547Z","end":"2026-10-19T01:50:29.543592Z","steps":["trace[897041644] 'count revisions from in-memory index tree' (duration: 243.816636ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:50:29.54362Z","caller":"traceutil/trace.go:171","msg":"trace[416278896] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:823; }","duration":"180.482219ms","start":"2026-10-19T01:50:29.363124Z","end":"2026-10-19T01:50:29.543606Z","steps":["trace[416278896] 'count revisions from in-memory index tree' (duration: 180.262563ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:50:29.543739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.122094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:50:29.54381Z","caller":"traceutil/trace.go:171","msg":"trace[2080075533] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:823; }","duration":"244.234088ms","start":"2026-10-19T01:50:29.299533Z","end":"2026-10-19T01:50:29.543767Z","steps":["trace[2080075533] 'range keys from in-memory index tree' (duration: 243.97706ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:50:29.543511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.806677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T01:50:29.544007Z","caller":"traceutil/trace.go:171","msg":"trace[939221820] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:823; }","duration":"223.35862ms","start":"2026-10-19T01:50:29.320633Z","end":"2026-10-19T01:50:29.543991Z","steps":["trace[939221820] 'range keys from in-memory index tree' (duration: 222.721644ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:50:29.543457Z","caller":"traceutil/trace.go:171","msg":"trace[1798712685] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:823; }","duration":"243.085297ms","start":"2026-10-19T01:50:29.300259Z","end":"2026-10-19T01:50:29.543345Z","steps":["trace[1798712685] 'range keys from in-memory index tree' (duration: 242.827919ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:51:20.288247Z","caller":"traceutil/trace.go:171","msg":"trace[892096336] transaction","detail":"{read_only:false; response_revision:1474; number_of_response:1; }","duration":"161.889076ms","start":"2026-10-19T01:51:20.126332Z","end":"2026-10-19T01:51:20.288221Z","steps":["trace[892096336] 'process raft request' (duration: 161.715952ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:51:46.429268Z","caller":"traceutil/trace.go:171","msg":"trace[1092117109] linearizableReadLoop","detail":"{readStateIndex:1961; appliedIndex:1960; }","duration":"204.641963ms","start":"2026-10-19T01:51:46.224594Z","end":"2026-10-19T01:51:46.429236Z","steps":["trace[1092117109] 'read index received' (duration: 204.420828ms)","trace[1092117109] 'applied index is now lower than readState.Index' (duration: 219.265µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:51:46.42944Z","caller":"traceutil/trace.go:171","msg":"trace[1148937715] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"215.161254ms","start":"2026-10-19T01:51:46.214263Z","end":"2026-10-19T01:51:46.429424Z","steps":["trace[1148937715] 'process raft request' (duration: 214.733173ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:46.429719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.106556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2deb8d86-43ee-40a5-bb28-85d00ac9505d\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-10-19T01:51:46.429797Z","caller":"traceutil/trace.go:171","msg":"trace[21544727] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2deb8d86-43ee-40a5-bb28-85d00ac9505d; range_end:; response_count:1; response_revision:1886; }","duration":"205.247199ms","start":"2026-10-19T01:51:46.224528Z","end":"2026-10-19T01:51:46.429775Z","steps":["trace[21544727] 'agreement among raft nodes before linearized reading' (duration: 205.034744ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:51:46.563968Z","caller":"traceutil/trace.go:171","msg":"trace[1526060155] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"169.016018ms","start":"2026-10-19T01:51:46.394909Z","end":"2026-10-19T01:51:46.563925Z","steps":["trace[1526060155] 'process raft request' (duration: 123.937271ms)","trace[1526060155] 'compare' (duration: 44.727899ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:51:46.564136Z","caller":"traceutil/trace.go:171","msg":"trace[778092479] linearizableReadLoop","detail":"{readStateIndex:1963; appliedIndex:1961; }","duration":"134.725619ms","start":"2026-10-19T01:51:46.429381Z","end":"2026-10-19T01:51:46.564107Z","steps":["trace[778092479] 'read index received' (duration: 89.55296ms)","trace[778092479] 'applied index is now lower than readState.Index' (duration: 45.170539ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:51:46.564327Z","caller":"traceutil/trace.go:171","msg":"trace[252520991] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"167.882851ms","start":"2026-10-19T01:51:46.396366Z","end":"2026-10-19T01:51:46.564249Z","steps":["trace[252520991] 'process raft request' (duration: 167.482231ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T01:51:46.564448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.996092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-19T01:51:46.564523Z","caller":"traceutil/trace.go:171","msg":"trace[853474408] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1888; }","duration":"143.129195ms","start":"2026-10-19T01:51:46.421378Z","end":"2026-10-19T01:51:46.564507Z","steps":["trace[853474408] 'agreement among raft nodes before linearized reading' (duration: 142.862008ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:51:46.573828Z","caller":"traceutil/trace.go:171","msg":"trace[783919058] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"134.867412ms","start":"2026-10-19T01:51:46.438931Z","end":"2026-10-19T01:51:46.573799Z","steps":["trace[783919058] 'process raft request' (duration: 134.628336ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:52:36.812195Z","caller":"traceutil/trace.go:171","msg":"trace[1414701062] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"109.43821ms","start":"2026-10-19T01:52:36.702729Z","end":"2026-10-19T01:52:36.812167Z","steps":["trace[1414701062] 'process raft request' (duration: 109.239215ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:52:36.93751Z","caller":"traceutil/trace.go:171","msg":"trace[1162733738] linearizableReadLoop","detail":"{readStateIndex:2303; appliedIndex:2302; }","duration":"102.738569ms","start":"2026-10-19T01:52:36.834737Z","end":"2026-10-19T01:52:36.937475Z","steps":["trace[1162733738] 'read index received' (duration: 55.946717ms)","trace[1162733738] 'applied index is now lower than readState.Index' (duration: 46.790252ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:52:36.93759Z","caller":"traceutil/trace.go:171","msg":"trace[1743245690] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"158.070938ms","start":"2026-10-19T01:52:36.779448Z","end":"2026-10-19T01:52:36.937518Z","steps":["trace[1743245690] 'process raft request' (duration: 111.219215ms)","trace[1743245690] 'compare' (duration: 46.467743ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:52:36.937811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.064337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-19T01:52:36.937854Z","caller":"traceutil/trace.go:171","msg":"trace[2137102475] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2216; }","duration":"103.1902ms","start":"2026-10-19T01:52:36.834654Z","end":"2026-10-19T01:52:36.937844Z","steps":["trace[2137102475] 'agreement among raft nodes before linearized reading' (duration: 102.989655ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:58:36.938482Z","caller":"traceutil/trace.go:171","msg":"trace[474868906] transaction","detail":"{read_only:false; number_of_response:0; response_revision:4918; }","duration":"113.256005ms","start":"2026-10-19T01:58:36.825197Z","end":"2026-10-19T01:58:36.938453Z","steps":["trace[474868906] 'process raft request' (duration: 65.431108ms)","trace[474868906] 'compare' (duration: 47.655092ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:58:36.938886Z","caller":"traceutil/trace.go:171","msg":"trace[1427121553] transaction","detail":"{read_only:false; response_revision:4919; number_of_response:1; }","duration":"105.941198ms","start":"2026-10-19T01:58:36.832909Z","end":"2026-10-19T01:58:36.93885Z","steps":["trace[1427121553] 'process raft request' (duration: 105.473785ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:58:37.596307Z","caller":"traceutil/trace.go:171","msg":"trace[1485706159] transaction","detail":"{read_only:false; response_revision:4954; number_of_response:1; }","duration":"121.240639ms","start":"2026-10-19T01:58:37.475029Z","end":"2026-10-19T01:58:37.596269Z","steps":["trace[1485706159] 'process raft request' (duration: 114.984899ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:58:43.604915Z","caller":"traceutil/trace.go:171","msg":"trace[911433727] linearizableReadLoop","detail":"{readStateIndex:5311; appliedIndex:5310; }","duration":"118.285874ms","start":"2026-10-19T01:58:43.486604Z","end":"2026-10-19T01:58:43.60489Z","steps":["trace[911433727] 'read index received' (duration: 77.021865ms)","trace[911433727] 'applied index is now lower than readState.Index' (duration: 41.262769ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T01:58:43.60495Z","caller":"traceutil/trace.go:171","msg":"trace[321861649] transaction","detail":"{read_only:false; response_revision:5113; number_of_response:1; }","duration":"130.001795ms","start":"2026-10-19T01:58:43.474908Z","end":"2026-10-19T01:58:43.60491Z","steps":["trace[321861649] 'process raft request' (duration: 88.703295ms)","trace[321861649] 'compare' (duration: 41.108295ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T01:58:43.60513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.512379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-10-19T01:58:43.605236Z","caller":"traceutil/trace.go:171","msg":"trace[617566032] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5113; }","duration":"118.665103ms","start":"2026-10-19T01:58:43.486533Z","end":"2026-10-19T01:58:43.605198Z","steps":["trace[617566032] 'agreement among raft nodes before linearized reading' (duration: 118.456288ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:59:04.880591Z","caller":"traceutil/trace.go:171","msg":"trace[449780141] transaction","detail":"{read_only:false; response_revision:5595; number_of_response:1; }","duration":"140.001121ms","start":"2026-10-19T01:59:04.740553Z","end":"2026-10-19T01:59:04.880554Z","steps":["trace[449780141] 'process raft request' (duration: 139.746934ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:59:05.025782Z","caller":"traceutil/trace.go:171","msg":"trace[1401166915] transaction","detail":"{read_only:false; response_revision:5596; number_of_response:1; }","duration":"254.755794ms","start":"2026-10-19T01:59:04.771001Z","end":"2026-10-19T01:59:05.025757Z","steps":["trace[1401166915] 'process raft request' (duration: 249.412257ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:59:05.028651Z","caller":"traceutil/trace.go:171","msg":"trace[1398353505] transaction","detail":"{read_only:false; response_revision:5598; number_of_response:1; }","duration":"141.935511ms","start":"2026-10-19T01:59:04.886703Z","end":"2026-10-19T01:59:05.028639Z","steps":["trace[1398353505] 'process raft request' (duration: 141.843648ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:59:05.028701Z","caller":"traceutil/trace.go:171","msg":"trace[184484243] transaction","detail":"{read_only:false; response_revision:5597; number_of_response:1; }","duration":"142.022813ms","start":"2026-10-19T01:59:04.886625Z","end":"2026-10-19T01:59:05.028648Z","steps":["trace[184484243] 'process raft request' (duration: 141.860189ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:59:05.028943Z","caller":"traceutil/trace.go:171","msg":"trace[1016430505] transaction","detail":"{read_only:false; response_revision:5599; number_of_response:1; }","duration":"141.90387ms","start":"2026-10-19T01:59:04.887028Z","end":"2026-10-19T01:59:05.028932Z","steps":["trace[1016430505] 'process raft request' (duration: 141.566342ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:59:05.028986Z","caller":"traceutil/trace.go:171","msg":"trace[144206700] transaction","detail":"{read_only:false; response_revision:5600; number_of_response:1; }","duration":"141.798557ms","start":"2026-10-19T01:59:04.887176Z","end":"2026-10-19T01:59:05.028974Z","steps":["trace[144206700] 'process raft request' (duration: 141.598462ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:59:14.727944Z","caller":"traceutil/trace.go:171","msg":"trace[1408003238] transaction","detail":"{read_only:false; response_revision:5770; number_of_response:1; }","duration":"135.864935ms","start":"2026-10-19T01:59:14.592031Z","end":"2026-10-19T01:59:14.727895Z","steps":["trace[1408003238] 'process raft request' (duration: 131.210255ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:59:15.195977Z","caller":"traceutil/trace.go:171","msg":"trace[741996777] transaction","detail":"{read_only:false; response_revision:5771; number_of_response:1; }","duration":"249.692063ms","start":"2026-10-19T01:59:14.946254Z","end":"2026-10-19T01:59:15.195946Z","steps":["trace[741996777] 'process raft request' (duration: 249.515429ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T01:59:20.070605Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2974} {"level":"info","ts":"2026-10-19T01:59:20.154924Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2974,"took":"82.606238ms","hash":2523494114,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":32329728,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-19T01:59:20.155008Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2523494114,"revision":2974,"compact-revision":-1} {"level":"info","ts":"2026-10-19T02:04:20.078151Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5883} {"level":"info","ts":"2026-10-19T02:04:20.173866Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5883,"took":"93.932344ms","hash":531003973,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":26603520,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-19T02:04:20.173946Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":531003973,"revision":5883,"compact-revision":2974} {"level":"info","ts":"2026-10-19T02:05:15.806263Z","caller":"traceutil/trace.go:171","msg":"trace[910919615] linearizableReadLoop","detail":"{readStateIndex:8883; appliedIndex:8882; }","duration":"266.703882ms","start":"2026-10-19T02:05:15.539532Z","end":"2026-10-19T02:05:15.806236Z","steps":["trace[910919615] 'read index received' (duration: 266.549158ms)","trace[910919615] 'applied index is now lower than readState.Index' (duration: 153.793µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:05:15.806326Z","caller":"traceutil/trace.go:171","msg":"trace[253675818] transaction","detail":"{read_only:false; response_revision:8578; number_of_response:1; }","duration":"268.033226ms","start":"2026-10-19T02:05:15.538262Z","end":"2026-10-19T02:05:15.806295Z","steps":["trace[253675818] 'process raft request' (duration: 267.79649ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:05:15.80649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.415791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-19T02:05:15.806527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.984518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-19T02:05:15.806596Z","caller":"traceutil/trace.go:171","msg":"trace[941701770] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8578; }","duration":"218.504094ms","start":"2026-10-19T02:05:15.588018Z","end":"2026-10-19T02:05:15.806522Z","steps":["trace[941701770] 'agreement among raft nodes before linearized reading' (duration: 218.387871ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:05:15.806607Z","caller":"traceutil/trace.go:171","msg":"trace[1652348168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8578; }","duration":"267.082681ms","start":"2026-10-19T02:05:15.539498Z","end":"2026-10-19T02:05:15.806581Z","steps":["trace[1652348168] 'agreement among raft nodes before linearized reading' (duration: 266.892066ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:05:15.935272Z","caller":"traceutil/trace.go:171","msg":"trace[1504280632] transaction","detail":"{read_only:false; response_revision:8579; number_of_response:1; }","duration":"124.730545ms","start":"2026-10-19T02:05:15.810516Z","end":"2026-10-19T02:05:15.935247Z","steps":["trace[1504280632] 'process raft request' (duration: 122.702163ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:05:28.078333Z","caller":"traceutil/trace.go:171","msg":"trace[678636137] transaction","detail":"{read_only:false; response_revision:8644; number_of_response:1; }","duration":"212.53794ms","start":"2026-10-19T02:05:27.865758Z","end":"2026-10-19T02:05:28.078296Z","steps":["trace[678636137] 'process raft request' (duration: 212.328735ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:05:28.206089Z","caller":"traceutil/trace.go:171","msg":"trace[2025563539] linearizableReadLoop","detail":"{readStateIndex:8953; appliedIndex:8952; }","duration":"105.312855ms","start":"2026-10-19T02:05:28.10075Z","end":"2026-10-19T02:05:28.206063Z","steps":["trace[2025563539] 'read index received' (duration: 60.495944ms)","trace[2025563539] 'applied index is now lower than readState.Index' (duration: 44.815821ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:05:28.206194Z","caller":"traceutil/trace.go:171","msg":"trace[1170923188] transaction","detail":"{read_only:false; response_revision:8645; number_of_response:1; }","duration":"123.75448ms","start":"2026-10-19T02:05:28.082405Z","end":"2026-10-19T02:05:28.206159Z","steps":["trace[1170923188] 'process raft request' (duration: 78.915048ms)","trace[1170923188] 'compare' (duration: 44.626566ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:05:28.206308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.533661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-19T02:05:28.206354Z","caller":"traceutil/trace.go:171","msg":"trace[136990847] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8645; }","duration":"105.630973ms","start":"2026-10-19T02:05:28.100709Z","end":"2026-10-19T02:05:28.20634Z","steps":["trace[136990847] 'agreement among raft nodes before linearized reading' (duration: 105.448999ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:05:28.968452Z","caller":"traceutil/trace.go:171","msg":"trace[2122447832] transaction","detail":"{read_only:false; response_revision:8648; number_of_response:1; }","duration":"251.765089ms","start":"2026-10-19T02:05:28.716644Z","end":"2026-10-19T02:05:28.968409Z","steps":["trace[2122447832] 'process raft request' (duration: 251.642776ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:05:58.458001Z","caller":"traceutil/trace.go:171","msg":"trace[1143626509] transaction","detail":"{read_only:false; response_revision:8858; number_of_response:1; }","duration":"111.730901ms","start":"2026-10-19T02:05:58.346235Z","end":"2026-10-19T02:05:58.457966Z","steps":["trace[1143626509] 'process raft request' (duration: 67.508125ms)","trace[1143626509] 'compare' (duration: 44.075602ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:06:04.174636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.352221ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T02:06:04.174768Z","caller":"traceutil/trace.go:171","msg":"trace[753181650] transaction","detail":"{read_only:false; response_revision:8887; number_of_response:1; }","duration":"368.351253ms","start":"2026-10-19T02:06:03.806389Z","end":"2026-10-19T02:06:04.17474Z","steps":["trace[753181650] 'process raft request' (duration: 54.772018ms)","trace[753181650] 'compare' (duration: 313.180695ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:06:04.174859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:06:03.806363Z","time spent":"368.448726ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:06:04.196594Z","caller":"traceutil/trace.go:171","msg":"trace[54945776] linearizableReadLoop","detail":"{readStateIndex:9206; appliedIndex:9205; }","duration":"257.948927ms","start":"2026-10-19T02:06:03.938619Z","end":"2026-10-19T02:06:04.196568Z","steps":["trace[54945776] 'read index received' (duration: 257.718761ms)","trace[54945776] 'applied index is now lower than readState.Index' (duration: 229.196µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:06:04.196678Z","caller":"traceutil/trace.go:171","msg":"trace[1132666530] transaction","detail":"{read_only:false; response_revision:8888; number_of_response:1; }","duration":"388.721237ms","start":"2026-10-19T02:06:03.807908Z","end":"2026-10-19T02:06:04.196629Z","steps":["trace[1132666530] 'process raft request' (duration: 388.496012ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:06:04.196844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.203143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-szls6\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-10-19T02:06:04.19692Z","caller":"traceutil/trace.go:171","msg":"trace[350810959] range","detail":"{range_begin:/registry/pods/openstack/keepalived-szls6; range_end:; response_count:1; response_revision:8888; }","duration":"258.310816ms","start":"2026-10-19T02:06:03.938589Z","end":"2026-10-19T02:06:04.196899Z","steps":["trace[350810959] 'agreement among raft nodes before linearized reading' (duration: 258.103451ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:06:04.19689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:06:03.807884Z","time spent":"388.890311ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:06:10.724858Z","caller":"traceutil/trace.go:171","msg":"trace[959751847] linearizableReadLoop","detail":"{readStateIndex:9281; appliedIndex:9280; }","duration":"345.850513ms","start":"2026-10-19T02:06:10.378983Z","end":"2026-10-19T02:06:10.724834Z","steps":["trace[959751847] 'read index received' (duration: 345.552665ms)","trace[959751847] 'applied index is now lower than readState.Index' (duration: 296.898µs)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:06:10.725117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.111449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-19T02:06:10.725274Z","caller":"traceutil/trace.go:171","msg":"trace[1088325676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8960; }","duration":"346.301394ms","start":"2026-10-19T02:06:10.378947Z","end":"2026-10-19T02:06:10.725249Z","steps":["trace[1088325676] 'agreement among raft nodes before linearized reading' (duration: 346.043938ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:06:10.725377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:06:10.378933Z","time spent":"346.404716ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-19T02:06:10.725117Z","caller":"traceutil/trace.go:171","msg":"trace[1227824559] transaction","detail":"{read_only:false; response_revision:8960; number_of_response:1; }","duration":"350.241875ms","start":"2026-10-19T02:06:10.374737Z","end":"2026-10-19T02:06:10.724978Z","steps":["trace[1227824559] 'process raft request' (duration: 349.838035ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:06:10.726133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:06:10.374713Z","time spent":"351.338584ms","remote":"127.0.0.1:42424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:06:10.828245Z","caller":"traceutil/trace.go:171","msg":"trace[1487499190] transaction","detail":"{read_only:false; response_revision:8961; number_of_response:1; }","duration":"318.935641ms","start":"2026-10-19T02:06:10.509287Z","end":"2026-10-19T02:06:10.828223Z","steps":["trace[1487499190] 'process raft request' (duration: 315.960485ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:06:10.828355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:06:10.509269Z","time spent":"319.031474ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:06:10.828368Z","caller":"traceutil/trace.go:171","msg":"trace[1381858506] transaction","detail":"{read_only:false; response_revision:8962; number_of_response:1; }","duration":"318.688495ms","start":"2026-10-19T02:06:10.509643Z","end":"2026-10-19T02:06:10.828331Z","steps":["trace[1381858506] 'process raft request' (duration: 318.467199ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:06:10.828541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:06:10.509623Z","time spent":"318.841679ms","remote":"127.0.0.1:53042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":746,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-19T02:06:10.828532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.343684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:06:10.828613Z","caller":"traceutil/trace.go:171","msg":"trace[88349483] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:8962; }","duration":"214.465938ms","start":"2026-10-19T02:06:10.614126Z","end":"2026-10-19T02:06:10.828592Z","steps":["trace[88349483] 'agreement among raft nodes before linearized reading' (duration: 214.248732ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:06:10.828964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.705895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-10-19T02:06:10.829006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.389863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-19T02:06:10.829079Z","caller":"traceutil/trace.go:171","msg":"trace[1529096130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8962; }","duration":"281.853888ms","start":"2026-10-19T02:06:10.547206Z","end":"2026-10-19T02:06:10.82906Z","steps":["trace[1529096130] 'agreement among raft nodes before linearized reading' (duration: 281.560461ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:06:10.829143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.967632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-nqrcf\" ","response":"range_response_count:1 size:4789"} {"level":"info","ts":"2026-10-19T02:06:10.82919Z","caller":"traceutil/trace.go:171","msg":"trace[1534966981] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-nqrcf; range_end:; response_count:1; response_revision:8962; }","duration":"319.033064ms","start":"2026-10-19T02:06:10.510144Z","end":"2026-10-19T02:06:10.829177Z","steps":["trace[1534966981] 'agreement among raft nodes before linearized reading' (duration: 318.901051ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:06:10.829241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:06:10.510138Z","time spent":"319.090976ms","remote":"127.0.0.1:53142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":4811,"request content":"key:\"/registry/pods/openstack/rook-ceph-detect-version-nqrcf\" "} {"level":"warn","ts":"2026-10-19T02:06:10.829102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.745465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225401"} {"level":"info","ts":"2026-10-19T02:06:10.829471Z","caller":"traceutil/trace.go:171","msg":"trace[1391200359] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:8962; }","duration":"150.014922ms","start":"2026-10-19T02:06:10.679319Z","end":"2026-10-19T02:06:10.829334Z","steps":["trace[1391200359] 'agreement among raft nodes before linearized reading' (duration: 149.13306ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:06:10.829102Z","caller":"traceutil/trace.go:171","msg":"trace[1941559204] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8962; }","duration":"268.531667ms","start":"2026-10-19T02:06:10.560546Z","end":"2026-10-19T02:06:10.829078Z","steps":["trace[1941559204] 'agreement among raft nodes before linearized reading' (duration: 268.226689ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:06:10.829014Z","caller":"traceutil/trace.go:171","msg":"trace[1419190604] linearizableReadLoop","detail":"{readStateIndex:9283; appliedIndex:9281; }","duration":"103.114909ms","start":"2026-10-19T02:06:10.725195Z","end":"2026-10-19T02:06:10.82831Z","steps":["trace[1419190604] 'read index received' (duration: 100.134522ms)","trace[1419190604] 'applied index is now lower than readState.Index' (duration: 2.978776ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:06:10.847491Z","caller":"traceutil/trace.go:171","msg":"trace[1107400105] transaction","detail":"{read_only:false; response_revision:8963; number_of_response:1; }","duration":"117.17867ms","start":"2026-10-19T02:06:10.730287Z","end":"2026-10-19T02:06:10.847466Z","steps":["trace[1107400105] 'process raft request' (duration: 117.037796ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:06:11.038517Z","caller":"traceutil/trace.go:171","msg":"trace[212655448] linearizableReadLoop","detail":"{readStateIndex:9287; appliedIndex:9284; }","duration":"172.871161ms","start":"2026-10-19T02:06:10.865625Z","end":"2026-10-19T02:06:11.038496Z","steps":["trace[212655448] 'read index received' (duration: 162.251548ms)","trace[212655448] 'applied index is now lower than readState.Index' (duration: 10.618083ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:06:11.038738Z","caller":"traceutil/trace.go:171","msg":"trace[311532870] transaction","detail":"{read_only:false; response_revision:8964; number_of_response:1; }","duration":"203.815105ms","start":"2026-10-19T02:06:10.834912Z","end":"2026-10-19T02:06:11.038727Z","steps":["trace[311532870] 'process raft request' (duration: 193.015377ms)","trace[311532870] 'compare' (duration: 10.364067ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:06:11.038868Z","caller":"traceutil/trace.go:171","msg":"trace[852182032] transaction","detail":"{read_only:false; response_revision:8965; number_of_response:1; }","duration":"203.916847ms","start":"2026-10-19T02:06:10.834944Z","end":"2026-10-19T02:06:11.038861Z","steps":["trace[852182032] 'process raft request' (duration: 203.437405ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:06:11.039012Z","caller":"traceutil/trace.go:171","msg":"trace[694157037] transaction","detail":"{read_only:false; response_revision:8966; number_of_response:1; }","duration":"194.026823ms","start":"2026-10-19T02:06:10.84498Z","end":"2026-10-19T02:06:11.039006Z","steps":["trace[694157037] 'process raft request' (duration: 193.432878ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:06:11.039171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.549307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1825"} {"level":"info","ts":"2026-10-19T02:06:11.039217Z","caller":"traceutil/trace.go:171","msg":"trace[818210396] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:8966; }","duration":"173.65169ms","start":"2026-10-19T02:06:10.865557Z","end":"2026-10-19T02:06:11.039209Z","steps":["trace[818210396] 'agreement among raft nodes before linearized reading' (duration: 173.535027ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:06:17.88757Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002483.wal"} {"level":"info","ts":"2026-10-19T02:07:29.265022Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"14f8f2dfdaccebdb","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T02:07:29.271935Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-19T02:07:29.27218Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-19T02:07:31.722956Z","caller":"traceutil/trace.go:171","msg":"trace[1229978663] linearizableReadLoop","detail":"{readStateIndex:10013; appliedIndex:10011; }","duration":"206.670109ms","start":"2026-10-19T02:07:31.516256Z","end":"2026-10-19T02:07:31.722926Z","steps":["trace[1229978663] 'read index received' (duration: 86.473821ms)","trace[1229978663] 'applied index is now lower than readState.Index' (duration: 120.195278ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:07:31.72301Z","caller":"traceutil/trace.go:171","msg":"trace[984626063] transaction","detail":"{read_only:false; response_revision:9670; number_of_response:1; }","duration":"210.988379ms","start":"2026-10-19T02:07:31.511998Z","end":"2026-10-19T02:07:31.722986Z","steps":["trace[984626063] 'process raft request' (duration: 163.792957ms)","trace[984626063] 'compare' (duration: 47.024998ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:07:31.723196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.923226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-10-19T02:07:31.723199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.251513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:07:31.723229Z","caller":"traceutil/trace.go:171","msg":"trace[723815177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9670; }","duration":"201.991278ms","start":"2026-10-19T02:07:31.521227Z","end":"2026-10-19T02:07:31.723219Z","steps":["trace[723815177] 'agreement among raft nodes before linearized reading' (duration: 201.850564ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:31.723241Z","caller":"traceutil/trace.go:171","msg":"trace[791839188] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9670; }","duration":"133.334265ms","start":"2026-10-19T02:07:31.589894Z","end":"2026-10-19T02:07:31.723228Z","steps":["trace[791839188] 'agreement among raft nodes before linearized reading' (duration: 133.244403ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:07:31.72401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.730275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-19T02:07:31.724117Z","caller":"traceutil/trace.go:171","msg":"trace[1357221650] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9670; }","duration":"207.844748ms","start":"2026-10-19T02:07:31.516249Z","end":"2026-10-19T02:07:31.724094Z","steps":["trace[1357221650] 'agreement among raft nodes before linearized reading' (duration: 206.823822ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:07:31.879591Z","caller":"traceutil/trace.go:171","msg":"trace[2050153193] transaction","detail":"{read_only:false; response_revision:9672; number_of_response:1; }","duration":"150.738371ms","start":"2026-10-19T02:07:31.728816Z","end":"2026-10-19T02:07:31.879555Z","steps":["trace[2050153193] 'process raft request' (duration: 110.878597ms)","trace[2050153193] 'compare' (duration: 39.706021ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:09:20.084584Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8073} {"level":"info","ts":"2026-10-19T02:09:20.167019Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8073,"took":"80.642882ms","hash":781390874,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":29298688,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-19T02:09:20.167069Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":781390874,"revision":8073,"compact-revision":5883} {"level":"info","ts":"2026-10-19T02:11:10.765819Z","caller":"traceutil/trace.go:171","msg":"trace[1461166626] transaction","detail":"{read_only:false; response_revision:11591; number_of_response:1; }","duration":"108.951698ms","start":"2026-10-19T02:11:10.656835Z","end":"2026-10-19T02:11:10.765787Z","steps":["trace[1461166626] 'process raft request' (duration: 108.63498ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:11:11.188856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.275408ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T02:11:11.189005Z","caller":"traceutil/trace.go:171","msg":"trace[1116977775] transaction","detail":"{read_only:false; response_revision:11593; number_of_response:1; }","duration":"125.738919ms","start":"2026-10-19T02:11:11.063242Z","end":"2026-10-19T02:11:11.18898Z","steps":["trace[1116977775] 'process raft request' (duration: 14.231925ms)","trace[1116977775] 'compare' (duration: 111.131464ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:11:11.657777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.564014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:11:11.657878Z","caller":"traceutil/trace.go:171","msg":"trace[267522113] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:11594; }","duration":"116.729228ms","start":"2026-10-19T02:11:11.541124Z","end":"2026-10-19T02:11:11.657853Z","steps":["trace[267522113] 'count revisions from in-memory index tree' (duration: 116.456732ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:14:20.096458Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10546} {"level":"info","ts":"2026-10-19T02:14:20.186266Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10546,"took":"87.530768ms","hash":535746651,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":28286976,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-19T02:14:20.186353Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":535746651,"revision":10546,"compact-revision":8073} {"level":"info","ts":"2026-10-19T02:17:25.418184Z","caller":"traceutil/trace.go:171","msg":"trace[836264018] transaction","detail":"{read_only:false; response_revision:14112; number_of_response:1; }","duration":"149.62106ms","start":"2026-10-19T02:17:25.268524Z","end":"2026-10-19T02:17:25.418145Z","steps":["trace[836264018] 'process raft request' (duration: 149.268262ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:17:25.53304Z","caller":"traceutil/trace.go:171","msg":"trace[1315528298] transaction","detail":"{read_only:false; response_revision:14113; number_of_response:1; }","duration":"106.932516ms","start":"2026-10-19T02:17:25.426071Z","end":"2026-10-19T02:17:25.533004Z","steps":["trace[1315528298] 'process raft request' (duration: 106.71943ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:17:42.119381Z","caller":"traceutil/trace.go:171","msg":"trace[1063145040] linearizableReadLoop","detail":"{readStateIndex:14701; appliedIndex:14700; }","duration":"238.131624ms","start":"2026-10-19T02:17:41.881226Z","end":"2026-10-19T02:17:42.119357Z","steps":["trace[1063145040] 'read index received' (duration: 237.95065ms)","trace[1063145040] 'applied index is now lower than readState.Index' (duration: 180.294µs)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:17:42.119472Z","caller":"traceutil/trace.go:171","msg":"trace[1907283629] transaction","detail":"{read_only:false; response_revision:14210; number_of_response:1; }","duration":"306.707546ms","start":"2026-10-19T02:17:41.812743Z","end":"2026-10-19T02:17:42.11945Z","steps":["trace[1907283629] 'process raft request' (duration: 306.48789ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:17:42.119549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.317509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-19T02:17:42.119626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:17:41.812724Z","time spent":"306.817518ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:17:42.119795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.068824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-19T02:17:42.119579Z","caller":"traceutil/trace.go:171","msg":"trace[1348992962] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:14210; }","duration":"238.401771ms","start":"2026-10-19T02:17:41.881169Z","end":"2026-10-19T02:17:42.119571Z","steps":["trace[1348992962] 'agreement among raft nodes before linearized reading' (duration: 238.331479ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:17:42.119873Z","caller":"traceutil/trace.go:171","msg":"trace[1490884206] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14210; }","duration":"196.188807ms","start":"2026-10-19T02:17:41.923664Z","end":"2026-10-19T02:17:42.119852Z","steps":["trace[1490884206] 'agreement among raft nodes before linearized reading' (duration: 196.001632ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:17:42.120055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.725091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-t997r\" ","response":"range_response_count:1 size:12360"} {"level":"warn","ts":"2026-10-19T02:17:42.120085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.794803ms","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-10-19T02:17:42.120098Z","caller":"traceutil/trace.go:171","msg":"trace[1491738044] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-t997r; range_end:; response_count:1; response_revision:14210; }","duration":"122.801423ms","start":"2026-10-19T02:17:41.997286Z","end":"2026-10-19T02:17:42.120088Z","steps":["trace[1491738044] 'agreement among raft nodes before linearized reading' (duration: 122.665099ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:17:42.120115Z","caller":"traceutil/trace.go:171","msg":"trace[777895418] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:14210; }","duration":"182.827134ms","start":"2026-10-19T02:17:41.937277Z","end":"2026-10-19T02:17:42.120104Z","steps":["trace[777895418] 'agreement among raft nodes before linearized reading' (duration: 182.768043ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:17:52.576369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.600972ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-19T02:17:52.576508Z","caller":"traceutil/trace.go:171","msg":"trace[1914246727] transaction","detail":"{read_only:false; response_revision:14378; number_of_response:1; }","duration":"253.620882ms","start":"2026-10-19T02:17:52.322866Z","end":"2026-10-19T02:17:52.576487Z","steps":["trace[1914246727] 'process raft request' (duration: 117.817555ms)","trace[1914246727] 'compare' (duration: 135.404437ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:17:52.782508Z","caller":"traceutil/trace.go:171","msg":"trace[877291430] transaction","detail":"{read_only:false; response_revision:14379; number_of_response:1; }","duration":"431.103948ms","start":"2026-10-19T02:17:52.351373Z","end":"2026-10-19T02:17:52.782477Z","steps":["trace[877291430] 'process raft request' (duration: 342.705669ms)","trace[877291430] 'compare' (duration: 88.183034ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:17:52.782703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:17:52.351352Z","time spent":"431.262303ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:17:52.782802Z","caller":"traceutil/trace.go:171","msg":"trace[503781012] linearizableReadLoop","detail":"{readStateIndex:14874; appliedIndex:14871; }","duration":"386.01003ms","start":"2026-10-19T02:17:52.396763Z","end":"2026-10-19T02:17:52.782773Z","steps":["trace[503781012] 'read index received' (duration: 44.106242ms)","trace[503781012] 'applied index is now lower than readState.Index' (duration: 341.902648ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:17:52.782892Z","caller":"traceutil/trace.go:171","msg":"trace[50453325] transaction","detail":"{read_only:false; response_revision:14380; number_of_response:1; }","duration":"431.107608ms","start":"2026-10-19T02:17:52.351747Z","end":"2026-10-19T02:17:52.782855Z","steps":["trace[50453325] 'process raft request' (duration: 430.690767ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:17:52.783077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.664968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12430"} {"level":"warn","ts":"2026-10-19T02:17:52.783112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.9526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-19T02:17:52.783103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:17:52.351737Z","time spent":"431.255281ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:17:52.783152Z","caller":"traceutil/trace.go:171","msg":"trace[1793743630] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14380; }","duration":"194.041362ms","start":"2026-10-19T02:17:52.589099Z","end":"2026-10-19T02:17:52.783141Z","steps":["trace[1793743630] 'agreement among raft nodes before linearized reading' (duration: 193.964979ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:17:52.783137Z","caller":"traceutil/trace.go:171","msg":"trace[1471506127] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14380; }","duration":"379.755981ms","start":"2026-10-19T02:17:52.403366Z","end":"2026-10-19T02:17:52.783122Z","steps":["trace[1471506127] 'agreement among raft nodes before linearized reading' (duration: 379.559235ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:17:52.783129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.339848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-szls6\" ","response":"range_response_count:1 size:6520"} {"level":"warn","ts":"2026-10-19T02:17:52.783202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:17:52.403356Z","time spent":"379.835972ms","remote":"127.0.0.1:53142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12452,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-10-19T02:17:52.783204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.314783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/ovn-controller-fl8ml.18dfccb8dd96ca19\" ","response":"range_response_count:1 size:759"} {"level":"info","ts":"2026-10-19T02:17:52.783287Z","caller":"traceutil/trace.go:171","msg":"trace[1443725110] range","detail":"{range_begin:/registry/events/openstack/ovn-controller-fl8ml.18dfccb8dd96ca19; range_end:; response_count:1; response_revision:14380; }","duration":"170.452526ms","start":"2026-10-19T02:17:52.612812Z","end":"2026-10-19T02:17:52.783264Z","steps":["trace[1443725110] 'agreement among raft nodes before linearized reading' (duration: 170.24063ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:17:52.783299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.080402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:17 size:159144"} {"level":"info","ts":"2026-10-19T02:17:52.783352Z","caller":"traceutil/trace.go:171","msg":"trace[109043809] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:17; response_revision:14380; }","duration":"125.175214ms","start":"2026-10-19T02:17:52.658163Z","end":"2026-10-19T02:17:52.783338Z","steps":["trace[109043809] 'agreement among raft nodes before linearized reading' (duration: 124.811774ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:17:52.783361Z","caller":"traceutil/trace.go:171","msg":"trace[911906010] range","detail":"{range_begin:/registry/pods/openstack/keepalived-szls6; range_end:; response_count:1; response_revision:14380; }","duration":"386.531584ms","start":"2026-10-19T02:17:52.396685Z","end":"2026-10-19T02:17:52.783217Z","steps":["trace[911906010] 'agreement among raft nodes before linearized reading' (duration: 386.191004ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:17:52.784092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:17:52.39666Z","time spent":"387.364906ms","remote":"127.0.0.1:53142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6542,"request content":"key:\"/registry/pods/openstack/keepalived-szls6\" "} {"level":"info","ts":"2026-10-19T02:19:20.104484Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12830} {"level":"info","ts":"2026-10-19T02:19:20.188541Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12830,"took":"81.364088ms","hash":2537451031,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":31031296,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-19T02:19:20.188642Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2537451031,"revision":12830,"compact-revision":10546} {"level":"info","ts":"2026-10-19T02:19:33.564718Z","caller":"traceutil/trace.go:171","msg":"trace[1522282174] linearizableReadLoop","detail":"{readStateIndex:15991; appliedIndex:15990; }","duration":"279.786144ms","start":"2026-10-19T02:19:33.284892Z","end":"2026-10-19T02:19:33.564678Z","steps":["trace[1522282174] 'read index received' (duration: 257.182364ms)","trace[1522282174] 'applied index is now lower than readState.Index' (duration: 22.60221ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:19:33.564872Z","caller":"traceutil/trace.go:171","msg":"trace[535904025] transaction","detail":"{read_only:false; response_revision:15463; number_of_response:1; }","duration":"335.993267ms","start":"2026-10-19T02:19:33.228798Z","end":"2026-10-19T02:19:33.564791Z","steps":["trace[535904025] 'process raft request' (duration: 313.285214ms)","trace[535904025] 'compare' (duration: 22.420196ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:19:33.564893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.093589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-19T02:19:33.564928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.717437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:19:33.564977Z","caller":"traceutil/trace.go:171","msg":"trace[549981949] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15463; }","duration":"292.212642ms","start":"2026-10-19T02:19:33.272744Z","end":"2026-10-19T02:19:33.564957Z","steps":["trace[549981949] 'agreement among raft nodes before linearized reading' (duration: 292.012567ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:19:33.564966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.258708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-10-19T02:19:33.565031Z","caller":"traceutil/trace.go:171","msg":"trace[110004222] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:15463; }","duration":"326.905672ms","start":"2026-10-19T02:19:33.238102Z","end":"2026-10-19T02:19:33.565007Z","steps":["trace[110004222] 'agreement among raft nodes before linearized reading' (duration: 326.726878ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:19:33.565039Z","caller":"traceutil/trace.go:171","msg":"trace[1340024289] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15463; }","duration":"291.344241ms","start":"2026-10-19T02:19:33.273676Z","end":"2026-10-19T02:19:33.56502Z","steps":["trace[1340024289] 'agreement among raft nodes before linearized reading' (duration: 291.077854ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:19:33.565033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:19:33.228778Z","time spent":"336.173591ms","remote":"127.0.0.1:53130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19022,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:19:33.565079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:19:33.238067Z","time spent":"326.999835ms","remote":"127.0.0.1:47744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true "} {"level":"warn","ts":"2026-10-19T02:19:33.56544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.330449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:19:33.5655Z","caller":"traceutil/trace.go:171","msg":"trace[544046371] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15463; }","duration":"298.443722ms","start":"2026-10-19T02:19:33.267042Z","end":"2026-10-19T02:19:33.565486Z","steps":["trace[544046371] 'agreement among raft nodes before linearized reading' (duration: 298.34106ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:19:33.565699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.554846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:19:33.565754Z","caller":"traceutil/trace.go:171","msg":"trace[1526736560] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15463; }","duration":"298.622908ms","start":"2026-10-19T02:19:33.26712Z","end":"2026-10-19T02:19:33.565743Z","steps":["trace[1526736560] 'agreement among raft nodes before linearized reading' (duration: 297.599581ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:19:33.764579Z","caller":"traceutil/trace.go:171","msg":"trace[307199390] linearizableReadLoop","detail":"{readStateIndex:15992; appliedIndex:15991; }","duration":"199.710959ms","start":"2026-10-19T02:19:33.564837Z","end":"2026-10-19T02:19:33.764548Z","steps":["trace[307199390] 'read index received' (duration: 127.824703ms)","trace[307199390] 'applied index is now lower than readState.Index' (duration: 71.885186ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:19:33.764778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.187153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-19T02:19:33.764788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.149302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-10-19T02:19:33.764829Z","caller":"traceutil/trace.go:171","msg":"trace[1310465379] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15464; }","duration":"456.289325ms","start":"2026-10-19T02:19:33.308525Z","end":"2026-10-19T02:19:33.764814Z","steps":["trace[1310465379] 'agreement among raft nodes before linearized reading' (duration: 456.192483ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:19:33.764856Z","caller":"traceutil/trace.go:171","msg":"trace[1784790502] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15464; }","duration":"456.272185ms","start":"2026-10-19T02:19:33.308564Z","end":"2026-10-19T02:19:33.764836Z","steps":["trace[1784790502] 'agreement among raft nodes before linearized reading' (duration: 456.057329ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:19:33.764878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:19:33.3085Z","time spent":"456.366208ms","remote":"127.0.0.1:53216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "} {"level":"warn","ts":"2026-10-19T02:19:33.764868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.456663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-10-19T02:19:33.764919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:19:33.308531Z","time spent":"456.375228ms","remote":"127.0.0.1:53114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":690,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"warn","ts":"2026-10-19T02:19:33.764884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.044362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-10-19T02:19:33.76498Z","caller":"traceutil/trace.go:171","msg":"trace[320936946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15464; }","duration":"379.639918ms","start":"2026-10-19T02:19:33.385311Z","end":"2026-10-19T02:19:33.764951Z","steps":["trace[320936946] 'agreement among raft nodes before linearized reading' (duration: 379.272648ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:19:33.765001Z","caller":"traceutil/trace.go:171","msg":"trace[2120589256] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15464; }","duration":"437.228296ms","start":"2026-10-19T02:19:33.327746Z","end":"2026-10-19T02:19:33.764975Z","steps":["trace[2120589256] 'agreement among raft nodes before linearized reading' (duration: 436.871517ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:19:33.765041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:19:33.385284Z","time spent":"379.748291ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-19T02:19:33.765051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:19:33.327725Z","time spent":"437.316008ms","remote":"127.0.0.1:53216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5545,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "} {"level":"warn","ts":"2026-10-19T02:19:33.765318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.545263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-10-19T02:19:33.765362Z","caller":"traceutil/trace.go:171","msg":"trace[1839425857] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15464; }","duration":"398.622765ms","start":"2026-10-19T02:19:33.36673Z","end":"2026-10-19T02:19:33.765353Z","steps":["trace[1839425857] 'agreement among raft nodes before linearized reading' (duration: 398.509822ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:19:33.765387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:19:33.366709Z","time spent":"398.672556ms","remote":"127.0.0.1:53114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":690,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"warn","ts":"2026-10-19T02:19:33.765431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.0104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-zx8kv\" ","response":"range_response_count:1 size:20795"} {"level":"info","ts":"2026-10-19T02:19:33.765492Z","caller":"traceutil/trace.go:171","msg":"trace[1401529102] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-zx8kv; range_end:; response_count:1; response_revision:15464; }","duration":"266.134453ms","start":"2026-10-19T02:19:33.499342Z","end":"2026-10-19T02:19:33.765476Z","steps":["trace[1401529102] 'agreement among raft nodes before linearized reading' (duration: 265.948888ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:19:33.765061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.153541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/rook-ceph/rook-ceph-operator-config\" ","response":"range_response_count:1 size:6824"} {"level":"info","ts":"2026-10-19T02:19:33.765591Z","caller":"traceutil/trace.go:171","msg":"trace[730275384] range","detail":"{range_begin:/registry/configmaps/rook-ceph/rook-ceph-operator-config; range_end:; response_count:1; response_revision:15464; }","duration":"195.761517ms","start":"2026-10-19T02:19:33.569816Z","end":"2026-10-19T02:19:33.765578Z","steps":["trace[730275384] 'agreement among raft nodes before linearized reading' (duration: 194.976717ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:19:33.765607Z","caller":"traceutil/trace.go:171","msg":"trace[662818120] transaction","detail":"{read_only:false; response_revision:15464; number_of_response:1; }","duration":"306.303844ms","start":"2026-10-19T02:19:33.459284Z","end":"2026-10-19T02:19:33.765588Z","steps":["trace[662818120] 'process raft request' (duration: 233.468034ms)","trace[662818120] 'compare' (duration: 71.613798ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:19:33.765621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.338653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.43\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-10-19T02:19:33.765733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:19:33.459244Z","time spent":"306.399666ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:19:33.765729Z","caller":"traceutil/trace.go:171","msg":"trace[911992004] range","detail":"{range_begin:/registry/masterleases/162.253.55.43; range_end:; response_count:1; response_revision:15464; }","duration":"163.497668ms","start":"2026-10-19T02:19:33.602172Z","end":"2026-10-19T02:19:33.765669Z","steps":["trace[911992004] 'agreement among raft nodes before linearized reading' (duration: 163.216951ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:19:33.76578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.236403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-19T02:19:33.765826Z","caller":"traceutil/trace.go:171","msg":"trace[673913568] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15464; }","duration":"174.338486ms","start":"2026-10-19T02:19:33.591474Z","end":"2026-10-19T02:19:33.765813Z","steps":["trace[673913568] 'agreement among raft nodes before linearized reading' (duration: 174.264554ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:24:20.112399Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15397} {"level":"info","ts":"2026-10-19T02:24:20.222383Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15397,"took":"106.488182ms","hash":965988385,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":32288768,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-19T02:24:20.222492Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":965988385,"revision":15397,"compact-revision":12830} {"level":"info","ts":"2026-10-19T02:25:08.846804Z","caller":"traceutil/trace.go:171","msg":"trace[587748465] linearizableReadLoop","detail":"{readStateIndex:18511; appliedIndex:18510; }","duration":"169.710815ms","start":"2026-10-19T02:25:08.677067Z","end":"2026-10-19T02:25:08.846778Z","steps":["trace[587748465] 'read index received' (duration: 127.82749ms)","trace[587748465] 'applied index is now lower than readState.Index' (duration: 41.879885ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:25:08.846888Z","caller":"traceutil/trace.go:171","msg":"trace[94207169] transaction","detail":"{read_only:false; response_revision:17901; number_of_response:1; }","duration":"172.031015ms","start":"2026-10-19T02:25:08.674826Z","end":"2026-10-19T02:25:08.846857Z","steps":["trace[94207169] 'process raft request' (duration: 130.172481ms)","trace[94207169] 'compare' (duration: 41.645319ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:25:08.847101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.766937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-10-19T02:25:08.847117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.016673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-10-19T02:25:08.847173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.859312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-10-19T02:25:08.84719Z","caller":"traceutil/trace.go:171","msg":"trace[288752222] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:17901; }","duration":"162.890509ms","start":"2026-10-19T02:25:08.684278Z","end":"2026-10-19T02:25:08.847168Z","steps":["trace[288752222] 'agreement among raft nodes before linearized reading' (duration: 162.753896ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:25:08.847222Z","caller":"traceutil/trace.go:171","msg":"trace[1633789616] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17901; }","duration":"152.950295ms","start":"2026-10-19T02:25:08.694252Z","end":"2026-10-19T02:25:08.847202Z","steps":["trace[1633789616] 'agreement among raft nodes before linearized reading' (duration: 152.792491ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:25:08.847216Z","caller":"traceutil/trace.go:171","msg":"trace[967950288] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17901; }","duration":"170.160297ms","start":"2026-10-19T02:25:08.677038Z","end":"2026-10-19T02:25:08.847198Z","steps":["trace[967950288] 'agreement among raft nodes before linearized reading' (duration: 169.90161ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:25:14.178618Z","caller":"traceutil/trace.go:171","msg":"trace[1585255570] transaction","detail":"{read_only:false; response_revision:17988; number_of_response:1; }","duration":"134.255625ms","start":"2026-10-19T02:25:14.044314Z","end":"2026-10-19T02:25:14.178569Z","steps":["trace[1585255570] 'process raft request' (duration: 133.446274ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:25:14.75839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.435519ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:25:14.758621Z","caller":"traceutil/trace.go:171","msg":"trace[552229511] transaction","detail":"{read_only:false; response_revision:17990; number_of_response:1; }","duration":"250.275741ms","start":"2026-10-19T02:25:14.50833Z","end":"2026-10-19T02:25:14.758606Z","steps":["trace[552229511] 'process raft request' (duration: 250.177419ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:25:14.758586Z","caller":"traceutil/trace.go:171","msg":"trace[293816157] transaction","detail":"{read_only:false; response_revision:17989; number_of_response:1; }","duration":"435.411231ms","start":"2026-10-19T02:25:14.323112Z","end":"2026-10-19T02:25:14.758523Z","steps":["trace[293816157] 'process raft request' (duration: 233.771367ms)","trace[293816157] 'compare' (duration: 201.07573ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:25:14.758645Z","caller":"traceutil/trace.go:171","msg":"trace[581971482] linearizableReadLoop","detail":"{readStateIndex:18601; appliedIndex:18600; }","duration":"271.067875ms","start":"2026-10-19T02:25:14.487544Z","end":"2026-10-19T02:25:14.758612Z","steps":["trace[581971482] 'read index received' (duration: 69.35407ms)","trace[581971482] 'applied index is now lower than readState.Index' (duration: 201.711885ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:25:14.75878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:25:14.32309Z","time spent":"435.583116ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:25:14.758838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.27117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-zx8kv\" ","response":"range_response_count:1 size:20898"} {"level":"warn","ts":"2026-10-19T02:25:14.758849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.75748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-19T02:25:14.75889Z","caller":"traceutil/trace.go:171","msg":"trace[430654490] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-zx8kv; range_end:; response_count:1; response_revision:17990; }","duration":"271.382273ms","start":"2026-10-19T02:25:14.487494Z","end":"2026-10-19T02:25:14.758876Z","steps":["trace[430654490] 'agreement among raft nodes before linearized reading' (duration: 271.226969ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:25:14.758897Z","caller":"traceutil/trace.go:171","msg":"trace[1300852192] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:17990; }","duration":"267.840652ms","start":"2026-10-19T02:25:14.491042Z","end":"2026-10-19T02:25:14.758883Z","steps":["trace[1300852192] 'agreement among raft nodes before linearized reading' (duration: 267.7497ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:25:14.758952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.285243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-19T02:25:14.7591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.646763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-10-19T02:25:14.759023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.127251ms","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:6"} {"level":"info","ts":"2026-10-19T02:25:14.759138Z","caller":"traceutil/trace.go:171","msg":"trace[1303365556] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:17990; }","duration":"192.756366ms","start":"2026-10-19T02:25:14.56637Z","end":"2026-10-19T02:25:14.759127Z","steps":["trace[1303365556] 'agreement among raft nodes before linearized reading' (duration: 192.693765ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:25:14.75922Z","caller":"traceutil/trace.go:171","msg":"trace[2127361850] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:17990; }","duration":"233.320596ms","start":"2026-10-19T02:25:14.525822Z","end":"2026-10-19T02:25:14.759143Z","steps":["trace[2127361850] 'agreement among raft nodes before linearized reading' (duration: 233.08981ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:25:14.759284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.855091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-fh9pw\" ","response":"range_response_count:1 size:9799"} {"level":"info","ts":"2026-10-19T02:25:14.759354Z","caller":"traceutil/trace.go:171","msg":"trace[1437698688] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-fh9pw; range_end:; response_count:1; response_revision:17990; }","duration":"242.945913ms","start":"2026-10-19T02:25:14.51639Z","end":"2026-10-19T02:25:14.759336Z","steps":["trace[1437698688] 'agreement among raft nodes before linearized reading' (duration: 242.723897ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:25:14.759025Z","caller":"traceutil/trace.go:171","msg":"trace[1341202339] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17990; }","duration":"169.392965ms","start":"2026-10-19T02:25:14.589615Z","end":"2026-10-19T02:25:14.759008Z","steps":["trace[1341202339] 'agreement among raft nodes before linearized reading' (duration: 169.236491ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:25:14.76429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.444245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225402"} {"level":"info","ts":"2026-10-19T02:25:14.764372Z","caller":"traceutil/trace.go:171","msg":"trace[2322564] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:17988; }","duration":"462.598559ms","start":"2026-10-19T02:25:14.301755Z","end":"2026-10-19T02:25:14.764354Z","steps":["trace[2322564] 'range keys from in-memory index tree' (duration: 456.211145ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:25:14.764551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:25:14.301726Z","time spent":"462.675341ms","remote":"127.0.0.1:53058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":57,"response size":2225424,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-10-19T02:25:14.955837Z","caller":"traceutil/trace.go:171","msg":"trace[733470020] linearizableReadLoop","detail":"{readStateIndex:18603; appliedIndex:18602; }","duration":"143.494782ms","start":"2026-10-19T02:25:14.812317Z","end":"2026-10-19T02:25:14.955811Z","steps":["trace[733470020] 'read index received' (duration: 128.890697ms)","trace[733470020] 'applied index is now lower than readState.Index' (duration: 14.603015ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:25:14.95591Z","caller":"traceutil/trace.go:171","msg":"trace[1764789707] transaction","detail":"{read_only:false; response_revision:17991; number_of_response:1; }","duration":"173.533092ms","start":"2026-10-19T02:25:14.782349Z","end":"2026-10-19T02:25:14.955883Z","steps":["trace[1764789707] 'process raft request' (duration: 158.902076ms)","trace[1764789707] 'compare' (duration: 14.41447ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:25:14.956085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.743569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1826"} {"level":"info","ts":"2026-10-19T02:25:14.956147Z","caller":"traceutil/trace.go:171","msg":"trace[66172996] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:17991; }","duration":"143.847742ms","start":"2026-10-19T02:25:14.812281Z","end":"2026-10-19T02:25:14.956128Z","steps":["trace[66172996] 'agreement among raft nodes before linearized reading' (duration: 143.669157ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:25:14.976222Z","caller":"traceutil/trace.go:171","msg":"trace[409453166] transaction","detail":"{read_only:false; response_revision:17992; number_of_response:1; }","duration":"108.063933ms","start":"2026-10-19T02:25:14.868105Z","end":"2026-10-19T02:25:14.976169Z","steps":["trace[409453166] 'process raft request' (duration: 107.798566ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:27:53.638714Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"14f8f2dfdaccebdb","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T02:27:53.648345Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-19T02:27:53.648485Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-19T02:29:20.120461Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17571} {"level":"info","ts":"2026-10-19T02:29:20.228242Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17571,"took":"103.791111ms","hash":1996959032,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":34271232,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-19T02:29:20.228321Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1996959032,"revision":17571,"compact-revision":15397} {"level":"info","ts":"2026-10-19T02:30:38.157393Z","caller":"traceutil/trace.go:171","msg":"trace[1987581965] transaction","detail":"{read_only:false; response_revision:20493; number_of_response:1; }","duration":"121.304761ms","start":"2026-10-19T02:30:38.036064Z","end":"2026-10-19T02:30:38.157369Z","steps":["trace[1987581965] 'process raft request' (duration: 121.139487ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:38.465268Z","caller":"traceutil/trace.go:171","msg":"trace[736848500] transaction","detail":"{read_only:false; response_revision:20494; number_of_response:1; }","duration":"103.017321ms","start":"2026-10-19T02:30:38.362215Z","end":"2026-10-19T02:30:38.465233Z","steps":["trace[736848500] 'process raft request' (duration: 57.222367ms)","trace[736848500] 'compare' (duration: 45.663051ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:30:38.92713Z","caller":"traceutil/trace.go:171","msg":"trace[1049880708] transaction","detail":"{read_only:false; response_revision:20495; number_of_response:1; }","duration":"116.790414ms","start":"2026-10-19T02:30:38.810312Z","end":"2026-10-19T02:30:38.927103Z","steps":["trace[1049880708] 'process raft request' (duration: 116.594619ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:30:39.334392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.494399ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-19T02:30:39.335141Z","caller":"traceutil/trace.go:171","msg":"trace[1964795762] transaction","detail":"{read_only:false; response_revision:20497; number_of_response:1; }","duration":"207.022187ms","start":"2026-10-19T02:30:39.128098Z","end":"2026-10-19T02:30:39.335121Z","steps":["trace[1964795762] 'process raft request' (duration: 206.929545ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:39.335174Z","caller":"traceutil/trace.go:171","msg":"trace[859831677] linearizableReadLoop","detail":"{readStateIndex:21190; appliedIndex:21188; }","duration":"383.985624ms","start":"2026-10-19T02:30:38.951165Z","end":"2026-10-19T02:30:39.33515Z","steps":["trace[859831677] 'read index received' (duration: 223.712555ms)","trace[859831677] 'applied index is now lower than readState.Index' (duration: 160.270849ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:30:39.335198Z","caller":"traceutil/trace.go:171","msg":"trace[1262658313] transaction","detail":"{read_only:false; response_revision:20496; number_of_response:1; }","duration":"478.684112ms","start":"2026-10-19T02:30:38.856478Z","end":"2026-10-19T02:30:39.335162Z","steps":["trace[1262658313] 'process raft request' (duration: 478.20266ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:30:39.335351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:30:38.856424Z","time spent":"478.848276ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:30:39.335351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.153128ms","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-10-19T02:30:39.335436Z","caller":"traceutil/trace.go:171","msg":"trace[1859292963] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:20497; }","duration":"384.292571ms","start":"2026-10-19T02:30:38.951119Z","end":"2026-10-19T02:30:39.335412Z","steps":["trace[1859292963] 'agreement among raft nodes before linearized reading' (duration: 384.122077ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:30:39.335511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:30:38.951099Z","time spent":"384.396904ms","remote":"127.0.0.1:42444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":32,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true "} {"level":"warn","ts":"2026-10-19T02:30:39.33553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.232134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-10-19T02:30:39.335552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.642555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-10-19T02:30:39.335586Z","caller":"traceutil/trace.go:171","msg":"trace[815220182] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20497; }","duration":"358.351306ms","start":"2026-10-19T02:30:38.977218Z","end":"2026-10-19T02:30:39.335569Z","steps":["trace[815220182] 'agreement among raft nodes before linearized reading' (duration: 358.09241ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:39.335627Z","caller":"traceutil/trace.go:171","msg":"trace[1346169637] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20497; }","duration":"337.787819ms","start":"2026-10-19T02:30:38.997817Z","end":"2026-10-19T02:30:39.335605Z","steps":["trace[1346169637] 'agreement among raft nodes before linearized reading' (duration: 337.539373ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:30:39.335594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.413466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-10-19T02:30:39.335667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:30:38.997777Z","time spent":"337.882872ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-10-19T02:30:39.335631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:30:38.977113Z","time spent":"358.508001ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-19T02:30:39.335703Z","caller":"traceutil/trace.go:171","msg":"trace[1013661670] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20497; }","duration":"347.5713ms","start":"2026-10-19T02:30:38.988101Z","end":"2026-10-19T02:30:39.335672Z","steps":["trace[1013661670] 'agreement among raft nodes before linearized reading' (duration: 347.286223ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:30:39.335756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:30:38.988062Z","time spent":"347.681183ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-19T02:30:39.607512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.475191ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:30:39.607743Z","caller":"traceutil/trace.go:171","msg":"trace[40264781] transaction","detail":"{read_only:false; response_revision:20498; number_of_response:1; }","duration":"267.125447ms","start":"2026-10-19T02:30:39.340587Z","end":"2026-10-19T02:30:39.607712Z","steps":["trace[40264781] 'process raft request' (duration: 135.272908ms)","trace[40264781] 'compare' (duration: 131.014318ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:30:39.60804Z","caller":"traceutil/trace.go:171","msg":"trace[2105374971] transaction","detail":"{read_only:false; response_revision:20499; number_of_response:1; }","duration":"266.536974ms","start":"2026-10-19T02:30:39.341467Z","end":"2026-10-19T02:30:39.608004Z","steps":["trace[2105374971] 'process raft request' (duration: 266.188444ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:39.608116Z","caller":"traceutil/trace.go:171","msg":"trace[22965868] linearizableReadLoop","detail":"{readStateIndex:21194; appliedIndex:21191; }","duration":"240.792053ms","start":"2026-10-19T02:30:39.367311Z","end":"2026-10-19T02:30:39.608103Z","steps":["trace[22965868] 'read index received' (duration: 108.565413ms)","trace[22965868] 'applied index is now lower than readState.Index' (duration: 132.22555ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:30:39.608193Z","caller":"traceutil/trace.go:171","msg":"trace[382659700] transaction","detail":"{read_only:false; response_revision:20500; number_of_response:1; }","duration":"266.227215ms","start":"2026-10-19T02:30:39.341928Z","end":"2026-10-19T02:30:39.608156Z","steps":["trace[382659700] 'process raft request' (duration: 265.925376ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:30:39.608338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.994018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-19T02:30:39.608398Z","caller":"traceutil/trace.go:171","msg":"trace[1647045039] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20500; }","duration":"241.117371ms","start":"2026-10-19T02:30:39.367256Z","end":"2026-10-19T02:30:39.608374Z","steps":["trace[1647045039] 'agreement among raft nodes before linearized reading' (duration: 240.924536ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:39.894852Z","caller":"traceutil/trace.go:171","msg":"trace[1982725736] linearizableReadLoop","detail":"{readStateIndex:21195; appliedIndex:21194; }","duration":"257.217524ms","start":"2026-10-19T02:30:39.623214Z","end":"2026-10-19T02:30:39.880432Z","steps":["trace[1982725736] 'read index received' (duration: 229.638097ms)","trace[1982725736] 'applied index is now lower than readState.Index' (duration: 27.578117ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:30:39.895412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.491197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-19T02:30:39.895553Z","caller":"traceutil/trace.go:171","msg":"trace[714711368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20501; }","duration":"164.702162ms","start":"2026-10-19T02:30:39.730832Z","end":"2026-10-19T02:30:39.895534Z","steps":["trace[714711368] 'agreement among raft nodes before linearized reading' (duration: 164.407885ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:30:39.895839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.961124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:30:39.896612Z","caller":"traceutil/trace.go:171","msg":"trace[1038279934] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:20501; }","duration":"253.139279ms","start":"2026-10-19T02:30:39.642788Z","end":"2026-10-19T02:30:39.895928Z","steps":["trace[1038279934] 'agreement among raft nodes before linearized reading' (duration: 252.431231ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:30:39.895016Z","caller":"traceutil/trace.go:171","msg":"trace[868327063] transaction","detail":"{read_only:false; response_revision:20501; number_of_response:1; }","duration":"282.240075ms","start":"2026-10-19T02:30:39.61272Z","end":"2026-10-19T02:30:39.89496Z","steps":["trace[868327063] 'process raft request' (duration: 240.117506ms)","trace[868327063] 'compare' (duration: 27.425113ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:30:39.898485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.224625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-19T02:30:39.89864Z","caller":"traceutil/trace.go:171","msg":"trace[1939141311] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20501; }","duration":"275.432771ms","start":"2026-10-19T02:30:39.623154Z","end":"2026-10-19T02:30:39.898586Z","steps":["trace[1939141311] 'agreement among raft nodes before linearized reading' (duration: 257.537012ms)","trace[1939141311] 'range keys from in-memory index tree' (duration: 14.784499ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:34:20.131886Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20034} {"level":"info","ts":"2026-10-19T02:34:20.387709Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20034,"took":"251.407498ms","hash":3273865732,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":32219136,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-19T02:34:20.387774Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3273865732,"revision":20034,"compact-revision":17571} {"level":"info","ts":"2026-10-19T02:34:30.711435Z","caller":"traceutil/trace.go:171","msg":"trace[171274921] transaction","detail":"{read_only:false; response_revision:22888; number_of_response:1; }","duration":"102.800007ms","start":"2026-10-19T02:34:30.608601Z","end":"2026-10-19T02:34:30.711401Z","steps":["trace[171274921] 'process raft request' (duration: 102.615053ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:34:31.013972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.686019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-19T02:34:31.014055Z","caller":"traceutil/trace.go:171","msg":"trace[491761713] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22888; }","duration":"163.948646ms","start":"2026-10-19T02:34:30.850088Z","end":"2026-10-19T02:34:31.014037Z","steps":["trace[491761713] 'range keys from in-memory index tree' (duration: 163.039492ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:37:48.327855Z","caller":"traceutil/trace.go:171","msg":"trace[230751752] transaction","detail":"{read_only:false; response_revision:24872; number_of_response:1; }","duration":"132.420436ms","start":"2026-10-19T02:37:48.195401Z","end":"2026-10-19T02:37:48.327821Z","steps":["trace[230751752] 'process raft request' (duration: 130.570049ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:37:48.328109Z","caller":"traceutil/trace.go:171","msg":"trace[324143124] linearizableReadLoop","detail":"{readStateIndex:25688; appliedIndex:25686; }","duration":"122.536102ms","start":"2026-10-19T02:37:48.20553Z","end":"2026-10-19T02:37:48.328066Z","steps":["trace[324143124] 'read index received' (duration: 120.441889ms)","trace[324143124] 'applied index is now lower than readState.Index' (duration: 2.093293ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:37:48.328288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.741807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-19T02:37:48.328329Z","caller":"traceutil/trace.go:171","msg":"trace[908114908] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24874; }","duration":"122.789968ms","start":"2026-10-19T02:37:48.205524Z","end":"2026-10-19T02:37:48.328314Z","steps":["trace[908114908] 'agreement among raft nodes before linearized reading' (duration: 122.652045ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:37:48.328405Z","caller":"traceutil/trace.go:171","msg":"trace[1343300713] transaction","detail":"{read_only:false; response_revision:24873; number_of_response:1; }","duration":"131.40645ms","start":"2026-10-19T02:37:48.196747Z","end":"2026-10-19T02:37:48.328153Z","steps":["trace[1343300713] 'process raft request' (duration: 131.01773ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:37:54.032941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.05589ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-19T02:37:54.033311Z","caller":"traceutil/trace.go:171","msg":"trace[1430924177] transaction","detail":"{read_only:false; response_revision:24919; number_of_response:1; }","duration":"166.230813ms","start":"2026-10-19T02:37:53.867059Z","end":"2026-10-19T02:37:54.03329Z","steps":["trace[1430924177] 'process raft request' (duration: 166.043968ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:37:54.033535Z","caller":"traceutil/trace.go:171","msg":"trace[1927358104] transaction","detail":"{read_only:false; response_revision:24918; number_of_response:1; }","duration":"296.205297ms","start":"2026-10-19T02:37:53.737277Z","end":"2026-10-19T02:37:54.033482Z","steps":["trace[1927358104] 'process raft request' (duration: 143.50197ms)","trace[1927358104] 'compare' (duration: 151.538767ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:37:54.399559Z","caller":"traceutil/trace.go:171","msg":"trace[996256289] linearizableReadLoop","detail":"{readStateIndex:25737; appliedIndex:25736; }","duration":"362.61741ms","start":"2026-10-19T02:37:54.036902Z","end":"2026-10-19T02:37:54.399519Z","steps":["trace[996256289] 'read index received' (duration: 326.666618ms)","trace[996256289] 'applied index is now lower than readState.Index' (duration: 35.948992ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:37:54.39976Z","caller":"traceutil/trace.go:171","msg":"trace[463973359] transaction","detail":"{read_only:false; response_revision:24920; number_of_response:1; }","duration":"365.408922ms","start":"2026-10-19T02:37:54.034328Z","end":"2026-10-19T02:37:54.399736Z","steps":["trace[463973359] 'process raft request' (duration: 329.223414ms)","trace[463973359] 'compare' (duration: 35.671505ms)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:37:54.399932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:37:54.034278Z","time spent":"365.524855ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:37:54.399972Z","caller":"traceutil/trace.go:171","msg":"trace[1103619695] transaction","detail":"{read_only:false; response_revision:24921; number_of_response:1; }","duration":"327.5179ms","start":"2026-10-19T02:37:54.072415Z","end":"2026-10-19T02:37:54.399932Z","steps":["trace[1103619695] 'process raft request' (duration: 327.036998ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:37:54.400208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:37:54.072378Z","time spent":"327.720705ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:37:54.40026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.339709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-10-19T02:37:54.400334Z","caller":"traceutil/trace.go:171","msg":"trace[918735376] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:24921; }","duration":"363.455082ms","start":"2026-10-19T02:37:54.03686Z","end":"2026-10-19T02:37:54.400316Z","steps":["trace[918735376] 'agreement among raft nodes before linearized reading' (duration: 363.243046ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:37:54.400394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:37:54.036841Z","time spent":"363.545573ms","remote":"127.0.0.1:53114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-10-19T02:37:54.400541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.296283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"warn","ts":"2026-10-19T02:37:54.400551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.896226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-10-19T02:37:54.400613Z","caller":"traceutil/trace.go:171","msg":"trace[1600535332] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24922; }","duration":"116.412556ms","start":"2026-10-19T02:37:54.284179Z","end":"2026-10-19T02:37:54.400591Z","steps":["trace[1600535332] 'agreement among raft nodes before linearized reading' (duration: 116.224831ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:37:54.400626Z","caller":"traceutil/trace.go:171","msg":"trace[1127235191] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24922; }","duration":"221.039199ms","start":"2026-10-19T02:37:54.179569Z","end":"2026-10-19T02:37:54.400608Z","steps":["trace[1127235191] 'agreement among raft nodes before linearized reading' (duration: 220.776572ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:37:54.40071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.032028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:37:54.400789Z","caller":"traceutil/trace.go:171","msg":"trace[755305290] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:24922; }","duration":"212.142821ms","start":"2026-10-19T02:37:54.188619Z","end":"2026-10-19T02:37:54.400762Z","steps":["trace[755305290] 'agreement among raft nodes before linearized reading' (duration: 212.018918ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:38:49.031335Z","caller":"traceutil/trace.go:171","msg":"trace[1208346500] transaction","detail":"{read_only:false; response_revision:25427; number_of_response:1; }","duration":"149.211856ms","start":"2026-10-19T02:38:48.882095Z","end":"2026-10-19T02:38:49.031307Z","steps":["trace[1208346500] 'process raft request' (duration: 149.058252ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:38:49.069122Z","caller":"traceutil/trace.go:171","msg":"trace[1532783427] transaction","detail":"{read_only:false; response_revision:25428; number_of_response:1; }","duration":"140.061682ms","start":"2026-10-19T02:38:48.929034Z","end":"2026-10-19T02:38:49.069095Z","steps":["trace[1532783427] 'process raft request' (duration: 139.61534ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:38:54.893126Z","caller":"traceutil/trace.go:171","msg":"trace[1221724901] transaction","detail":"{read_only:false; response_revision:25464; number_of_response:1; }","duration":"312.987997ms","start":"2026-10-19T02:38:54.580107Z","end":"2026-10-19T02:38:54.893095Z","steps":["trace[1221724901] 'process raft request' (duration: 312.821873ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:38:54.893306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:38:54.580075Z","time spent":"313.148162ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:38:54.913029Z","caller":"traceutil/trace.go:171","msg":"trace[22814358] transaction","detail":"{read_only:false; response_revision:25466; number_of_response:1; }","duration":"245.512107ms","start":"2026-10-19T02:38:54.667497Z","end":"2026-10-19T02:38:54.913009Z","steps":["trace[22814358] 'process raft request' (duration: 245.439525ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:38:54.913058Z","caller":"traceutil/trace.go:171","msg":"trace[911028710] transaction","detail":"{read_only:false; response_revision:25465; number_of_response:1; }","duration":"266.417393ms","start":"2026-10-19T02:38:54.646607Z","end":"2026-10-19T02:38:54.913025Z","steps":["trace[911028710] 'process raft request' (duration: 266.159566ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:38:54.913192Z","caller":"traceutil/trace.go:171","msg":"trace[786698062] linearizableReadLoop","detail":"{readStateIndex:26296; appliedIndex:26292; }","duration":"101.924633ms","start":"2026-10-19T02:38:54.811256Z","end":"2026-10-19T02:38:54.913181Z","steps":["trace[786698062] 'read index received' (duration: 81.785297ms)","trace[786698062] 'applied index is now lower than readState.Index' (duration: 20.138446ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:38:54.913314Z","caller":"traceutil/trace.go:171","msg":"trace[1526066754] transaction","detail":"{read_only:false; response_revision:25467; number_of_response:1; }","duration":"244.729786ms","start":"2026-10-19T02:38:54.668564Z","end":"2026-10-19T02:38:54.913294Z","steps":["trace[1526066754] 'process raft request' (duration: 244.413118ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:38:54.913477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.20798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-19T02:38:54.913508Z","caller":"traceutil/trace.go:171","msg":"trace[1744744297] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25467; }","duration":"102.252672ms","start":"2026-10-19T02:38:54.811246Z","end":"2026-10-19T02:38:54.913499Z","steps":["trace[1744744297] 'agreement among raft nodes before linearized reading' (duration: 102.144599ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:38:55.137485Z","caller":"traceutil/trace.go:171","msg":"trace[1284497405] transaction","detail":"{read_only:false; response_revision:25468; number_of_response:1; }","duration":"217.349495ms","start":"2026-10-19T02:38:54.920101Z","end":"2026-10-19T02:38:55.137451Z","steps":["trace[1284497405] 'process raft request' (duration: 150.962252ms)","trace[1284497405] 'compare' (duration: 66.045104ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:38:55.389795Z","caller":"traceutil/trace.go:171","msg":"trace[2058732451] transaction","detail":"{read_only:false; response_revision:25469; number_of_response:1; }","duration":"469.295105ms","start":"2026-10-19T02:38:54.920474Z","end":"2026-10-19T02:38:55.389769Z","steps":["trace[2058732451] 'process raft request' (duration: 469.009508ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:38:55.389982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:38:54.920458Z","time spent":"469.408928ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:38:55.38996Z","caller":"traceutil/trace.go:171","msg":"trace[1796303339] transaction","detail":"{read_only:false; response_revision:25470; number_of_response:1; }","duration":"469.334626ms","start":"2026-10-19T02:38:54.920543Z","end":"2026-10-19T02:38:55.389877Z","steps":["trace[1796303339] 'process raft request' (duration: 469.10881ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:38:55.390201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:38:54.920535Z","time spent":"469.533731ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:38:55.39052Z","caller":"traceutil/trace.go:171","msg":"trace[1768554810] transaction","detail":"{read_only:false; response_revision:25471; number_of_response:1; }","duration":"469.86912ms","start":"2026-10-19T02:38:54.920607Z","end":"2026-10-19T02:38:55.390477Z","steps":["trace[1768554810] 'process raft request' (duration: 469.121771ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:38:55.390681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.607183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:38:55.390723Z","caller":"traceutil/trace.go:171","msg":"trace[612990839] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:25472; }","duration":"439.697836ms","start":"2026-10-19T02:38:54.951014Z","end":"2026-10-19T02:38:55.390711Z","steps":["trace[612990839] 'agreement among raft nodes before linearized reading' (duration: 439.605443ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:38:55.390754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:38:54.950989Z","time spent":"439.755737ms","remote":"127.0.0.1:43582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-10-19T02:38:55.390759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:38:54.9206Z","time spent":"470.043744ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:38:55.390835Z","caller":"traceutil/trace.go:171","msg":"trace[472557688] transaction","detail":"{read_only:false; response_revision:25472; number_of_response:1; }","duration":"470.163098ms","start":"2026-10-19T02:38:54.920654Z","end":"2026-10-19T02:38:55.390817Z","steps":["trace[472557688] 'process raft request' (duration: 469.664145ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:38:55.390972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:38:54.920647Z","time spent":"470.270661ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-19T02:38:55.390585Z","caller":"traceutil/trace.go:171","msg":"trace[497102350] linearizableReadLoop","detail":"{readStateIndex:26301; appliedIndex:26296; }","duration":"439.498291ms","start":"2026-10-19T02:38:54.95107Z","end":"2026-10-19T02:38:55.390568Z","steps":["trace[497102350] 'read index received' (duration: 119.999967ms)","trace[497102350] 'applied index is now lower than readState.Index' (duration: 319.497344ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:38:55.508293Z","caller":"traceutil/trace.go:171","msg":"trace[1195030932] transaction","detail":"{read_only:false; response_revision:25473; number_of_response:1; }","duration":"416.915271ms","start":"2026-10-19T02:38:55.091344Z","end":"2026-10-19T02:38:55.508259Z","steps":["trace[1195030932] 'process raft request' (duration: 416.646744ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:38:55.508686Z","caller":"traceutil/trace.go:171","msg":"trace[1460637522] transaction","detail":"{read_only:false; response_revision:25474; number_of_response:1; }","duration":"312.651268ms","start":"2026-10-19T02:38:55.196014Z","end":"2026-10-19T02:38:55.508666Z","steps":["trace[1460637522] 'process raft request' (duration: 312.188576ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:38:55.508707Z","caller":"traceutil/trace.go:171","msg":"trace[1632491231] linearizableReadLoop","detail":"{readStateIndex:26304; appliedIndex:26301; }","duration":"117.570465ms","start":"2026-10-19T02:38:55.391105Z","end":"2026-10-19T02:38:55.508676Z","steps":["trace[1632491231] 'read index received' (duration: 116.810474ms)","trace[1632491231] 'applied index is now lower than readState.Index' (duration: 758.561µs)"],"step_count":2} {"level":"warn","ts":"2026-10-19T02:38:55.508792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:38:55.195988Z","time spent":"312.747291ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:38:55.508808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:38:55.091318Z","time spent":"417.073916ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-19T02:38:55.508908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.351099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/volumes/\" range_end:\"/registry/openstack.k-orc.cloud/volumes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:38:55.508958Z","caller":"traceutil/trace.go:171","msg":"trace[1834096149] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/volumes/; range_end:/registry/openstack.k-orc.cloud/volumes0; response_count:0; response_revision:25475; }","duration":"533.494622ms","start":"2026-10-19T02:38:54.975445Z","end":"2026-10-19T02:38:55.50894Z","steps":["trace[1834096149] 'agreement among raft nodes before linearized reading' (duration: 533.350729ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:38:55.509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:38:54.975421Z","time spent":"533.568325ms","remote":"127.0.0.1:33772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/openstack.k-orc.cloud/volumes/\" range_end:\"/registry/openstack.k-orc.cloud/volumes0\" count_only:true "} {"level":"warn","ts":"2026-10-19T02:38:55.509094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.223581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-19T02:38:55.509143Z","caller":"traceutil/trace.go:171","msg":"trace[1865603981] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25475; }","duration":"449.310373ms","start":"2026-10-19T02:38:55.059819Z","end":"2026-10-19T02:38:55.509129Z","steps":["trace[1865603981] 'agreement among raft nodes before linearized reading' (duration: 449.141519ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:38:55.509181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:38:55.059797Z","time spent":"449.376225ms","remote":"127.0.0.1:37072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-10-19T02:38:55.509356Z","caller":"traceutil/trace.go:171","msg":"trace[824364557] transaction","detail":"{read_only:false; response_revision:25475; number_of_response:1; }","duration":"176.344623ms","start":"2026-10-19T02:38:55.332968Z","end":"2026-10-19T02:38:55.509313Z","steps":["trace[824364557] 'process raft request' (duration: 175.532662ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:38:55.509361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.339038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-19T02:38:55.509521Z","caller":"traceutil/trace.go:171","msg":"trace[19467510] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:25475; }","duration":"494.558894ms","start":"2026-10-19T02:38:55.014949Z","end":"2026-10-19T02:38:55.509508Z","steps":["trace[19467510] 'agreement among raft nodes before linearized reading' (duration: 494.306987ms)"],"step_count":1} {"level":"warn","ts":"2026-10-19T02:38:55.509562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-19T02:38:55.014929Z","time spent":"494.618926ms","remote":"127.0.0.1:33632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true "} {"level":"warn","ts":"2026-10-19T02:38:55.510119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.799135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-10-19T02:38:55.510199Z","caller":"traceutil/trace.go:171","msg":"trace[352030745] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:25475; }","duration":"123.918808ms","start":"2026-10-19T02:38:55.386269Z","end":"2026-10-19T02:38:55.510188Z","steps":["trace[352030745] 'agreement among raft nodes before linearized reading' (duration: 122.665006ms)"],"step_count":1} {"level":"info","ts":"2026-10-19T02:39:20.142526Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22358} {"level":"info","ts":"2026-10-19T02:39:20.264163Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22358,"took":"117.082062ms","hash":2807700712,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":44765184,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-10-19T02:39:20.264266Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2807700712,"revision":22358,"compact-revision":20034} {"level":"info","ts":"2026-10-19T02:39:33.431006Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000686f.wal"} {"level":"info","ts":"2026-10-19T02:43:13.077526Z","caller":"traceutil/trace.go:171","msg":"trace[819742035] transaction","detail":"{read_only:false; response_revision:28013; number_of_response:1; }","duration":"119.502861ms","start":"2026-10-19T02:43:12.957996Z","end":"2026-10-19T02:43:13.077499Z","steps":["trace[819742035] 'process raft request' (duration: 91.33538ms)","trace[819742035] 'compare' (duration: 27.655268ms)"],"step_count":2} {"level":"info","ts":"2026-10-19T02:44:20.155408Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25652} {"level":"info","ts":"2026-10-19T02:44:20.369118Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25652,"took":"209.263579ms","hash":3473405766,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":35639296,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-19T02:44:20.369235Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3473405766,"revision":25652,"compact-revision":22358} {"level":"info","ts":"2026-10-19T02:45:31.962822Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"14f8f2dfdaccebdb","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T02:45:31.969368Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-19T02:45:31.969482Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-19T02:49:20.162515Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28514} {"level":"info","ts":"2026-10-19T02:49:20.328352Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28514,"took":"161.541186ms","hash":2002818393,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":30674944,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-19T02:49:20.328414Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2002818393,"revision":28514,"compact-revision":25652} {"level":"info","ts":"2026-10-19T02:54:20.174619Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30735} {"level":"info","ts":"2026-10-19T02:54:20.291586Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30735,"took":"113.401934ms","hash":3395603146,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":31100928,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-19T02:54:20.291631Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3395603146,"revision":30735,"compact-revision":28514} {"level":"info","ts":"2026-10-19T02:59:20.185563Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32996} {"level":"info","ts":"2026-10-19T02:59:20.38471Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32996,"took":"194.631997ms","hash":457608,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":30838784,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-19T02:59:20.384789Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":457608,"revision":32996,"compact-revision":30735} {"level":"info","ts":"2026-10-19T03:04:20.193025Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35284} {"level":"info","ts":"2026-10-19T03:04:20.343781Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35284,"took":"145.156749ms","hash":1988272840,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":33390592,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-19T03:04:20.343897Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1988272840,"revision":35284,"compact-revision":32996} {"level":"info","ts":"2026-10-19T03:06:50.460104Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"14f8f2dfdaccebdb","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-19T03:06:50.466933Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-19T03:06:50.467023Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-19T03:09:20.201302Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37579} {"level":"info","ts":"2026-10-19T03:09:20.344971Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37579,"took":"139.468745ms","hash":2236903179,"current-db-size-bytes":57044992,"current-db-size":"57 MB","current-db-size-in-use-bytes":32210944,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-19T03:09:20.345091Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2236903179,"revision":37579,"compact-revision":35284}