{"level":"warn","ts":"2026-09-01T03:58:37.417771Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T03:58:37.417856Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.109: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.109:2380","--initial-cluster=instance=https://162.253.55.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.109:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-01T03:58:37.418132Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T03:58:37.418146Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.109:2380"]} {"level":"info","ts":"2026-09-01T03:58:37.418165Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-01T03:58:37.419018Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.109:2379"]} {"level":"info","ts":"2026-09-01T03:58:37.419153Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.109:2380"],"listen-peer-urls":["https://162.253.55.109:2380"],"advertise-client-urls":["https://162.253.55.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.109:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-01T03:58:37.42308Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.646272ms"} {"level":"info","ts":"2026-09-01T03:58:37.432258Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1ee91cef4f0023c4","cluster-id":"8dccb05df97999f"} {"level":"info","ts":"2026-09-01T03:58:37.43232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 switched to configuration voters=()"} {"level":"info","ts":"2026-09-01T03:58:37.432364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 became follower at term 0"} {"level":"info","ts":"2026-09-01T03:58:37.432372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1ee91cef4f0023c4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-01T03:58:37.432378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 became follower at term 1"} {"level":"info","ts":"2026-09-01T03:58:37.432408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 switched to configuration voters=(2227343304859591620)"} {"level":"warn","ts":"2026-09-01T03:58:37.440788Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-01T03:58:37.441967Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-01T03:58:37.443464Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-01T03:58:37.445287Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1ee91cef4f0023c4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-01T03:58:37.445441Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1ee91cef4f0023c4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-01T03:58:37.445544Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T03:58:37.445671Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T03:58:37.44568Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-01T03:58:37.446769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 switched to configuration voters=(2227343304859591620)"} {"level":"info","ts":"2026-09-01T03:58:37.451055Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8dccb05df97999f","local-member-id":"1ee91cef4f0023c4","added-peer-id":"1ee91cef4f0023c4","added-peer-peer-urls":["https://162.253.55.109:2380"]} {"level":"info","ts":"2026-09-01T03:58:37.452151Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-01T03:58:37.452298Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.109:2380"} {"level":"info","ts":"2026-09-01T03:58:37.45234Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.109:2380"} {"level":"info","ts":"2026-09-01T03:58:37.452465Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1ee91cef4f0023c4","initial-advertise-peer-urls":["https://162.253.55.109:2380"],"listen-peer-urls":["https://162.253.55.109:2380"],"advertise-client-urls":["https://162.253.55.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-01T03:58:37.452497Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-01T03:58:38.034797Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 is starting a new election at term 1"} {"level":"info","ts":"2026-09-01T03:58:38.034863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-01T03:58:38.034926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 received MsgPreVoteResp from 1ee91cef4f0023c4 at term 1"} {"level":"info","ts":"2026-09-01T03:58:38.034984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 became candidate at term 2"} {"level":"info","ts":"2026-09-01T03:58:38.034999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 received MsgVoteResp from 1ee91cef4f0023c4 at term 2"} {"level":"info","ts":"2026-09-01T03:58:38.035014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee91cef4f0023c4 became leader at term 2"} {"level":"info","ts":"2026-09-01T03:58:38.035051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1ee91cef4f0023c4 elected leader 1ee91cef4f0023c4 at term 2"} {"level":"info","ts":"2026-09-01T03:58:38.039067Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T03:58:38.042204Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1ee91cef4f0023c4","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.109:2379]}","request-path":"/0/members/1ee91cef4f0023c4/attributes","cluster-id":"8dccb05df97999f","publish-timeout":"7s"} {"level":"info","ts":"2026-09-01T03:58:38.042228Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T03:58:38.042359Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-01T03:58:38.042422Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-01T03:58:38.042893Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T03:58:38.043694Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8dccb05df97999f","local-member-id":"1ee91cef4f0023c4","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T03:58:38.043834Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T03:58:38.043932Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T03:58:38.044122Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.109:2379"} {"level":"info","ts":"2026-09-01T03:58:38.044711Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-01T03:59:25.591667Z","caller":"traceutil/trace.go:171","msg":"trace[272363471] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"199.633316ms","start":"2026-09-01T03:59:25.392004Z","end":"2026-09-01T03:59:25.591637Z","steps":["trace[272363471] 'process raft request' (duration: 199.490268ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:59:28.553695Z","caller":"traceutil/trace.go:171","msg":"trace[1832944371] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"103.127333ms","start":"2026-09-01T03:59:28.45054Z","end":"2026-09-01T03:59:28.553668Z","steps":["trace[1832944371] 'process raft request' (duration: 102.554412ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:59:29.683614Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2577361199976119662,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-01T03:59:29.843959Z","caller":"traceutil/trace.go:171","msg":"trace[1748552896] linearizableReadLoop","detail":"{readStateIndex:680; appliedIndex:679; }","duration":"661.126332ms","start":"2026-09-01T03:59:29.182804Z","end":"2026-09-01T03:59:29.843931Z","steps":["trace[1748552896] 'read index received' (duration: 660.348348ms)","trace[1748552896] 'applied index is now lower than readState.Index' (duration: 777.114µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T03:59:29.844053Z","caller":"traceutil/trace.go:171","msg":"trace[1910994477] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"730.464532ms","start":"2026-09-01T03:59:29.113558Z","end":"2026-09-01T03:59:29.844023Z","steps":["trace[1910994477] 'process raft request' (duration: 729.866798ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:59:29.844195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.360965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-djrtd\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-01T03:59:29.844351Z","caller":"traceutil/trace.go:171","msg":"trace[2079238164] range","detail":"{range_begin:/registry/pods/kube-system/cilium-djrtd; range_end:; response_count:1; response_revision:651; }","duration":"661.565716ms","start":"2026-09-01T03:59:29.182765Z","end":"2026-09-01T03:59:29.844331Z","steps":["trace[2079238164] 'agreement among raft nodes before linearized reading' (duration: 661.288781ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:59:29.844345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.397172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T03:59:29.844401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:59:29.182748Z","time spent":"661.63847ms","remote":"127.0.0.1:38942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-djrtd\" "} {"level":"warn","ts":"2026-09-01T03:59:29.844431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.61714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-01T03:59:29.844459Z","caller":"traceutil/trace.go:171","msg":"trace[1002635394] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:651; }","duration":"110.509808ms","start":"2026-09-01T03:59:29.733907Z","end":"2026-09-01T03:59:29.844417Z","steps":["trace[1002635394] 'agreement among raft nodes before linearized reading' (duration: 110.313417ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T03:59:29.844508Z","caller":"traceutil/trace.go:171","msg":"trace[800226225] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:651; }","duration":"101.738857ms","start":"2026-09-01T03:59:29.742744Z","end":"2026-09-01T03:59:29.844483Z","steps":["trace[800226225] 'agreement among raft nodes before linearized reading' (duration: 101.485323ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:59:29.844664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T03:59:29.11353Z","time spent":"730.575468ms","remote":"127.0.0.1:38846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T03:59:51.824542Z","caller":"traceutil/trace.go:171","msg":"trace[1728808872] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"226.861682ms","start":"2026-09-01T03:59:51.597643Z","end":"2026-09-01T03:59:51.824505Z","steps":["trace[1728808872] 'process raft request' (duration: 226.391192ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:59:52.169609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.404987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-01T03:59:52.169698Z","caller":"traceutil/trace.go:171","msg":"trace[1539705444] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:839; }","duration":"187.555677ms","start":"2026-09-01T03:59:51.98212Z","end":"2026-09-01T03:59:52.169676Z","steps":["trace[1539705444] 'range keys from in-memory index tree' (duration: 187.217355ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:59:52.170115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.835261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-01T03:59:52.170996Z","caller":"traceutil/trace.go:171","msg":"trace[1584200951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:839; }","duration":"125.2019ms","start":"2026-09-01T03:59:52.04576Z","end":"2026-09-01T03:59:52.170962Z","steps":["trace[1584200951] 'range keys from in-memory index tree' (duration: 123.588925ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T03:59:52.170166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.200017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-01T03:59:52.171162Z","caller":"traceutil/trace.go:171","msg":"trace[901114221] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:839; }","duration":"171.225934ms","start":"2026-09-01T03:59:51.999874Z","end":"2026-09-01T03:59:52.171099Z","steps":["trace[901114221] 'range keys from in-memory index tree' (duration: 169.404715ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:00:25.880807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.970381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:00:25.880909Z","caller":"traceutil/trace.go:171","msg":"trace[1519641053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1258; }","duration":"145.130843ms","start":"2026-09-01T04:00:25.735758Z","end":"2026-09-01T04:00:25.880889Z","steps":["trace[1519641053] 'range keys from in-memory index tree' (duration: 144.881655ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:01:16.198292Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2577361199976122235,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-01T04:01:16.273761Z","caller":"traceutil/trace.go:171","msg":"trace[2065087474] transaction","detail":"{read_only:false; response_revision:1937; number_of_response:1; }","duration":"578.813399ms","start":"2026-09-01T04:01:15.694906Z","end":"2026-09-01T04:01:16.273719Z","steps":["trace[2065087474] 'process raft request' (duration: 578.542157ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:01:16.274013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:01:15.694844Z","time spent":"579.032707ms","remote":"127.0.0.1:38942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10967,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:01:16.332374Z","caller":"traceutil/trace.go:171","msg":"trace[2032278009] transaction","detail":"{read_only:false; response_revision:1938; number_of_response:1; }","duration":"622.028744ms","start":"2026-09-01T04:01:15.710303Z","end":"2026-09-01T04:01:16.332332Z","steps":["trace[2032278009] 'process raft request' (duration: 621.691886ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:01:16.33238Z","caller":"traceutil/trace.go:171","msg":"trace[1716563756] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"596.033262ms","start":"2026-09-01T04:01:15.736321Z","end":"2026-09-01T04:01:16.332355Z","steps":["trace[1716563756] 'process raft request' (duration: 595.861117ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:01:16.332707Z","caller":"traceutil/trace.go:171","msg":"trace[320643969] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"172.483825ms","start":"2026-09-01T04:01:16.160126Z","end":"2026-09-01T04:01:16.33261Z","steps":["trace[320643969] 'process raft request' (duration: 172.146488ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:01:16.332793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:01:15.736291Z","time spent":"596.371309ms","remote":"127.0.0.1:39028","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-09-01T04:01:16.33298Z","caller":"traceutil/trace.go:171","msg":"trace[1204827427] linearizableReadLoop","detail":"{readStateIndex:2024; appliedIndex:2020; }","duration":"634.636437ms","start":"2026-09-01T04:01:15.697958Z","end":"2026-09-01T04:01:16.332594Z","steps":["trace[1204827427] 'read index received' (duration: 575.218505ms)","trace[1204827427] 'applied index is now lower than readState.Index' (duration: 59.416192ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:01:16.333095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.128456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-01T04:01:16.333034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:01:15.710286Z","time spent":"622.195827ms","remote":"127.0.0.1:39028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:01:16.333323Z","caller":"traceutil/trace.go:171","msg":"trace[891139588] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1940; }","duration":"635.311902ms","start":"2026-09-01T04:01:15.697914Z","end":"2026-09-01T04:01:16.333226Z","steps":["trace[891139588] 'agreement among raft nodes before linearized reading' (duration: 635.127137ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:01:16.333368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:01:15.697895Z","time spent":"635.462124ms","remote":"127.0.0.1:39226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":29,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-09-01T04:01:16.678527Z","caller":"traceutil/trace.go:171","msg":"trace[500329886] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"396.770513ms","start":"2026-09-01T04:01:16.281706Z","end":"2026-09-01T04:01:16.678477Z","steps":["trace[500329886] 'process raft request' (duration: 341.02074ms)","trace[500329886] 'compare' (duration: 55.566149ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:01:16.678765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:01:16.281667Z","time spent":"396.959519ms","remote":"127.0.0.1:39042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:01:16.678558Z","caller":"traceutil/trace.go:171","msg":"trace[1974821389] transaction","detail":"{read_only:false; response_revision:1943; number_of_response:1; }","duration":"395.157272ms","start":"2026-09-01T04:01:16.283377Z","end":"2026-09-01T04:01:16.678534Z","steps":["trace[1974821389] 'process raft request' (duration: 395.092707ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:01:16.679018Z","caller":"traceutil/trace.go:171","msg":"trace[269522931] transaction","detail":"{read_only:false; response_revision:1944; number_of_response:1; }","duration":"395.393341ms","start":"2026-09-01T04:01:16.283538Z","end":"2026-09-01T04:01:16.678931Z","steps":["trace[269522931] 'process raft request' (duration: 394.961086ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:01:16.679005Z","caller":"traceutil/trace.go:171","msg":"trace[911197079] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"392.953214ms","start":"2026-09-01T04:01:16.286012Z","end":"2026-09-01T04:01:16.678965Z","steps":["trace[911197079] 'process raft request' (duration: 392.744557ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:01:16.679116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:01:16.283366Z","time spent":"395.50698ms","remote":"127.0.0.1:38926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:01:16.67915Z","caller":"traceutil/trace.go:171","msg":"trace[126647514] linearizableReadLoop","detail":"{readStateIndex:2029; appliedIndex:2024; }","duration":"345.94517ms","start":"2026-09-01T04:01:16.333189Z","end":"2026-09-01T04:01:16.679135Z","steps":["trace[126647514] 'read index received' (duration: 289.4909ms)","trace[126647514] 'applied index is now lower than readState.Index' (duration: 56.45242ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:01:16.679224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:01:16.286Z","time spent":"393.107646ms","remote":"127.0.0.1:39028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:01:16.679248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:01:16.283513Z","time spent":"395.534622ms","remote":"127.0.0.1:39042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:01:16.678559Z","caller":"traceutil/trace.go:171","msg":"trace[878364364] transaction","detail":"{read_only:false; response_revision:1942; number_of_response:1; }","duration":"396.512952ms","start":"2026-09-01T04:01:16.282022Z","end":"2026-09-01T04:01:16.678535Z","steps":["trace[878364364] 'process raft request' (duration: 396.396773ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:01:16.6794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:01:16.281996Z","time spent":"397.363581ms","remote":"127.0.0.1:38926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:01:16.695649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"962.00892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:01:16.695734Z","caller":"traceutil/trace.go:171","msg":"trace[528369499] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1945; }","duration":"962.13162ms","start":"2026-09-01T04:01:15.733586Z","end":"2026-09-01T04:01:16.695718Z","steps":["trace[528369499] 'agreement among raft nodes before linearized reading' (duration: 945.726206ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:01:16.695689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"831.284353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-09-01T04:01:16.695772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:01:15.733573Z","time spent":"962.190824ms","remote":"127.0.0.1:38744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-01T04:01:16.695809Z","caller":"traceutil/trace.go:171","msg":"trace[1170688957] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1945; }","duration":"831.466057ms","start":"2026-09-01T04:01:15.864317Z","end":"2026-09-01T04:01:16.695783Z","steps":["trace[1170688957] 'agreement among raft nodes before linearized reading' (duration: 814.961995ms)","trace[1170688957] 'range keys from in-memory index tree' (duration: 16.23606ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:01:16.695859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:01:15.864294Z","time spent":"831.556924ms","remote":"127.0.0.1:58988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-01T04:01:16.696167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.992654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-09-01T04:01:16.696355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.496369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-11c5163f-b73d-46c1-8079-523e4331675c\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-09-01T04:01:16.696183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.970242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-11c5163f-b73d-46c1-8079-523e4331675c\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-01T04:01:16.69669Z","caller":"traceutil/trace.go:171","msg":"trace[964919156] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-11c5163f-b73d-46c1-8079-523e4331675c; range_end:; response_count:1; response_revision:1945; }","duration":"415.681811ms","start":"2026-09-01T04:01:16.280992Z","end":"2026-09-01T04:01:16.696674Z","steps":["trace[964919156] 'agreement among raft nodes before linearized reading' (duration: 398.243683ms)","trace[964919156] 'range keys from in-memory index tree' (duration: 16.701447ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:01:16.696834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:01:16.280969Z","time spent":"415.849324ms","remote":"127.0.0.1:38942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-11c5163f-b73d-46c1-8079-523e4331675c\" "} {"level":"info","ts":"2026-09-01T04:01:16.696287Z","caller":"traceutil/trace.go:171","msg":"trace[565223170] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1945; }","duration":"613.135935ms","start":"2026-09-01T04:01:16.083124Z","end":"2026-09-01T04:01:16.69626Z","steps":["trace[565223170] 'agreement among raft nodes before linearized reading' (duration: 596.133803ms)","trace[565223170] 'range keys from in-memory index tree' (duration: 16.822537ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:01:16.697131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:01:16.083102Z","time spent":"613.895638ms","remote":"127.0.0.1:58988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-01T04:01:16.697777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"914.924965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-01T04:01:16.69794Z","caller":"traceutil/trace.go:171","msg":"trace[770906206] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1945; }","duration":"917.243034ms","start":"2026-09-01T04:01:15.780677Z","end":"2026-09-01T04:01:16.69792Z","steps":["trace[770906206] 'agreement among raft nodes before linearized reading' (duration: 898.62413ms)","trace[770906206] 'range keys from in-memory index tree' (duration: 16.241321ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:01:16.699274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:01:15.780627Z","time spent":"918.624607ms","remote":"127.0.0.1:39028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-01T04:01:16.701185Z","caller":"traceutil/trace.go:171","msg":"trace[289690223] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-11c5163f-b73d-46c1-8079-523e4331675c; range_end:; response_count:1; response_revision:1945; }","duration":"909.356054ms","start":"2026-09-01T04:01:15.791798Z","end":"2026-09-01T04:01:16.701154Z","steps":["trace[289690223] 'agreement among raft nodes before linearized reading' (duration: 887.491106ms)","trace[289690223] 'range keys from in-memory index tree' (duration: 16.944667ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:01:16.701276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:01:15.791773Z","time spent":"909.483604ms","remote":"127.0.0.1:38942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-11c5163f-b73d-46c1-8079-523e4331675c\" "} {"level":"info","ts":"2026-09-01T04:01:29.328901Z","caller":"traceutil/trace.go:171","msg":"trace[177423468] transaction","detail":"{read_only:false; response_revision:2054; number_of_response:1; }","duration":"149.730034ms","start":"2026-09-01T04:01:29.179146Z","end":"2026-09-01T04:01:29.328876Z","steps":["trace[177423468] 'process raft request' (duration: 140.574961ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:01:32.677205Z","caller":"traceutil/trace.go:171","msg":"trace[1705201504] transaction","detail":"{read_only:false; response_revision:2080; number_of_response:1; }","duration":"229.140616ms","start":"2026-09-01T04:01:32.448038Z","end":"2026-09-01T04:01:32.677179Z","steps":["trace[1705201504] 'process raft request' (duration: 228.999815ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:01:32.678265Z","caller":"traceutil/trace.go:171","msg":"trace[1767807519] transaction","detail":"{read_only:false; response_revision:2081; number_of_response:1; }","duration":"225.658708ms","start":"2026-09-01T04:01:32.452591Z","end":"2026-09-01T04:01:32.67825Z","steps":["trace[1767807519] 'process raft request' (duration: 225.337602ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:01:56.168014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.417216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:01:56.168103Z","caller":"traceutil/trace.go:171","msg":"trace[1197465715] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:2213; }","duration":"211.575039ms","start":"2026-09-01T04:01:55.956503Z","end":"2026-09-01T04:01:56.168078Z","steps":["trace[1197465715] 'count revisions from in-memory index tree' (duration: 211.21921ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:01:56.168155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.916188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-01T04:01:56.168215Z","caller":"traceutil/trace.go:171","msg":"trace[798902782] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2213; }","duration":"187.062431ms","start":"2026-09-01T04:01:55.981126Z","end":"2026-09-01T04:01:56.168188Z","steps":["trace[798902782] 'range keys from in-memory index tree' (duration: 186.712551ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:01:56.168198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.286651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-01T04:01:56.16828Z","caller":"traceutil/trace.go:171","msg":"trace[1421197701] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:2213; }","duration":"238.567965ms","start":"2026-09-01T04:01:55.929696Z","end":"2026-09-01T04:01:56.168264Z","steps":["trace[1421197701] 'count revisions from in-memory index tree' (duration: 238.110537ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:01:56.168484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.171001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:01:56.168691Z","caller":"traceutil/trace.go:171","msg":"trace[324869667] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2213; }","duration":"210.560005ms","start":"2026-09-01T04:01:55.958056Z","end":"2026-09-01T04:01:56.168616Z","steps":["trace[324869667] 'count revisions from in-memory index tree' (duration: 210.061682ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:01:56.923031Z","caller":"traceutil/trace.go:171","msg":"trace[1352417025] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"125.884814ms","start":"2026-09-01T04:01:56.797126Z","end":"2026-09-01T04:01:56.92301Z","steps":["trace[1352417025] 'process raft request' (duration: 125.7139ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:01:57.069254Z","caller":"traceutil/trace.go:171","msg":"trace[628969171] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"137.191177ms","start":"2026-09-01T04:01:56.932036Z","end":"2026-09-01T04:01:57.069227Z","steps":["trace[628969171] 'process raft request' (duration: 137.018463ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:01:57.069573Z","caller":"traceutil/trace.go:171","msg":"trace[151978415] transaction","detail":"{read_only:false; response_revision:2218; number_of_response:1; }","duration":"137.112221ms","start":"2026-09-01T04:01:56.932436Z","end":"2026-09-01T04:01:57.069548Z","steps":["trace[151978415] 'process raft request' (duration: 136.753931ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:01:57.069573Z","caller":"traceutil/trace.go:171","msg":"trace[1930667444] transaction","detail":"{read_only:false; response_revision:2219; number_of_response:1; }","duration":"137.091849ms","start":"2026-09-01T04:01:56.932456Z","end":"2026-09-01T04:01:57.069548Z","steps":["trace[1930667444] 'process raft request' (duration: 136.924525ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:02:56.250605Z","caller":"traceutil/trace.go:171","msg":"trace[1085956482] transaction","detail":"{read_only:false; response_revision:2642; number_of_response:1; }","duration":"257.745384ms","start":"2026-09-01T04:02:55.992841Z","end":"2026-09-01T04:02:56.250586Z","steps":["trace[1085956482] 'process raft request' (duration: 257.635515ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:03:27.459757Z","caller":"traceutil/trace.go:171","msg":"trace[603454489] transaction","detail":"{read_only:false; response_revision:2811; number_of_response:1; }","duration":"100.975813ms","start":"2026-09-01T04:03:27.358749Z","end":"2026-09-01T04:03:27.459725Z","steps":["trace[603454489] 'process raft request' (duration: 52.343813ms)","trace[603454489] 'compare' (duration: 48.349287ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:08:05.618366Z","caller":"traceutil/trace.go:171","msg":"trace[235114252] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"138.521017ms","start":"2026-09-01T04:08:05.47981Z","end":"2026-09-01T04:08:05.618331Z","steps":["trace[235114252] 'process raft request' (duration: 138.309743ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:08:18.727583Z","caller":"traceutil/trace.go:171","msg":"trace[1582263989] transaction","detail":"{read_only:false; response_revision:5203; number_of_response:1; }","duration":"188.350161ms","start":"2026-09-01T04:08:18.5392Z","end":"2026-09-01T04:08:18.72755Z","steps":["trace[1582263989] 'process raft request' (duration: 187.806555ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:08:18.816943Z","caller":"traceutil/trace.go:171","msg":"trace[513801533] transaction","detail":"{read_only:false; response_revision:5204; number_of_response:1; }","duration":"227.953026ms","start":"2026-09-01T04:08:18.588956Z","end":"2026-09-01T04:08:18.816909Z","steps":["trace[513801533] 'process raft request' (duration: 165.660765ms)","trace[513801533] 'compare' (duration: 62.141461ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:08:19.121061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.508157ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:08:19.121158Z","caller":"traceutil/trace.go:171","msg":"trace[593241988] linearizableReadLoop","detail":"{readStateIndex:5409; appliedIndex:5408; }","duration":"172.210892ms","start":"2026-09-01T04:08:18.948932Z","end":"2026-09-01T04:08:19.121142Z","steps":["trace[593241988] 'read index received' (duration: 63.3219ms)","trace[593241988] 'applied index is now lower than readState.Index' (duration: 108.885992ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:08:19.121227Z","caller":"traceutil/trace.go:171","msg":"trace[1676355932] transaction","detail":"{read_only:false; response_revision:5206; number_of_response:1; }","duration":"215.949419ms","start":"2026-09-01T04:08:18.905235Z","end":"2026-09-01T04:08:19.121184Z","steps":["trace[1676355932] 'process raft request' (duration: 107.021465ms)","trace[1676355932] 'compare' (duration: 108.390749ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:08:19.121342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.402855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-01T04:08:19.121385Z","caller":"traceutil/trace.go:171","msg":"trace[1976438532] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:5206; }","duration":"172.488231ms","start":"2026-09-01T04:08:18.948882Z","end":"2026-09-01T04:08:19.12137Z","steps":["trace[1976438532] 'agreement among raft nodes before linearized reading' (duration: 172.345202ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:08:19.121544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.487678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-09-01T04:08:19.121646Z","caller":"traceutil/trace.go:171","msg":"trace[244621085] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5206; }","duration":"100.594865ms","start":"2026-09-01T04:08:19.021035Z","end":"2026-09-01T04:08:19.12163Z","steps":["trace[244621085] 'agreement among raft nodes before linearized reading' (duration: 100.21894ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:08:38.065499Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2871} {"level":"info","ts":"2026-09-01T04:08:38.145975Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2871,"took":"78.629615ms","hash":298771897,"current-db-size-bytes":53211136,"current-db-size":"53 MB","current-db-size-in-use-bytes":27832320,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-01T04:08:38.146025Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":298771897,"revision":2871,"compact-revision":-1} {"level":"info","ts":"2026-09-01T04:12:24.004017Z","caller":"traceutil/trace.go:171","msg":"trace[587998759] transaction","detail":"{read_only:false; response_revision:6994; number_of_response:1; }","duration":"123.694692ms","start":"2026-09-01T04:12:23.880304Z","end":"2026-09-01T04:12:24.003998Z","steps":["trace[587998759] 'process raft request' (duration: 69.145074ms)","trace[587998759] 'compare' (duration: 54.477647ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:13:38.071978Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5352} {"level":"info","ts":"2026-09-01T04:13:38.150177Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5352,"took":"76.829587ms","hash":4098565564,"current-db-size-bytes":53211136,"current-db-size":"53 MB","current-db-size-in-use-bytes":18829312,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-01T04:13:38.150249Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4098565564,"revision":5352,"compact-revision":2871}