{"level":"warn","ts":"2026-04-20T20:51:53.898132Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T20:51:53.898213Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.216: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://199.204.45.216:2380","--initial-cluster=instance=https://199.204.45.216:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.216:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.216: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-04-20T20:51:53.898271Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T20:51:53.898282Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-04-20T20:51:53.898302Z","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-04-20T20:51:53.89889Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"]} {"level":"info","ts":"2026-04-20T20:51:53.898952Z","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://199.204.45.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.216: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-04-20T20:51:53.90262Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.474736ms"} {"level":"info","ts":"2026-04-20T20:51:53.910341Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e98569549cc430c","cluster-id":"65d70b4d1d4a8bf9"} {"level":"info","ts":"2026-04-20T20:51:53.9104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T20:51:53.910424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 0"} {"level":"info","ts":"2026-04-20T20:51:53.910441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e98569549cc430c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T20:51:53.910451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 1"} {"level":"info","ts":"2026-04-20T20:51:53.910489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"warn","ts":"2026-04-20T20:51:53.916533Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T20:51:53.918725Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T20:51:53.919729Z","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-04-20T20:51:53.921856Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e98569549cc430c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T20:51:53.924282Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e98569549cc430c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T20:51:53.924425Z","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-04-20T20:51:53.924476Z","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-04-20T20:51:53.924488Z","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-04-20T20:51:53.925723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"info","ts":"2026-04-20T20:51:53.926053Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","added-peer-id":"4e98569549cc430c","added-peer-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-04-20T20:51:53.929434Z","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-04-20T20:51:53.929527Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-04-20T20:51:53.929546Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-04-20T20:51:53.929659Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e98569549cc430c","initial-advertise-peer-urls":["https://199.204.45.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T20:51:53.929685Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T20:51:54.910642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T20:51:54.910699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T20:51:54.910732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgPreVoteResp from 4e98569549cc430c at term 1"} {"level":"info","ts":"2026-04-20T20:51:54.910752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became candidate at term 2"} {"level":"info","ts":"2026-04-20T20:51:54.910769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgVoteResp from 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-04-20T20:51:54.910796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became leader at term 2"} {"level":"info","ts":"2026-04-20T20:51:54.910811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e98569549cc430c elected leader 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-04-20T20:51:54.911634Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e98569549cc430c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.216:2379]}","request-path":"/0/members/4e98569549cc430c/attributes","cluster-id":"65d70b4d1d4a8bf9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T20:51:54.911761Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T20:51:54.911901Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T20:51:54.912081Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T20:51:54.912691Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T20:51:54.912798Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T20:51:54.912752Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T20:51:54.91283Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T20:51:54.912835Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T20:51:54.915404Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T20:51:54.915547Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.216:2379"} {"level":"info","ts":"2026-04-20T20:51:56.736212Z","caller":"traceutil/trace.go:171","msg":"trace[1647732455] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"446.999823ms","start":"2026-04-20T20:51:56.289152Z","end":"2026-04-20T20:51:56.736152Z","steps":["trace[1647732455] 'process raft request' (duration: 416.355455ms)","trace[1647732455] 'compare' (duration: 30.330811ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T20:51:56.736738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:51:56.289132Z","time spent":"447.165256ms","remote":"127.0.0.1:45962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":947,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T20:51:56.736771Z","caller":"traceutil/trace.go:171","msg":"trace[547550991] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"447.38662ms","start":"2026-04-20T20:51:56.289358Z","end":"2026-04-20T20:51:56.736745Z","steps":["trace[547550991] 'process raft request' (duration: 446.656174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:51:56.736904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:51:56.289351Z","time spent":"447.462332ms","remote":"127.0.0.1:45962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T20:51:56.736939Z","caller":"traceutil/trace.go:171","msg":"trace[1028388395] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"447.518603ms","start":"2026-04-20T20:51:56.289251Z","end":"2026-04-20T20:51:56.73677Z","steps":["trace[1028388395] 'process raft request' (duration: 446.723935ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:51:56.737006Z","caller":"traceutil/trace.go:171","msg":"trace[697103563] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"447.482762ms","start":"2026-04-20T20:51:56.289513Z","end":"2026-04-20T20:51:56.736996Z","steps":["trace[697103563] 'process raft request' (duration: 446.540101ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:51:56.737023Z","caller":"traceutil/trace.go:171","msg":"trace[634827770] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"446.958ms","start":"2026-04-20T20:51:56.290053Z","end":"2026-04-20T20:51:56.737011Z","steps":["trace[634827770] 'process raft request' (duration: 446.04294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:51:56.737057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:51:56.289506Z","time spent":"447.529593ms","remote":"127.0.0.1:45962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":956,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T20:51:56.737085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:51:56.29004Z","time spent":"447.009841ms","remote":"127.0.0.1:45878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":711,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T20:51:56.737075Z","caller":"traceutil/trace.go:171","msg":"trace[368210749] linearizableReadLoop","detail":"{readStateIndex:35; appliedIndex:30; }","duration":"423.14638ms","start":"2026-04-20T20:51:56.313864Z","end":"2026-04-20T20:51:56.73701Z","steps":["trace[368210749] 'read index received' (duration: 391.646593ms)","trace[368210749] 'applied index is now lower than readState.Index' (duration: 31.491517ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T20:51:56.737106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:51:56.289244Z","time spent":"447.774589ms","remote":"127.0.0.1:45962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1007,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T20:51:56.737244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.368205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T20:51:56.737304Z","caller":"traceutil/trace.go:171","msg":"trace[1306801109] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:31; }","duration":"423.450697ms","start":"2026-04-20T20:51:56.313841Z","end":"2026-04-20T20:51:56.737292Z","steps":["trace[1306801109] 'agreement among raft nodes before linearized reading' (duration: 423.314744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:51:56.737337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:51:56.313829Z","time spent":"423.499709ms","remote":"127.0.0.1:45510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" "} {"level":"info","ts":"2026-04-20T20:51:56.880577Z","caller":"traceutil/trace.go:171","msg":"trace[804908166] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"566.470764ms","start":"2026-04-20T20:51:56.314056Z","end":"2026-04-20T20:51:56.880527Z","steps":["trace[804908166] 'process raft request' (duration: 562.0214ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:51:56.880678Z","caller":"traceutil/trace.go:171","msg":"trace[1764850991] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"138.84092ms","start":"2026-04-20T20:51:56.741815Z","end":"2026-04-20T20:51:56.880656Z","steps":["trace[1764850991] 'process raft request' (duration: 138.810949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:51:56.880756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:51:56.314045Z","time spent":"566.629638ms","remote":"127.0.0.1:45962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T20:51:56.880794Z","caller":"traceutil/trace.go:171","msg":"trace[68540625] linearizableReadLoop","detail":"{readStateIndex:36; appliedIndex:35; }","duration":"143.512338ms","start":"2026-04-20T20:51:56.737162Z","end":"2026-04-20T20:51:56.880674Z","steps":["trace[68540625] 'read index received' (duration: 138.945372ms)","trace[68540625] 'applied index is now lower than readState.Index' (duration: 4.564916ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T20:51:56.880798Z","caller":"traceutil/trace.go:171","msg":"trace[174311242] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"139.454794ms","start":"2026-04-20T20:51:56.741301Z","end":"2026-04-20T20:51:56.880755Z","steps":["trace[174311242] 'process raft request' (duration: 139.244019ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:51:56.880866Z","caller":"traceutil/trace.go:171","msg":"trace[187413549] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"139.430333ms","start":"2026-04-20T20:51:56.74142Z","end":"2026-04-20T20:51:56.88085Z","steps":["trace[187413549] 'process raft request' (duration: 139.160487ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:51:56.880932Z","caller":"traceutil/trace.go:171","msg":"trace[1157538219] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"139.265899ms","start":"2026-04-20T20:51:56.74165Z","end":"2026-04-20T20:51:56.880916Z","steps":["trace[1157538219] 'process raft request' (duration: 138.955692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:51:56.881101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.52009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T20:51:56.882329Z","caller":"traceutil/trace.go:171","msg":"trace[685716334] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:38; }","duration":"466.781048ms","start":"2026-04-20T20:51:56.415515Z","end":"2026-04-20T20:51:56.882296Z","steps":["trace[685716334] 'agreement among raft nodes before linearized reading' (duration: 465.364696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:51:56.882437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:51:56.415496Z","time spent":"466.925622ms","remote":"127.0.0.1:45832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-04-20T20:51:56.881174Z","caller":"traceutil/trace.go:171","msg":"trace[280726225] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"140.131669ms","start":"2026-04-20T20:51:56.741017Z","end":"2026-04-20T20:51:56.881148Z","steps":["trace[280726225] 'process raft request' (duration: 139.496494ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:51:56.882142Z","caller":"traceutil/trace.go:171","msg":"trace[1145556834] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"142.897394ms","start":"2026-04-20T20:51:56.739206Z","end":"2026-04-20T20:51:56.882103Z","steps":["trace[1145556834] 'process raft request' (duration: 141.265336ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:01.831433Z","caller":"traceutil/trace.go:171","msg":"trace[705362528] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"104.853871ms","start":"2026-04-20T20:53:01.726367Z","end":"2026-04-20T20:53:01.831221Z","steps":["trace[705362528] 'process raft request' (duration: 41.708792ms)","trace[705362528] 'compare' (duration: 63.037798ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T20:53:03.454552Z","caller":"traceutil/trace.go:171","msg":"trace[723136931] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"245.509335ms","start":"2026-04-20T20:53:03.209014Z","end":"2026-04-20T20:53:03.454523Z","steps":["trace[723136931] 'process raft request' (duration: 244.538804ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:03.7596Z","caller":"traceutil/trace.go:171","msg":"trace[1329138383] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"276.9722ms","start":"2026-04-20T20:53:03.4826Z","end":"2026-04-20T20:53:03.759572Z","steps":["trace[1329138383] 'process raft request' (duration: 276.722377ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:03.800919Z","caller":"traceutil/trace.go:171","msg":"trace[1129910226] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"285.829198ms","start":"2026-04-20T20:53:03.515059Z","end":"2026-04-20T20:53:03.800888Z","steps":["trace[1129910226] 'process raft request' (duration: 264.113399ms)","trace[1129910226] 'compare' (duration: 21.614268ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T20:53:04.294454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.665594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T20:53:04.294602Z","caller":"traceutil/trace.go:171","msg":"trace[418336152] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:692; }","duration":"391.897886ms","start":"2026-04-20T20:53:03.902683Z","end":"2026-04-20T20:53:04.294581Z","steps":["trace[418336152] 'count revisions from in-memory index tree' (duration: 391.578302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:04.294681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:53:03.902668Z","time spent":"391.998987ms","remote":"127.0.0.1:45784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":14,"response size":29,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-04-20T20:53:18.629778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.208154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lqrdh\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-20T20:53:18.629964Z","caller":"traceutil/trace.go:171","msg":"trace[555297858] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lqrdh; range_end:; response_count:1; response_revision:854; }","duration":"115.451095ms","start":"2026-04-20T20:53:18.514488Z","end":"2026-04-20T20:53:18.629939Z","steps":["trace[555297858] 'range keys from in-memory index tree' (duration: 115.022326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:51.332522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.442239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T20:53:51.332612Z","caller":"traceutil/trace.go:171","msg":"trace[1164944740] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1268; }","duration":"122.588924ms","start":"2026-04-20T20:53:51.210004Z","end":"2026-04-20T20:53:51.332593Z","steps":["trace[1164944740] 'range keys from in-memory index tree' (duration: 122.351667ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:54:37.677068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.72329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-20T20:54:37.6773Z","caller":"traceutil/trace.go:171","msg":"trace[556660027] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1928; }","duration":"338.004486ms","start":"2026-04-20T20:54:37.339263Z","end":"2026-04-20T20:54:37.677267Z","steps":["trace[556660027] 'range keys from in-memory index tree' (duration: 337.503255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:54:37.677456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:54:37.339238Z","time spent":"338.19139ms","remote":"127.0.0.1:45692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T20:54:37.677072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.730783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0f27f587-6ccd-400a-a8a4-51a4fb63d635\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-04-20T20:54:37.677645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.102101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-20T20:54:37.677765Z","caller":"traceutil/trace.go:171","msg":"trace[1397218976] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0f27f587-6ccd-400a-a8a4-51a4fb63d635; range_end:; response_count:1; response_revision:1928; }","duration":"236.418078ms","start":"2026-04-20T20:54:37.441253Z","end":"2026-04-20T20:54:37.677671Z","steps":["trace[1397218976] 'range keys from in-memory index tree' (duration: 235.425236ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:54:37.677856Z","caller":"traceutil/trace.go:171","msg":"trace[1241806839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1928; }","duration":"324.350026ms","start":"2026-04-20T20:54:37.353457Z","end":"2026-04-20T20:54:37.677807Z","steps":["trace[1241806839] 'range keys from in-memory index tree' (duration: 323.769633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:54:37.677938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:54:37.353431Z","time spent":"324.492809ms","remote":"127.0.0.1:45692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T20:54:37.680448Z","caller":"traceutil/trace.go:171","msg":"trace[1711037148] transaction","detail":"{read_only:false; response_revision:1929; number_of_response:1; }","duration":"118.340016ms","start":"2026-04-20T20:54:37.562076Z","end":"2026-04-20T20:54:37.680416Z","steps":["trace[1711037148] 'process raft request' (duration: 118.122902ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:54:38.067642Z","caller":"traceutil/trace.go:171","msg":"trace[7972221] transaction","detail":"{read_only:false; response_revision:1934; number_of_response:1; }","duration":"100.951355ms","start":"2026-04-20T20:54:37.966646Z","end":"2026-04-20T20:54:38.067597Z","steps":["trace[7972221] 'process raft request' (duration: 100.795461ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:54:38.072366Z","caller":"traceutil/trace.go:171","msg":"trace[1164088179] transaction","detail":"{read_only:false; response_revision:1935; number_of_response:1; }","duration":"103.033501ms","start":"2026-04-20T20:54:37.969313Z","end":"2026-04-20T20:54:38.072347Z","steps":["trace[1164088179] 'process raft request' (duration: 102.918038ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:54:54.310084Z","caller":"traceutil/trace.go:171","msg":"trace[2043407463] linearizableReadLoop","detail":"{readStateIndex:2150; appliedIndex:2149; }","duration":"117.741453ms","start":"2026-04-20T20:54:54.19231Z","end":"2026-04-20T20:54:54.310051Z","steps":["trace[2043407463] 'read index received' (duration: 117.477518ms)","trace[2043407463] 'applied index is now lower than readState.Index' (duration: 262.905µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T20:54:54.310231Z","caller":"traceutil/trace.go:171","msg":"trace[530658728] transaction","detail":"{read_only:false; response_revision:2067; number_of_response:1; }","duration":"146.343752ms","start":"2026-04-20T20:54:54.163847Z","end":"2026-04-20T20:54:54.31019Z","steps":["trace[530658728] 'process raft request' (duration: 146.012335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:54:54.310386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.041729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"info","ts":"2026-04-20T20:54:54.310434Z","caller":"traceutil/trace.go:171","msg":"trace[1339638803] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2067; }","duration":"118.152012ms","start":"2026-04-20T20:54:54.192271Z","end":"2026-04-20T20:54:54.310423Z","steps":["trace[1339638803] 'agreement among raft nodes before linearized reading' (duration: 117.943047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:55:12.534881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.949714ms","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-04-20T20:55:12.534985Z","caller":"traceutil/trace.go:171","msg":"trace[185152882] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2170; }","duration":"102.079927ms","start":"2026-04-20T20:55:12.432879Z","end":"2026-04-20T20:55:12.534959Z","steps":["trace[185152882] 'range keys from in-memory index tree' (duration: 101.758041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:55:12.534998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.944826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T20:55:12.535183Z","caller":"traceutil/trace.go:171","msg":"trace[2139785906] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:2170; }","duration":"153.284992ms","start":"2026-04-20T20:55:12.381852Z","end":"2026-04-20T20:55:12.535137Z","steps":["trace[2139785906] 'count revisions from in-memory index tree' (duration: 152.819824ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:55:12.534879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.884102ms","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-04-20T20:55:12.535499Z","caller":"traceutil/trace.go:171","msg":"trace[1987609037] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2170; }","duration":"129.614866ms","start":"2026-04-20T20:55:12.405863Z","end":"2026-04-20T20:55:12.535477Z","steps":["trace[1987609037] 'range keys from in-memory index tree' (duration: 128.643247ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:55:12.535833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.834203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-20T20:55:12.535926Z","caller":"traceutil/trace.go:171","msg":"trace[284073187] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2170; }","duration":"135.985446ms","start":"2026-04-20T20:55:12.399919Z","end":"2026-04-20T20:55:12.535904Z","steps":["trace[284073187] 'range keys from in-memory index tree' (duration: 134.512528ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:55:13.138372Z","caller":"traceutil/trace.go:171","msg":"trace[545547442] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"153.529216ms","start":"2026-04-20T20:55:12.984809Z","end":"2026-04-20T20:55:13.138338Z","steps":["trace[545547442] 'process raft request' (duration: 153.015686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:55:13.453834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.489556ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T20:55:13.454365Z","caller":"traceutil/trace.go:171","msg":"trace[132091462] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"313.055222ms","start":"2026-04-20T20:55:13.14126Z","end":"2026-04-20T20:55:13.454316Z","steps":["trace[132091462] 'process raft request' (duration: 312.748267ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:55:13.454407Z","caller":"traceutil/trace.go:171","msg":"trace[1313403833] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"315.10969ms","start":"2026-04-20T20:55:13.139243Z","end":"2026-04-20T20:55:13.454353Z","steps":["trace[1313403833] 'process raft request' (duration: 170.465212ms)","trace[1313403833] 'compare' (duration: 143.309063ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T20:55:13.454815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:55:13.14125Z","time spent":"313.211846ms","remote":"127.0.0.1:45692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T20:55:13.454845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:55:13.139216Z","time spent":"315.488167ms","remote":"127.0.0.1:45692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T20:55:13.482327Z","caller":"traceutil/trace.go:171","msg":"trace[1459159904] linearizableReadLoop","detail":"{readStateIndex:2263; appliedIndex:2260; }","duration":"268.413134ms","start":"2026-04-20T20:55:13.21389Z","end":"2026-04-20T20:55:13.482303Z","steps":["trace[1459159904] 'read index received' (duration: 95.878562ms)","trace[1459159904] 'applied index is now lower than readState.Index' (duration: 172.533202ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T20:55:13.482547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.556797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T20:55:13.482724Z","caller":"traceutil/trace.go:171","msg":"trace[1262094123] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2175; }","duration":"268.833691ms","start":"2026-04-20T20:55:13.213864Z","end":"2026-04-20T20:55:13.482698Z","steps":["trace[1262094123] 'agreement among raft nodes before linearized reading' (duration: 268.511046ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:00:30.088371Z","caller":"traceutil/trace.go:171","msg":"trace[559284960] linearizableReadLoop","detail":"{readStateIndex:4873; appliedIndex:4872; }","duration":"164.804996ms","start":"2026-04-20T21:00:29.923528Z","end":"2026-04-20T21:00:30.088333Z","steps":["trace[559284960] 'read index received' (duration: 164.589132ms)","trace[559284960] 'applied index is now lower than readState.Index' (duration: 214.664µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T21:00:30.088393Z","caller":"traceutil/trace.go:171","msg":"trace[1150677037] transaction","detail":"{read_only:false; response_revision:4689; number_of_response:1; }","duration":"194.903208ms","start":"2026-04-20T21:00:29.893462Z","end":"2026-04-20T21:00:30.088365Z","steps":["trace[1150677037] 'process raft request' (duration: 194.671503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T21:00:30.088511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.958521ms","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-04-20T21:00:30.088539Z","caller":"traceutil/trace.go:171","msg":"trace[1604263557] 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:4689; }","duration":"165.045312ms","start":"2026-04-20T21:00:29.923487Z","end":"2026-04-20T21:00:30.088532Z","steps":["trace[1604263557] 'agreement among raft nodes before linearized reading' (duration: 164.9519ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:00:30.099305Z","caller":"traceutil/trace.go:171","msg":"trace[467002115] transaction","detail":"{read_only:false; response_revision:4690; number_of_response:1; }","duration":"105.00399ms","start":"2026-04-20T21:00:29.994289Z","end":"2026-04-20T21:00:30.099293Z","steps":["trace[467002115] 'process raft request' (duration: 104.918728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T21:00:34.638388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.317744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b022abdf-83f9-49bf-8830-a2345f47a45a\" ","response":"range_response_count:1 size:3646"} {"level":"warn","ts":"2026-04-20T21:00:34.638428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.187022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T21:00:34.638456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.244448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T21:00:34.638533Z","caller":"traceutil/trace.go:171","msg":"trace[722252322] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:4782; }","duration":"205.397732ms","start":"2026-04-20T21:00:34.433116Z","end":"2026-04-20T21:00:34.638514Z","steps":["trace[722252322] 'count revisions from in-memory index tree' (duration: 205.140916ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:00:34.638534Z","caller":"traceutil/trace.go:171","msg":"trace[814752859] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:4782; }","duration":"217.373217ms","start":"2026-04-20T21:00:34.421136Z","end":"2026-04-20T21:00:34.638509Z","steps":["trace[814752859] 'count revisions from in-memory index tree' (duration: 217.04525ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:00:34.638604Z","caller":"traceutil/trace.go:171","msg":"trace[1240576055] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b022abdf-83f9-49bf-8830-a2345f47a45a; range_end:; response_count:1; response_revision:4782; }","duration":"107.483708ms","start":"2026-04-20T21:00:34.530996Z","end":"2026-04-20T21:00:34.63848Z","steps":["trace[1240576055] 'range keys from in-memory index tree' (duration: 107.117899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T21:00:47.414316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.093311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T21:00:47.414413Z","caller":"traceutil/trace.go:171","msg":"trace[896262531] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4956; }","duration":"196.244455ms","start":"2026-04-20T21:00:47.218144Z","end":"2026-04-20T21:00:47.414388Z","steps":["trace[896262531] 'range keys from in-memory index tree' (duration: 196.01348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T21:00:47.414422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.762413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-20T21:00:47.414501Z","caller":"traceutil/trace.go:171","msg":"trace[1869047920] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4956; }","duration":"156.855755ms","start":"2026-04-20T21:00:47.257608Z","end":"2026-04-20T21:00:47.414464Z","steps":["trace[1869047920] 'range keys from in-memory index tree' (duration: 156.58524ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:00:47.461392Z","caller":"traceutil/trace.go:171","msg":"trace[2064939484] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"116.558416ms","start":"2026-04-20T21:00:47.344812Z","end":"2026-04-20T21:00:47.46137Z","steps":["trace[2064939484] 'process raft request' (duration: 116.2787ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:00:47.966159Z","caller":"traceutil/trace.go:171","msg":"trace[269737066] transaction","detail":"{read_only:false; response_revision:4966; number_of_response:1; }","duration":"125.265754ms","start":"2026-04-20T21:00:47.840866Z","end":"2026-04-20T21:00:47.966131Z","steps":["trace[269737066] 'process raft request' (duration: 75.597862ms)","trace[269737066] 'compare' (duration: 49.476488ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T21:00:47.966478Z","caller":"traceutil/trace.go:171","msg":"trace[1494006907] transaction","detail":"{read_only:false; response_revision:4967; number_of_response:1; }","duration":"125.403707ms","start":"2026-04-20T21:00:47.841037Z","end":"2026-04-20T21:00:47.966441Z","steps":["trace[1494006907] 'process raft request' (duration: 125.041729ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:00:47.966784Z","caller":"traceutil/trace.go:171","msg":"trace[113336745] transaction","detail":"{read_only:false; response_revision:4968; number_of_response:1; }","duration":"125.452957ms","start":"2026-04-20T21:00:47.841151Z","end":"2026-04-20T21:00:47.966604Z","steps":["trace[113336745] 'process raft request' (duration: 125.11404ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T21:01:54.941326Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2831} {"level":"info","ts":"2026-04-20T21:01:55.032705Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2831,"took":"89.139752ms","hash":2394037306,"current-db-size-bytes":52817920,"current-db-size":"53 MB","current-db-size-in-use-bytes":29040640,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-20T21:01:55.032779Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2394037306,"revision":2831,"compact-revision":-1} {"level":"info","ts":"2026-04-20T21:06:54.947217Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5547} {"level":"info","ts":"2026-04-20T21:06:55.035611Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5547,"took":"87.078696ms","hash":2630358481,"current-db-size-bytes":52817920,"current-db-size":"53 MB","current-db-size-in-use-bytes":18640896,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-04-20T21:06:55.035697Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2630358481,"revision":5547,"compact-revision":2831}