{"level":"warn","ts":"2026-04-21T15:36:07.653687Z","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-21T15:36:07.653769Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.235: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.19.213.235:2380","--initial-cluster=instance=https://199.19.213.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.235: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-21T15:36:07.654006Z","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-21T15:36:07.654012Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.235:2380"]} {"level":"info","ts":"2026-04-21T15:36:07.654027Z","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-21T15:36:07.654618Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.235:2379"]} {"level":"info","ts":"2026-04-21T15:36:07.654678Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.235:2380"],"listen-peer-urls":["https://199.19.213.235:2380"],"advertise-client-urls":["https://199.19.213.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.235: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-21T15:36:07.658196Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.335078ms"} {"level":"info","ts":"2026-04-21T15:36:07.664011Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"61a3fe3fc9dc5d35","cluster-id":"e13fd0e1d9ce1168"} {"level":"info","ts":"2026-04-21T15:36:07.664073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 switched to configuration voters=()"} {"level":"info","ts":"2026-04-21T15:36:07.66409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became follower at term 0"} {"level":"info","ts":"2026-04-21T15:36:07.664098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 61a3fe3fc9dc5d35 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-21T15:36:07.66411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became follower at term 1"} {"level":"info","ts":"2026-04-21T15:36:07.664141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 switched to configuration voters=(7035746592805903669)"} {"level":"warn","ts":"2026-04-21T15:36:07.668637Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-21T15:36:07.670194Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-21T15:36:07.671435Z","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-21T15:36:07.674129Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"61a3fe3fc9dc5d35","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-21T15:36:07.674363Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"61a3fe3fc9dc5d35","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-21T15:36:07.674376Z","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-21T15:36:07.67452Z","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-21T15:36:07.674549Z","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-21T15:36:07.676515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 switched to configuration voters=(7035746592805903669)"} {"level":"info","ts":"2026-04-21T15:36:07.676668Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e13fd0e1d9ce1168","local-member-id":"61a3fe3fc9dc5d35","added-peer-id":"61a3fe3fc9dc5d35","added-peer-peer-urls":["https://199.19.213.235:2380"]} {"level":"info","ts":"2026-04-21T15:36:07.679495Z","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-21T15:36:07.679718Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.235:2380"} {"level":"info","ts":"2026-04-21T15:36:07.679763Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.235:2380"} {"level":"info","ts":"2026-04-21T15:36:07.680049Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"61a3fe3fc9dc5d35","initial-advertise-peer-urls":["https://199.19.213.235:2380"],"listen-peer-urls":["https://199.19.213.235:2380"],"advertise-client-urls":["https://199.19.213.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-21T15:36:07.680108Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-21T15:36:08.164834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 is starting a new election at term 1"} {"level":"info","ts":"2026-04-21T15:36:08.1649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-21T15:36:08.164924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 received MsgPreVoteResp from 61a3fe3fc9dc5d35 at term 1"} {"level":"info","ts":"2026-04-21T15:36:08.164943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became candidate at term 2"} {"level":"info","ts":"2026-04-21T15:36:08.164956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 received MsgVoteResp from 61a3fe3fc9dc5d35 at term 2"} {"level":"info","ts":"2026-04-21T15:36:08.164971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became leader at term 2"} {"level":"info","ts":"2026-04-21T15:36:08.164985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 61a3fe3fc9dc5d35 elected leader 61a3fe3fc9dc5d35 at term 2"} {"level":"info","ts":"2026-04-21T15:36:08.166575Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"61a3fe3fc9dc5d35","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.235:2379]}","request-path":"/0/members/61a3fe3fc9dc5d35/attributes","cluster-id":"e13fd0e1d9ce1168","publish-timeout":"7s"} {"level":"info","ts":"2026-04-21T15:36:08.166627Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T15:36:08.16668Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T15:36:08.167072Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T15:36:08.167385Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-21T15:36:08.167487Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-21T15:36:08.168107Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e13fd0e1d9ce1168","local-member-id":"61a3fe3fc9dc5d35","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T15:36:08.168311Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T15:36:08.168358Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T15:36:08.170233Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-21T15:36:08.170752Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.235:2379"} {"level":"info","ts":"2026-04-21T15:36:38.123265Z","caller":"traceutil/trace.go:171","msg":"trace[207236635] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"172.449235ms","start":"2026-04-21T15:36:37.950789Z","end":"2026-04-21T15:36:38.123238Z","steps":["trace[207236635] 'process raft request' (duration: 172.227539ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:36:38.128401Z","caller":"traceutil/trace.go:171","msg":"trace[689930047] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"172.175587ms","start":"2026-04-21T15:36:37.956204Z","end":"2026-04-21T15:36:38.12838Z","steps":["trace[689930047] 'process raft request' (duration: 172.074945ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:36:44.416817Z","caller":"traceutil/trace.go:171","msg":"trace[67734438] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"154.815913ms","start":"2026-04-21T15:36:44.261976Z","end":"2026-04-21T15:36:44.416792Z","steps":["trace[67734438] 'read index received' (duration: 154.636139ms)","trace[67734438] 'applied index is now lower than readState.Index' (duration: 178.854µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:36:44.41694Z","caller":"traceutil/trace.go:171","msg":"trace[1908119400] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"220.025641ms","start":"2026-04-21T15:36:44.196903Z","end":"2026-04-21T15:36:44.416928Z","steps":["trace[1908119400] 'process raft request' (duration: 219.716934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:36:44.417299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.265453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-21T15:36:44.417498Z","caller":"traceutil/trace.go:171","msg":"trace[1765234914] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:578; }","duration":"155.54025ms","start":"2026-04-21T15:36:44.261941Z","end":"2026-04-21T15:36:44.417481Z","steps":["trace[1765234914] 'agreement among raft nodes before linearized reading' (duration: 155.135341ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:36:44.58307Z","caller":"traceutil/trace.go:171","msg":"trace[628123511] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"166.143807ms","start":"2026-04-21T15:36:44.416898Z","end":"2026-04-21T15:36:44.583041Z","steps":["trace[628123511] 'read index received' (duration: 116.337438ms)","trace[628123511] 'applied index is now lower than readState.Index' (duration: 49.805139ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:36:44.58313Z","caller":"traceutil/trace.go:171","msg":"trace[1695155345] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"294.6561ms","start":"2026-04-21T15:36:44.288447Z","end":"2026-04-21T15:36:44.583103Z","steps":["trace[1695155345] 'process raft request' (duration: 244.960973ms)","trace[1695155345] 'compare' (duration: 49.232445ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:36:44.583366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.592484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-21T15:36:44.583524Z","caller":"traceutil/trace.go:171","msg":"trace[1493867362] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:579; }","duration":"229.721107ms","start":"2026-04-21T15:36:44.353733Z","end":"2026-04-21T15:36:44.583454Z","steps":["trace[1493867362] 'agreement among raft nodes before linearized reading' (duration: 229.40272ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:36:44.811902Z","caller":"traceutil/trace.go:171","msg":"trace[1952554898] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"388.887103ms","start":"2026-04-21T15:36:44.422993Z","end":"2026-04-21T15:36:44.81188Z","steps":["trace[1952554898] 'process raft request' (duration: 313.433976ms)","trace[1952554898] 'compare' (duration: 75.190911ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:36:44.812002Z","caller":"traceutil/trace.go:171","msg":"trace[1592414001] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:601; }","duration":"106.367186ms","start":"2026-04-21T15:36:44.705606Z","end":"2026-04-21T15:36:44.811973Z","steps":["trace[1592414001] 'read index received' (duration: 30.834248ms)","trace[1592414001] 'applied index is now lower than readState.Index' (duration: 75.531418ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:36:44.812036Z","caller":"traceutil/trace.go:171","msg":"trace[298549082] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"174.778578ms","start":"2026-04-21T15:36:44.63724Z","end":"2026-04-21T15:36:44.812019Z","steps":["trace[298549082] 'process raft request' (duration: 174.686176ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:36:44.812171Z","caller":"traceutil/trace.go:171","msg":"trace[1665283957] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"223.924002ms","start":"2026-04-21T15:36:44.588236Z","end":"2026-04-21T15:36:44.81216Z","steps":["trace[1665283957] 'process raft request' (duration: 223.574044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:36:44.812161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.53077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:36:44.812213Z","caller":"traceutil/trace.go:171","msg":"trace[1353822225] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"106.637202ms","start":"2026-04-21T15:36:44.705561Z","end":"2026-04-21T15:36:44.812198Z","steps":["trace[1353822225] 'agreement among raft nodes before linearized reading' (duration: 106.510179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:36:44.81265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:36:44.42297Z","time spent":"388.983764ms","remote":"127.0.0.1:36960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T15:36:45.529336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.722211ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T15:36:45.529579Z","caller":"traceutil/trace.go:171","msg":"trace[1384841997] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"618.814904ms","start":"2026-04-21T15:36:44.910718Z","end":"2026-04-21T15:36:45.529532Z","steps":["trace[1384841997] 'process raft request' (duration: 283.443258ms)","trace[1384841997] 'compare' (duration: 334.612809ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:36:45.529644Z","caller":"traceutil/trace.go:171","msg":"trace[2034618834] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"618.907556ms","start":"2026-04-21T15:36:44.910718Z","end":"2026-04-21T15:36:45.529625Z","steps":["trace[2034618834] 'process raft request' (duration: 618.720622ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:36:45.52972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:36:44.910702Z","time spent":"618.982828ms","remote":"127.0.0.1:36800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T15:36:45.529747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:36:44.910702Z","time spent":"618.961208ms","remote":"127.0.0.1:36800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T15:36:45.529972Z","caller":"traceutil/trace.go:171","msg":"trace[543890276] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"618.519138ms","start":"2026-04-21T15:36:44.911404Z","end":"2026-04-21T15:36:45.529923Z","steps":["trace[543890276] 'process raft request' (duration: 618.101177ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:36:45.530172Z","caller":"traceutil/trace.go:171","msg":"trace[1963613460] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"616.916211ms","start":"2026-04-21T15:36:44.913235Z","end":"2026-04-21T15:36:45.530151Z","steps":["trace[1963613460] 'process raft request' (duration: 616.829599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:36:45.530222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:36:44.911381Z","time spent":"618.706682ms","remote":"127.0.0.1:36928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T15:36:45.530387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:36:44.913226Z","time spent":"617.045314ms","remote":"127.0.0.1:36872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T15:37:30.576477Z","caller":"traceutil/trace.go:171","msg":"trace[476496978] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"142.797094ms","start":"2026-04-21T15:37:30.433656Z","end":"2026-04-21T15:37:30.576453Z","steps":["trace[476496978] 'process raft request' (duration: 142.658661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:38:16.608899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.23035ms","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-21T15:38:16.608993Z","caller":"traceutil/trace.go:171","msg":"trace[1826913495] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1819; }","duration":"140.417934ms","start":"2026-04-21T15:38:16.468553Z","end":"2026-04-21T15:38:16.60897Z","steps":["trace[1826913495] 'range keys from in-memory index tree' (duration: 140.033945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:38:16.60924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.142786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a8695b4e0ecfaf\" ","response":"range_response_count:1 size:982"} {"level":"info","ts":"2026-04-21T15:38:16.609347Z","caller":"traceutil/trace.go:171","msg":"trace[1652107033] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a8695b4e0ecfaf; range_end:; response_count:1; response_revision:1819; }","duration":"107.30271ms","start":"2026-04-21T15:38:16.502Z","end":"2026-04-21T15:38:16.609303Z","steps":["trace[1652107033] 'range keys from in-memory index tree' (duration: 106.938382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:39:04.526137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.951582ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T15:39:04.526275Z","caller":"traceutil/trace.go:171","msg":"trace[1226981751] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"188.930939ms","start":"2026-04-21T15:39:04.337322Z","end":"2026-04-21T15:39:04.526253Z","steps":["trace[1226981751] 'process raft request' (duration: 78.761551ms)","trace[1226981751] 'compare' (duration: 109.654085ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:39:10.669555Z","caller":"traceutil/trace.go:171","msg":"trace[328439213] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"126.045634ms","start":"2026-04-21T15:39:10.543466Z","end":"2026-04-21T15:39:10.669512Z","steps":["trace[328439213] 'process raft request' (duration: 125.838049ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:39:10.867044Z","caller":"traceutil/trace.go:171","msg":"trace[701416966] linearizableReadLoop","detail":"{readStateIndex:2246; appliedIndex:2245; }","duration":"162.534722ms","start":"2026-04-21T15:39:10.704468Z","end":"2026-04-21T15:39:10.867002Z","steps":["trace[701416966] 'read index received' (duration: 106.46831ms)","trace[701416966] 'applied index is now lower than readState.Index' (duration: 56.065472ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:39:10.867124Z","caller":"traceutil/trace.go:171","msg":"trace[149430547] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"193.186499ms","start":"2026-04-21T15:39:10.673897Z","end":"2026-04-21T15:39:10.867084Z","steps":["trace[149430547] 'process raft request' (duration: 137.027445ms)","trace[149430547] 'compare' (duration: 55.96329ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:39:10.867163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.681655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:39:10.867197Z","caller":"traceutil/trace.go:171","msg":"trace[1956577294] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2164; }","duration":"162.761317ms","start":"2026-04-21T15:39:10.704424Z","end":"2026-04-21T15:39:10.867186Z","steps":["trace[1956577294] 'agreement among raft nodes before linearized reading' (duration: 162.689275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:39:11.122422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.639487ms","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-21T15:39:11.122535Z","caller":"traceutil/trace.go:171","msg":"trace[402728608] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2164; }","duration":"128.76152ms","start":"2026-04-21T15:39:10.993751Z","end":"2026-04-21T15:39:11.122512Z","steps":["trace[402728608] 'range keys from in-memory index tree' (duration: 128.490703ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:39:11.122592Z","caller":"traceutil/trace.go:171","msg":"trace[2047692069] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"109.734857ms","start":"2026-04-21T15:39:11.012827Z","end":"2026-04-21T15:39:11.122562Z","steps":["trace[2047692069] 'process raft request' (duration: 107.515925ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:40:20.864662Z","caller":"traceutil/trace.go:171","msg":"trace[1976029294] transaction","detail":"{read_only:false; response_revision:2737; number_of_response:1; }","duration":"143.046273ms","start":"2026-04-21T15:40:20.72159Z","end":"2026-04-21T15:40:20.864636Z","steps":["trace[1976029294] 'process raft request' (duration: 142.90141ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:40:21.002901Z","caller":"traceutil/trace.go:171","msg":"trace[780602657] transaction","detail":"{read_only:false; response_revision:2738; number_of_response:1; }","duration":"101.909305ms","start":"2026-04-21T15:40:20.90095Z","end":"2026-04-21T15:40:21.00286Z","steps":["trace[780602657] 'process raft request' (duration: 88.423585ms)","trace[780602657] 'compare' (duration: 13.344067ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:42:45.656941Z","caller":"traceutil/trace.go:171","msg":"trace[399835673] transaction","detail":"{read_only:false; response_revision:3703; number_of_response:1; }","duration":"182.715563ms","start":"2026-04-21T15:42:45.474202Z","end":"2026-04-21T15:42:45.656917Z","steps":["trace[399835673] 'process raft request' (duration: 182.56797ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:44:10.249624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.934959ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T15:44:10.249789Z","caller":"traceutil/trace.go:171","msg":"trace[1010792922] linearizableReadLoop","detail":"{readStateIndex:5091; appliedIndex:5089; }","duration":"113.359126ms","start":"2026-04-21T15:44:10.136419Z","end":"2026-04-21T15:44:10.249778Z","steps":["trace[1010792922] 'read index received' (duration: 110.402256ms)","trace[1010792922] 'applied index is now lower than readState.Index' (duration: 2.95615ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:44:10.249851Z","caller":"traceutil/trace.go:171","msg":"trace[1451420894] transaction","detail":"{read_only:false; response_revision:4907; number_of_response:1; }","duration":"119.214096ms","start":"2026-04-21T15:44:10.130627Z","end":"2026-04-21T15:44:10.249841Z","steps":["trace[1451420894] 'process raft request' (duration: 119.082053ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:44:10.249941Z","caller":"traceutil/trace.go:171","msg":"trace[1008461172] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"168.730073ms","start":"2026-04-21T15:44:10.081096Z","end":"2026-04-21T15:44:10.249827Z","steps":["trace[1008461172] 'process raft request' (duration: 41.523988ms)","trace[1008461172] 'compare' (duration: 126.715443ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:44:10.250057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.644722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-cpnj4\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-21T15:44:10.250077Z","caller":"traceutil/trace.go:171","msg":"trace[1268478744] range","detail":"{range_begin:/registry/pods/openstack/keepalived-cpnj4; range_end:; response_count:1; response_revision:4907; }","duration":"113.695194ms","start":"2026-04-21T15:44:10.136377Z","end":"2026-04-21T15:44:10.250072Z","steps":["trace[1268478744] 'agreement among raft nodes before linearized reading' (duration: 113.600651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:44:21.848229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.502692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:44:21.848346Z","caller":"traceutil/trace.go:171","msg":"trace[113388472] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5139; }","duration":"140.683126ms","start":"2026-04-21T15:44:21.707637Z","end":"2026-04-21T15:44:21.848321Z","steps":["trace[113388472] 'range keys from in-memory index tree' (duration: 140.378459ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:44:29.638268Z","caller":"traceutil/trace.go:171","msg":"trace[1284087879] transaction","detail":"{read_only:false; response_revision:5308; number_of_response:1; }","duration":"129.595833ms","start":"2026-04-21T15:44:29.508645Z","end":"2026-04-21T15:44:29.638241Z","steps":["trace[1284087879] 'process raft request' (duration: 88.620488ms)","trace[1284087879] 'compare' (duration: 40.861682ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:44:29.816755Z","caller":"traceutil/trace.go:171","msg":"trace[1503396242] transaction","detail":"{read_only:false; response_revision:5309; number_of_response:1; }","duration":"122.910123ms","start":"2026-04-21T15:44:29.693811Z","end":"2026-04-21T15:44:29.816721Z","steps":["trace[1503396242] 'process raft request' (duration: 47.07558ms)","trace[1503396242] 'compare' (duration: 75.68612ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:44:29.831075Z","caller":"traceutil/trace.go:171","msg":"trace[2038034861] linearizableReadLoop","detail":"{readStateIndex:5505; appliedIndex:5503; }","duration":"125.173818ms","start":"2026-04-21T15:44:29.705872Z","end":"2026-04-21T15:44:29.831046Z","steps":["trace[2038034861] 'read index received' (duration: 34.985433ms)","trace[2038034861] 'applied index is now lower than readState.Index' (duration: 90.187085ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:44:29.831127Z","caller":"traceutil/trace.go:171","msg":"trace[1491722021] transaction","detail":"{read_only:false; response_revision:5310; number_of_response:1; }","duration":"134.97994ms","start":"2026-04-21T15:44:29.696119Z","end":"2026-04-21T15:44:29.831099Z","steps":["trace[1491722021] 'process raft request' (duration: 134.748895ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:44:29.831226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.344531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:44:29.831295Z","caller":"traceutil/trace.go:171","msg":"trace[407352355] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5310; }","duration":"125.472654ms","start":"2026-04-21T15:44:29.705809Z","end":"2026-04-21T15:44:29.831281Z","steps":["trace[407352355] 'agreement among raft nodes before linearized reading' (duration: 125.363082ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:44:30.119471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.182737ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T15:44:30.119627Z","caller":"traceutil/trace.go:171","msg":"trace[1520101525] transaction","detail":"{read_only:false; response_revision:5311; number_of_response:1; }","duration":"207.401904ms","start":"2026-04-21T15:44:29.912205Z","end":"2026-04-21T15:44:30.119607Z","steps":["trace[1520101525] 'process raft request' (duration: 76.979991ms)","trace[1520101525] 'compare' (duration: 129.933581ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:44:35.742101Z","caller":"traceutil/trace.go:171","msg":"trace[35992135] transaction","detail":"{read_only:false; response_revision:5411; number_of_response:1; }","duration":"133.183328ms","start":"2026-04-21T15:44:35.608883Z","end":"2026-04-21T15:44:35.742066Z","steps":["trace[35992135] 'process raft request' (duration: 132.585874ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:46:08.204026Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2996} {"level":"info","ts":"2026-04-21T15:46:08.288502Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2996,"took":"82.83963ms","hash":1296395293,"current-db-size-bytes":59064320,"current-db-size":"59 MB","current-db-size-in-use-bytes":34250752,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-21T15:46:08.288557Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1296395293,"revision":2996,"compact-revision":-1} {"level":"info","ts":"2026-04-21T15:50:45.884089Z","caller":"traceutil/trace.go:171","msg":"trace[820825153] linearizableReadLoop","detail":"{readStateIndex:8478; appliedIndex:8477; }","duration":"175.120894ms","start":"2026-04-21T15:50:45.708932Z","end":"2026-04-21T15:50:45.884053Z","steps":["trace[820825153] 'read index received' (duration: 12.777424ms)","trace[820825153] 'applied index is now lower than readState.Index' (duration: 162.34232ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:50:45.884147Z","caller":"traceutil/trace.go:171","msg":"trace[652444571] transaction","detail":"{read_only:false; response_revision:8193; number_of_response:1; }","duration":"175.679978ms","start":"2026-04-21T15:50:45.70844Z","end":"2026-04-21T15:50:45.88412Z","steps":["trace[652444571] 'process raft request' (duration: 173.407534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:50:45.884282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.34592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:50:45.884424Z","caller":"traceutil/trace.go:171","msg":"trace[61293240] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8193; }","duration":"175.466083ms","start":"2026-04-21T15:50:45.708873Z","end":"2026-04-21T15:50:45.884339Z","steps":["trace[61293240] 'agreement among raft nodes before linearized reading' (duration: 175.33295ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:50:57.652236Z","caller":"traceutil/trace.go:171","msg":"trace[57886207] transaction","detail":"{read_only:false; response_revision:8257; number_of_response:1; }","duration":"226.431733ms","start":"2026-04-21T15:50:57.425771Z","end":"2026-04-21T15:50:57.652203Z","steps":["trace[57886207] 'process raft request' (duration: 160.458175ms)","trace[57886207] 'compare' (duration: 65.576439ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:50:58.008862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.292715ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T15:50:58.009006Z","caller":"traceutil/trace.go:171","msg":"trace[1522842458] linearizableReadLoop","detail":"{readStateIndex:8546; appliedIndex:8545; }","duration":"168.60526ms","start":"2026-04-21T15:50:57.840378Z","end":"2026-04-21T15:50:58.008984Z","steps":["trace[1522842458] 'read index received' (duration: 40.511µs)","trace[1522842458] 'applied index is now lower than readState.Index' (duration: 168.562888ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:50:58.009034Z","caller":"traceutil/trace.go:171","msg":"trace[925150592] transaction","detail":"{read_only:false; response_revision:8258; number_of_response:1; }","duration":"244.655038ms","start":"2026-04-21T15:50:57.764346Z","end":"2026-04-21T15:50:58.009001Z","steps":["trace[925150592] 'process raft request' (duration: 25.111247ms)","trace[925150592] 'compare' (duration: 219.136721ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:50:58.009151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.769483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T15:50:58.009196Z","caller":"traceutil/trace.go:171","msg":"trace[807198675] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:8258; }","duration":"168.864355ms","start":"2026-04-21T15:50:57.840322Z","end":"2026-04-21T15:50:58.009186Z","steps":["trace[807198675] 'agreement among raft nodes before linearized reading' (duration: 168.730132ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:50:58.061191Z","caller":"traceutil/trace.go:171","msg":"trace[2087439326] transaction","detail":"{read_only:false; response_revision:8259; number_of_response:1; }","duration":"144.884285ms","start":"2026-04-21T15:50:57.916271Z","end":"2026-04-21T15:50:58.061156Z","steps":["trace[2087439326] 'process raft request' (duration: 144.745281ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:50:59.335981Z","caller":"traceutil/trace.go:171","msg":"trace[1783323184] transaction","detail":"{read_only:false; response_revision:8265; number_of_response:1; }","duration":"165.786342ms","start":"2026-04-21T15:50:59.170158Z","end":"2026-04-21T15:50:59.335944Z","steps":["trace[1783323184] 'process raft request' (duration: 77.888112ms)","trace[1783323184] 'compare' (duration: 87.717156ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:50:59.400081Z","caller":"traceutil/trace.go:171","msg":"trace[1622227749] transaction","detail":"{read_only:false; response_revision:8266; number_of_response:1; }","duration":"229.410015ms","start":"2026-04-21T15:50:59.170427Z","end":"2026-04-21T15:50:59.399837Z","steps":["trace[1622227749] 'process raft request' (duration: 229.265732ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:50:59.429599Z","caller":"traceutil/trace.go:171","msg":"trace[1066024797] transaction","detail":"{read_only:false; response_revision:8267; number_of_response:1; }","duration":"165.526376ms","start":"2026-04-21T15:50:59.264035Z","end":"2026-04-21T15:50:59.429561Z","steps":["trace[1066024797] 'process raft request' (duration: 165.330442ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:51:08.21141Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6178} {"level":"info","ts":"2026-04-21T15:51:08.308206Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6178,"took":"93.331449ms","hash":1489474192,"current-db-size-bytes":59064320,"current-db-size":"59 MB","current-db-size-in-use-bytes":23076864,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-21T15:51:08.308293Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1489474192,"revision":6178,"compact-revision":2996} {"level":"info","ts":"2026-04-21T15:51:28.553911Z","caller":"traceutil/trace.go:171","msg":"trace[1526124620] transaction","detail":"{read_only:false; response_revision:8477; number_of_response:1; }","duration":"213.707041ms","start":"2026-04-21T15:51:28.340182Z","end":"2026-04-21T15:51:28.553889Z","steps":["trace[1526124620] 'process raft request' (duration: 213.336713ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:51:28.756156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.751752ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T15:51:28.756747Z","caller":"traceutil/trace.go:171","msg":"trace[641831157] transaction","detail":"{read_only:false; response_revision:8478; number_of_response:1; }","duration":"198.581412ms","start":"2026-04-21T15:51:28.558139Z","end":"2026-04-21T15:51:28.75672Z","steps":["trace[641831157] 'process raft request' (duration: 61.174845ms)","trace[641831157] 'compare' (duration: 136.595497ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:51:28.757099Z","caller":"traceutil/trace.go:171","msg":"trace[816292064] transaction","detail":"{read_only:false; response_revision:8479; number_of_response:1; }","duration":"198.880269ms","start":"2026-04-21T15:51:28.55821Z","end":"2026-04-21T15:51:28.75709Z","steps":["trace[816292064] 'process raft request' (duration: 198.05713ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:51:32.362517Z","caller":"traceutil/trace.go:171","msg":"trace[519450307] transaction","detail":"{read_only:false; response_revision:8495; number_of_response:1; }","duration":"210.495826ms","start":"2026-04-21T15:51:32.15199Z","end":"2026-04-21T15:51:32.362486Z","steps":["trace[519450307] 'process raft request' (duration: 210.312012ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:51:32.552981Z","caller":"traceutil/trace.go:171","msg":"trace[407640530] transaction","detail":"{read_only:false; response_revision:8497; number_of_response:1; }","duration":"328.572173ms","start":"2026-04-21T15:51:32.224378Z","end":"2026-04-21T15:51:32.552951Z","steps":["trace[407640530] 'process raft request' (duration: 328.47073ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:51:32.552994Z","caller":"traceutil/trace.go:171","msg":"trace[959052050] transaction","detail":"{read_only:false; response_revision:8496; number_of_response:1; }","duration":"354.471999ms","start":"2026-04-21T15:51:32.198489Z","end":"2026-04-21T15:51:32.552961Z","steps":["trace[959052050] 'process raft request' (duration: 321.926245ms)","trace[959052050] 'compare' (duration: 31.96021ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:51:32.553154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:51:32.224353Z","time spent":"328.712596ms","remote":"127.0.0.1:36960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T15:51:32.553161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:51:32.198465Z","time spent":"354.607493ms","remote":"127.0.0.1:36960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T15:51:32.621614Z","caller":"traceutil/trace.go:171","msg":"trace[1703895732] transaction","detail":"{read_only:false; response_revision:8498; number_of_response:1; }","duration":"187.227382ms","start":"2026-04-21T15:51:32.434369Z","end":"2026-04-21T15:51:32.621596Z","steps":["trace[1703895732] 'process raft request' (duration: 187.124259ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:51:41.782424Z","caller":"traceutil/trace.go:171","msg":"trace[938614664] transaction","detail":"{read_only:false; response_revision:8590; number_of_response:1; }","duration":"180.565283ms","start":"2026-04-21T15:51:41.601836Z","end":"2026-04-21T15:51:41.782401Z","steps":["trace[938614664] 'process raft request' (duration: 180.44644ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:51:41.782464Z","caller":"traceutil/trace.go:171","msg":"trace[1359983796] linearizableReadLoop","detail":"{readStateIndex:8892; appliedIndex:8891; }","duration":"181.589467ms","start":"2026-04-21T15:51:41.600848Z","end":"2026-04-21T15:51:41.782437Z","steps":["trace[1359983796] 'read index received' (duration: 97.560449ms)","trace[1359983796] 'applied index is now lower than readState.Index' (duration: 84.027588ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:51:41.782581Z","caller":"traceutil/trace.go:171","msg":"trace[1265986922] transaction","detail":"{read_only:false; response_revision:8589; number_of_response:1; }","duration":"220.878092ms","start":"2026-04-21T15:51:41.561691Z","end":"2026-04-21T15:51:41.782569Z","steps":["trace[1265986922] 'process raft request' (duration: 136.705379ms)","trace[1265986922] 'compare' (duration: 83.522817ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:51:41.782805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.470367ms","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-04-21T15:51:41.782835Z","caller":"traceutil/trace.go:171","msg":"trace[1446298555] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8590; }","duration":"147.556929ms","start":"2026-04-21T15:51:41.635272Z","end":"2026-04-21T15:51:41.782829Z","steps":["trace[1446298555] 'agreement among raft nodes before linearized reading' (duration: 147.456417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:51:41.78281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.951797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T15:51:41.782881Z","caller":"traceutil/trace.go:171","msg":"trace[331390461] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:8590; }","duration":"182.06723ms","start":"2026-04-21T15:51:41.600792Z","end":"2026-04-21T15:51:41.782859Z","steps":["trace[331390461] 'agreement among raft nodes before linearized reading' (duration: 181.932187ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:51:41.923636Z","caller":"traceutil/trace.go:171","msg":"trace[988272745] transaction","detail":"{read_only:false; response_revision:8591; number_of_response:1; }","duration":"136.884455ms","start":"2026-04-21T15:51:41.786724Z","end":"2026-04-21T15:51:41.923608Z","steps":["trace[988272745] 'process raft request' (duration: 124.429159ms)","trace[988272745] 'compare' (duration: 12.348714ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:51:42.165846Z","caller":"traceutil/trace.go:171","msg":"trace[1796737986] transaction","detail":"{read_only:false; response_revision:8593; number_of_response:1; }","duration":"100.46122ms","start":"2026-04-21T15:51:42.065359Z","end":"2026-04-21T15:51:42.16582Z","steps":["trace[1796737986] 'process raft request' (duration: 100.327606ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:51:42.929142Z","caller":"traceutil/trace.go:171","msg":"trace[1970006390] transaction","detail":"{read_only:false; response_revision:8600; number_of_response:1; }","duration":"122.891282ms","start":"2026-04-21T15:51:42.806213Z","end":"2026-04-21T15:51:42.929104Z","steps":["trace[1970006390] 'process raft request' (duration: 122.608505ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:51:43.063488Z","caller":"traceutil/trace.go:171","msg":"trace[1973764473] transaction","detail":"{read_only:false; response_revision:8601; number_of_response:1; }","duration":"130.097484ms","start":"2026-04-21T15:51:42.933366Z","end":"2026-04-21T15:51:43.063464Z","steps":["trace[1973764473] 'process raft request' (duration: 129.9184ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:51:43.065794Z","caller":"traceutil/trace.go:171","msg":"trace[140993233] transaction","detail":"{read_only:false; response_revision:8602; number_of_response:1; }","duration":"132.061381ms","start":"2026-04-21T15:51:42.933719Z","end":"2026-04-21T15:51:43.065781Z","steps":["trace[140993233] 'process raft request' (duration: 131.923398ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:52:16.890071Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000241f.wal"} {"level":"warn","ts":"2026-04-21T15:52:59.441163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.619186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:52:59.441267Z","caller":"traceutil/trace.go:171","msg":"trace[534177289] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:9343; }","duration":"175.765058ms","start":"2026-04-21T15:52:59.265481Z","end":"2026-04-21T15:52:59.441246Z","steps":["trace[534177289] 'count revisions from in-memory index tree' (duration: 175.546543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:52:59.441688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.129211ms","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-21T15:52:59.441777Z","caller":"traceutil/trace.go:171","msg":"trace[645765029] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:9343; }","duration":"156.266434ms","start":"2026-04-21T15:52:59.285495Z","end":"2026-04-21T15:52:59.441761Z","steps":["trace[645765029] 'count revisions from in-memory index tree' (duration: 156.032139ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:52:59.564769Z","caller":"traceutil/trace.go:171","msg":"trace[1139977233] transaction","detail":"{read_only:false; response_revision:9344; number_of_response:1; }","duration":"118.922866ms","start":"2026-04-21T15:52:59.445819Z","end":"2026-04-21T15:52:59.564742Z","steps":["trace[1139977233] 'process raft request' (duration: 118.750012ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:52:59.574172Z","caller":"traceutil/trace.go:171","msg":"trace[1927056801] transaction","detail":"{read_only:false; response_revision:9345; number_of_response:1; }","duration":"127.566492ms","start":"2026-04-21T15:52:59.446583Z","end":"2026-04-21T15:52:59.57415Z","steps":["trace[1927056801] 'process raft request' (duration: 127.44979ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:53:43.776877Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"61a3fe3fc9dc5d35","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-21T15:53:43.781582Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-21T15:53:43.781766Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-21T15:56:08.219075Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8319} {"level":"info","ts":"2026-04-21T15:56:08.296739Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8319,"took":"75.503704ms","hash":1373345499,"current-db-size-bytes":59064320,"current-db-size":"59 MB","current-db-size-in-use-bytes":24862720,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-21T15:56:08.296798Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1373345499,"revision":8319,"compact-revision":6178} {"level":"info","ts":"2026-04-21T16:01:08.226552Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10710} {"level":"info","ts":"2026-04-21T16:01:08.301229Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10710,"took":"72.789603ms","hash":1651847113,"current-db-size-bytes":59064320,"current-db-size":"59 MB","current-db-size-in-use-bytes":20946944,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-21T16:01:08.301322Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1651847113,"revision":10710,"compact-revision":8319}