{"level":"warn","ts":"2026-03-19T17:52:26.771863Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-19T17:52:26.77199Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.243: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.243:2380","--initial-cluster=instance=https://199.19.213.243:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.243:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.243: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-03-19T17:52:26.772091Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-19T17:52:26.77211Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.243:2380"]} {"level":"info","ts":"2026-03-19T17:52:26.772136Z","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-03-19T17:52:26.773029Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.243:2379"]} {"level":"info","ts":"2026-03-19T17:52:26.773132Z","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.243:2380"],"listen-peer-urls":["https://199.19.213.243:2380"],"advertise-client-urls":["https://199.19.213.243:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.243:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.243: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-03-19T17:52:26.777882Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.480898ms"} {"level":"info","ts":"2026-03-19T17:52:26.785379Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"864e14457b828f9c","cluster-id":"6c0ae60a355554b9"} {"level":"info","ts":"2026-03-19T17:52:26.785457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c switched to configuration voters=()"} {"level":"info","ts":"2026-03-19T17:52:26.785479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became follower at term 0"} {"level":"info","ts":"2026-03-19T17:52:26.785495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 864e14457b828f9c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-19T17:52:26.785504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became follower at term 1"} {"level":"info","ts":"2026-03-19T17:52:26.785547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c switched to configuration voters=(9677694937923227548)"} {"level":"warn","ts":"2026-03-19T17:52:26.800018Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-19T17:52:26.801789Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-19T17:52:26.802929Z","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-03-19T17:52:26.805218Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"864e14457b828f9c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-19T17:52:26.80546Z","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-03-19T17:52:26.805481Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"864e14457b828f9c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-19T17:52:26.805554Z","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-03-19T17:52:26.805611Z","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-03-19T17:52:26.807743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c switched to configuration voters=(9677694937923227548)"} {"level":"info","ts":"2026-03-19T17:52:26.807967Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c0ae60a355554b9","local-member-id":"864e14457b828f9c","added-peer-id":"864e14457b828f9c","added-peer-peer-urls":["https://199.19.213.243:2380"]} {"level":"info","ts":"2026-03-19T17:52:26.80944Z","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-03-19T17:52:26.809675Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.243:2380"} {"level":"info","ts":"2026-03-19T17:52:26.809708Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"864e14457b828f9c","initial-advertise-peer-urls":["https://199.19.213.243:2380"],"listen-peer-urls":["https://199.19.213.243:2380"],"advertise-client-urls":["https://199.19.213.243:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.243:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-19T17:52:26.809761Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-19T17:52:26.809737Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.243:2380"} {"level":"info","ts":"2026-03-19T17:52:27.18714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c is starting a new election at term 1"} {"level":"info","ts":"2026-03-19T17:52:27.187191Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became pre-candidate at term 1"} {"level":"info","ts":"2026-03-19T17:52:27.187222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c received MsgPreVoteResp from 864e14457b828f9c at term 1"} {"level":"info","ts":"2026-03-19T17:52:27.187236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became candidate at term 2"} {"level":"info","ts":"2026-03-19T17:52:27.187248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c received MsgVoteResp from 864e14457b828f9c at term 2"} {"level":"info","ts":"2026-03-19T17:52:27.18726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became leader at term 2"} {"level":"info","ts":"2026-03-19T17:52:27.187276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 864e14457b828f9c elected leader 864e14457b828f9c at term 2"} {"level":"info","ts":"2026-03-19T17:52:27.188114Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"864e14457b828f9c","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.243:2379]}","request-path":"/0/members/864e14457b828f9c/attributes","cluster-id":"6c0ae60a355554b9","publish-timeout":"7s"} {"level":"info","ts":"2026-03-19T17:52:27.188247Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-19T17:52:27.188314Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-19T17:52:27.188515Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-19T17:52:27.188559Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-19T17:52:27.18864Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-19T17:52:27.190828Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c0ae60a355554b9","local-member-id":"864e14457b828f9c","cluster-version":"3.5"} {"level":"info","ts":"2026-03-19T17:52:27.190938Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-19T17:52:27.190984Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-19T17:52:27.191163Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-19T17:52:27.192545Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.243:2379"} {"level":"info","ts":"2026-03-19T17:53:05.149809Z","caller":"traceutil/trace.go:171","msg":"trace[289278000] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"118.906349ms","start":"2026-03-19T17:53:05.030872Z","end":"2026-03-19T17:53:05.149778Z","steps":["trace[289278000] 'process raft request' (duration: 118.773727ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T17:53:05.676371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.677227ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-19T17:53:05.676491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.093528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-03-19T17:53:05.676538Z","caller":"traceutil/trace.go:171","msg":"trace[667802529] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:552; }","duration":"185.905931ms","start":"2026-03-19T17:53:05.490609Z","end":"2026-03-19T17:53:05.676515Z","steps":["trace[667802529] 'range keys from in-memory index tree' (duration: 185.656617ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T17:53:05.676548Z","caller":"traceutil/trace.go:171","msg":"trace[1180621153] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:552; }","duration":"253.200699ms","start":"2026-03-19T17:53:05.423332Z","end":"2026-03-19T17:53:05.676533Z","steps":["trace[1180621153] 'range keys from in-memory index tree' (duration: 252.839501ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T17:53:05.676564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.541943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-l2vv2\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-03-19T17:53:05.676647Z","caller":"traceutil/trace.go:171","msg":"trace[355470042] range","detail":"{range_begin:/registry/pods/kube-system/cilium-l2vv2; range_end:; response_count:1; response_revision:552; }","duration":"236.682956ms","start":"2026-03-19T17:53:05.439942Z","end":"2026-03-19T17:53:05.676625Z","steps":["trace[355470042] 'range keys from in-memory index tree' (duration: 236.337178ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T17:53:05.824516Z","caller":"traceutil/trace.go:171","msg":"trace[1196698906] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"143.658184ms","start":"2026-03-19T17:53:05.680817Z","end":"2026-03-19T17:53:05.824475Z","steps":["trace[1196698906] 'process raft request' (duration: 143.43747ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T17:53:05.837793Z","caller":"traceutil/trace.go:171","msg":"trace[951107085] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"146.469178ms","start":"2026-03-19T17:53:05.691284Z","end":"2026-03-19T17:53:05.837753Z","steps":["trace[951107085] 'process raft request' (duration: 146.288804ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T17:54:19.353318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.716969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a53d6006-aa49-4338-9788-307ae2dc1499\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-03-19T17:54:19.35344Z","caller":"traceutil/trace.go:171","msg":"trace[1282408178] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a53d6006-aa49-4338-9788-307ae2dc1499; range_end:; response_count:1; response_revision:1599; }","duration":"171.909653ms","start":"2026-03-19T17:54:19.181509Z","end":"2026-03-19T17:54:19.353419Z","steps":["trace[1282408178] 'range keys from in-memory index tree' (duration: 171.439904ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T17:54:19.657688Z","caller":"traceutil/trace.go:171","msg":"trace[1315040801] transaction","detail":"{read_only:false; response_revision:1602; number_of_response:1; }","duration":"108.551319ms","start":"2026-03-19T17:54:19.549105Z","end":"2026-03-19T17:54:19.657657Z","steps":["trace[1315040801] 'process raft request' (duration: 24.314391ms)","trace[1315040801] 'compare' (duration: 84.094115ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T17:54:58.020933Z","caller":"traceutil/trace.go:171","msg":"trace[303760555] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"124.153292ms","start":"2026-03-19T17:54:57.896753Z","end":"2026-03-19T17:54:58.020906Z","steps":["trace[303760555] 'process raft request' (duration: 124.088811ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T17:54:58.021014Z","caller":"traceutil/trace.go:171","msg":"trace[31348989] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"124.204514ms","start":"2026-03-19T17:54:57.896781Z","end":"2026-03-19T17:54:58.020986Z","steps":["trace[31348989] 'process raft request' (duration: 24.461682ms)","trace[31348989] 'compare' (duration: 99.457736ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T17:55:03.57574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.239759ms","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-03-19T17:55:03.575855Z","caller":"traceutil/trace.go:171","msg":"trace[1002819853] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1866; }","duration":"153.474063ms","start":"2026-03-19T17:55:03.422352Z","end":"2026-03-19T17:55:03.575826Z","steps":["trace[1002819853] 'range keys from in-memory index tree' (duration: 152.924482ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T17:55:09.772137Z","caller":"traceutil/trace.go:171","msg":"trace[1354249059] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"109.322729ms","start":"2026-03-19T17:55:09.66278Z","end":"2026-03-19T17:55:09.772103Z","steps":["trace[1354249059] 'process raft request' (duration: 109.148006ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T17:56:00.902506Z","caller":"traceutil/trace.go:171","msg":"trace[1690315669] linearizableReadLoop","detail":"{readStateIndex:2416; appliedIndex:2415; }","duration":"156.34984ms","start":"2026-03-19T17:56:00.746116Z","end":"2026-03-19T17:56:00.902466Z","steps":["trace[1690315669] 'read index received' (duration: 156.232558ms)","trace[1690315669] 'applied index is now lower than readState.Index' (duration: 116.352µs)"],"step_count":2} {"level":"info","ts":"2026-03-19T17:56:00.902602Z","caller":"traceutil/trace.go:171","msg":"trace[448972827] transaction","detail":"{read_only:false; response_revision:2322; number_of_response:1; }","duration":"168.279112ms","start":"2026-03-19T17:56:00.734294Z","end":"2026-03-19T17:56:00.902573Z","steps":["trace[448972827] 'process raft request' (duration: 168.043638ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T17:56:00.902702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.554844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-19T17:56:00.90277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.325444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-03-19T17:56:00.902812Z","caller":"traceutil/trace.go:171","msg":"trace[1019334131] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2322; }","duration":"111.421086ms","start":"2026-03-19T17:56:00.79138Z","end":"2026-03-19T17:56:00.902801Z","steps":["trace[1019334131] 'agreement among raft nodes before linearized reading' (duration: 111.261073ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T17:56:00.902807Z","caller":"traceutil/trace.go:171","msg":"trace[1703306064] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2322; }","duration":"156.700077ms","start":"2026-03-19T17:56:00.746082Z","end":"2026-03-19T17:56:00.902782Z","steps":["trace[1703306064] 'agreement among raft nodes before linearized reading' (duration: 156.509213ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T17:56:33.989095Z","caller":"traceutil/trace.go:171","msg":"trace[1405380461] transaction","detail":"{read_only:false; response_revision:2504; number_of_response:1; }","duration":"116.157443ms","start":"2026-03-19T17:56:33.872887Z","end":"2026-03-19T17:56:33.989045Z","steps":["trace[1405380461] 'process raft request' (duration: 115.952979ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T17:58:36.601689Z","caller":"traceutil/trace.go:171","msg":"trace[1438752996] transaction","detail":"{read_only:false; response_revision:3180; number_of_response:1; }","duration":"105.140494ms","start":"2026-03-19T17:58:36.496517Z","end":"2026-03-19T17:58:36.601658Z","steps":["trace[1438752996] 'process raft request' (duration: 105.057252ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T17:58:36.601688Z","caller":"traceutil/trace.go:171","msg":"trace[507779752] transaction","detail":"{read_only:false; response_revision:3179; number_of_response:1; }","duration":"105.44254ms","start":"2026-03-19T17:58:36.496213Z","end":"2026-03-19T17:58:36.601656Z","steps":["trace[507779752] 'process raft request' (duration: 75.87978ms)","trace[507779752] 'compare' (duration: 29.288905ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T18:00:33.62786Z","caller":"traceutil/trace.go:171","msg":"trace[2108576031] linearizableReadLoop","detail":"{readStateIndex:4748; appliedIndex:4747; }","duration":"246.460679ms","start":"2026-03-19T18:00:33.381349Z","end":"2026-03-19T18:00:33.62781Z","steps":["trace[2108576031] 'read index received' (duration: 190.972745ms)","trace[2108576031] 'applied index is now lower than readState.Index' (duration: 55.485704ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T18:00:33.627889Z","caller":"traceutil/trace.go:171","msg":"trace[941415459] transaction","detail":"{read_only:false; response_revision:4565; number_of_response:1; }","duration":"295.36653ms","start":"2026-03-19T18:00:33.332467Z","end":"2026-03-19T18:00:33.627834Z","steps":["trace[941415459] 'process raft request' (duration: 239.933928ms)","trace[941415459] 'compare' (duration: 55.126376ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T18:00:33.628078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.696874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-03-19T18:00:33.628169Z","caller":"traceutil/trace.go:171","msg":"trace[57733207] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4565; }","duration":"246.830048ms","start":"2026-03-19T18:00:33.381318Z","end":"2026-03-19T18:00:33.628148Z","steps":["trace[57733207] 'agreement among raft nodes before linearized reading' (duration: 246.595162ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T18:00:33.628163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.630506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-19T18:00:33.628243Z","caller":"traceutil/trace.go:171","msg":"trace[340465166] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:4565; }","duration":"161.772799ms","start":"2026-03-19T18:00:33.466433Z","end":"2026-03-19T18:00:33.628206Z","steps":["trace[340465166] 'agreement among raft nodes before linearized reading' (duration: 161.624606ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T18:00:33.628414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.342507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-19T18:00:33.628475Z","caller":"traceutil/trace.go:171","msg":"trace[1223833972] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:4565; }","duration":"124.44693ms","start":"2026-03-19T18:00:33.504012Z","end":"2026-03-19T18:00:33.628459Z","steps":["trace[1223833972] 'agreement among raft nodes before linearized reading' (duration: 124.282116ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T18:00:52.635068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.186578ms","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-03-19T18:00:52.635185Z","caller":"traceutil/trace.go:171","msg":"trace[608102420] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4917; }","duration":"101.370031ms","start":"2026-03-19T18:00:52.533789Z","end":"2026-03-19T18:00:52.635159Z","steps":["trace[608102420] 'range keys from in-memory index tree' (duration: 100.950123ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T18:00:52.851747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.439204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T18:00:52.851868Z","caller":"traceutil/trace.go:171","msg":"trace[1043125918] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4919; }","duration":"105.660908ms","start":"2026-03-19T18:00:52.746183Z","end":"2026-03-19T18:00:52.851844Z","steps":["trace[1043125918] 'range keys from in-memory index tree' (duration: 105.356322ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T18:00:53.104073Z","caller":"traceutil/trace.go:171","msg":"trace[2145666970] transaction","detail":"{read_only:false; response_revision:4920; number_of_response:1; }","duration":"206.191333ms","start":"2026-03-19T18:00:52.897845Z","end":"2026-03-19T18:00:53.104037Z","steps":["trace[2145666970] 'process raft request' (duration: 205.892287ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T18:01:04.847318Z","caller":"traceutil/trace.go:171","msg":"trace[1796044732] transaction","detail":"{read_only:false; response_revision:5109; number_of_response:1; }","duration":"120.344874ms","start":"2026-03-19T18:01:04.726927Z","end":"2026-03-19T18:01:04.847272Z","steps":["trace[1796044732] 'process raft request' (duration: 119.967106ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T18:02:27.262323Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2769} {"level":"info","ts":"2026-03-19T18:02:27.3178Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2769,"took":"53.218617ms","hash":2163858217,"current-db-size-bytes":41304064,"current-db-size":"41 MB","current-db-size-in-use-bytes":30846976,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-03-19T18:02:27.317861Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2163858217,"revision":2769,"compact-revision":-1} {"level":"info","ts":"2026-03-19T18:04:59.335288Z","caller":"traceutil/trace.go:171","msg":"trace[854361467] transaction","detail":"{read_only:false; response_revision:6651; number_of_response:1; }","duration":"653.188735ms","start":"2026-03-19T18:04:58.682078Z","end":"2026-03-19T18:04:59.335267Z","steps":["trace[854361467] 'process raft request' (duration: 653.062143ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T18:04:59.33595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T18:04:58.682054Z","time spent":"653.39349ms","remote":"127.0.0.1:53224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-19T18:04:59.339297Z","caller":"traceutil/trace.go:171","msg":"trace[1212662129] transaction","detail":"{read_only:false; response_revision:6652; number_of_response:1; }","duration":"466.3526ms","start":"2026-03-19T18:04:58.872914Z","end":"2026-03-19T18:04:59.339267Z","steps":["trace[1212662129] 'process raft request' (duration: 466.184867ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T18:04:59.339464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T18:04:58.872887Z","time spent":"466.491592ms","remote":"127.0.0.1:53224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-19T18:04:59.339494Z","caller":"traceutil/trace.go:171","msg":"trace[1490513557] linearizableReadLoop","detail":"{readStateIndex:6907; appliedIndex:6904; }","duration":"184.230554ms","start":"2026-03-19T18:04:59.155243Z","end":"2026-03-19T18:04:59.339474Z","steps":["trace[1490513557] 'read index received' (duration: 179.96996ms)","trace[1490513557] 'applied index is now lower than readState.Index' (duration: 4.259304ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T18:04:59.339778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.533751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-03-19T18:04:59.339862Z","caller":"traceutil/trace.go:171","msg":"trace[197987752] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6653; }","duration":"184.660094ms","start":"2026-03-19T18:04:59.155189Z","end":"2026-03-19T18:04:59.339849Z","steps":["trace[197987752] 'agreement among raft nodes before linearized reading' (duration: 184.46202ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T18:04:59.33991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.764217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-19T18:04:59.340052Z","caller":"traceutil/trace.go:171","msg":"trace[109275652] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:6653; }","duration":"168.964141ms","start":"2026-03-19T18:04:59.171057Z","end":"2026-03-19T18:04:59.340021Z","steps":["trace[109275652] 'agreement among raft nodes before linearized reading' (duration: 168.725046ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T18:04:59.340346Z","caller":"traceutil/trace.go:171","msg":"trace[1789369209] transaction","detail":"{read_only:false; response_revision:6653; number_of_response:1; }","duration":"441.887795ms","start":"2026-03-19T18:04:58.898431Z","end":"2026-03-19T18:04:59.340318Z","steps":["trace[1789369209] 'process raft request' (duration: 440.797062ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T18:04:59.340374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.778547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-rpt5g\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-03-19T18:04:59.340435Z","caller":"traceutil/trace.go:171","msg":"trace[1111704456] range","detail":"{range_begin:/registry/pods/openstack/keepalived-rpt5g; range_end:; response_count:1; response_revision:6653; }","duration":"176.859819ms","start":"2026-03-19T18:04:59.16356Z","end":"2026-03-19T18:04:59.34042Z","steps":["trace[1111704456] 'agreement among raft nodes before linearized reading' (duration: 176.173074ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T18:04:59.340601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T18:04:58.898392Z","time spent":"442.027458ms","remote":"127.0.0.1:53224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-19T18:05:01.860566Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10348318698157040047,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-19T18:05:01.876Z","caller":"traceutil/trace.go:171","msg":"trace[923896021] transaction","detail":"{read_only:false; response_revision:6664; number_of_response:1; }","duration":"520.472793ms","start":"2026-03-19T18:05:01.355503Z","end":"2026-03-19T18:05:01.875976Z","steps":["trace[923896021] 'process raft request' (duration: 519.649806ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T18:05:01.876161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T18:05:01.355485Z","time spent":"520.590306ms","remote":"127.0.0.1:53224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-19T18:05:01.876377Z","caller":"traceutil/trace.go:171","msg":"trace[1373664629] transaction","detail":"{read_only:false; response_revision:6666; number_of_response:1; }","duration":"520.613736ms","start":"2026-03-19T18:05:01.355737Z","end":"2026-03-19T18:05:01.876351Z","steps":["trace[1373664629] 'process raft request' (duration: 520.410722ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T18:05:01.876452Z","caller":"traceutil/trace.go:171","msg":"trace[1433586357] transaction","detail":"{read_only:false; response_revision:6665; number_of_response:1; }","duration":"520.799869ms","start":"2026-03-19T18:05:01.355576Z","end":"2026-03-19T18:05:01.876376Z","steps":["trace[1433586357] 'process raft request' (duration: 520.32002ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T18:05:01.876669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T18:05:01.35555Z","time spent":"521.011193ms","remote":"127.0.0.1:53224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-19T18:05:01.876736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T18:05:01.355725Z","time spent":"520.731298ms","remote":"127.0.0.1:53224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-19T18:05:01.877087Z","caller":"traceutil/trace.go:171","msg":"trace[832961965] linearizableReadLoop","detail":"{readStateIndex:6922; appliedIndex:6918; }","duration":"517.098807ms","start":"2026-03-19T18:05:01.359966Z","end":"2026-03-19T18:05:01.877065Z","steps":["trace[832961965] 'read index received' (duration: 515.156988ms)","trace[832961965] 'applied index is now lower than readState.Index' (duration: 1.941019ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T18:05:01.87717Z","caller":"traceutil/trace.go:171","msg":"trace[1850632431] transaction","detail":"{read_only:false; response_revision:6667; number_of_response:1; }","duration":"457.910832ms","start":"2026-03-19T18:05:01.419244Z","end":"2026-03-19T18:05:01.877155Z","steps":["trace[1850632431] 'process raft request' (duration: 457.745068ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T18:05:01.877355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T18:05:01.419227Z","time spent":"458.075705ms","remote":"127.0.0.1:53224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-19T18:05:01.877439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.460974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:18 size:161421"} {"level":"info","ts":"2026-03-19T18:05:01.877471Z","caller":"traceutil/trace.go:171","msg":"trace[862219177] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:18; response_revision:6667; }","duration":"517.535235ms","start":"2026-03-19T18:05:01.359927Z","end":"2026-03-19T18:05:01.877462Z","steps":["trace[862219177] 'agreement among raft nodes before linearized reading' (duration: 517.251009ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T18:05:01.877496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T18:05:01.359922Z","time spent":"517.567275ms","remote":"127.0.0.1:53144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":18,"response size":161444,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"warn","ts":"2026-03-19T18:05:01.877459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.346196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-barbican-default-user\" ","response":"range_response_count:1 size:1162"} {"level":"info","ts":"2026-03-19T18:05:01.877651Z","caller":"traceutil/trace.go:171","msg":"trace[544052403] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-barbican-default-user; range_end:; response_count:1; response_revision:6667; }","duration":"419.53095ms","start":"2026-03-19T18:05:01.458026Z","end":"2026-03-19T18:05:01.877557Z","steps":["trace[544052403] 'agreement among raft nodes before linearized reading' (duration: 419.177554ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T18:05:01.877715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-19T18:05:01.458012Z","time spent":"419.685854ms","remote":"127.0.0.1:53038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1185,"request content":"key:\"/registry/secrets/openstack/rabbitmq-barbican-default-user\" "} {"level":"info","ts":"2026-03-19T18:07:06.751809Z","caller":"traceutil/trace.go:171","msg":"trace[1791306985] transaction","detail":"{read_only:false; response_revision:7644; number_of_response:1; }","duration":"104.230008ms","start":"2026-03-19T18:07:06.646864Z","end":"2026-03-19T18:07:06.751094Z","steps":["trace[1791306985] 'process raft request' (duration: 15.002309ms)","trace[1791306985] 'compare' (duration: 89.030145ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T18:07:27.268699Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5726} {"level":"info","ts":"2026-03-19T18:07:27.362743Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5726,"took":"91.257777ms","hash":2553963591,"current-db-size-bytes":44421120,"current-db-size":"44 MB","current-db-size-in-use-bytes":23261184,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-03-19T18:07:27.3628Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2553963591,"revision":5726,"compact-revision":2769} {"level":"info","ts":"2026-03-19T18:07:36.34908Z","caller":"traceutil/trace.go:171","msg":"trace[992879772] transaction","detail":"{read_only:false; response_revision:7841; number_of_response:1; }","duration":"122.600134ms","start":"2026-03-19T18:07:36.22644Z","end":"2026-03-19T18:07:36.34904Z","steps":["trace[992879772] 'process raft request' (duration: 122.42279ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T18:07:47.075298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.508872ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-19T18:07:47.07542Z","caller":"traceutil/trace.go:171","msg":"trace[1822818185] linearizableReadLoop","detail":"{readStateIndex:8242; appliedIndex:8241; }","duration":"132.172455ms","start":"2026-03-19T18:07:46.943229Z","end":"2026-03-19T18:07:47.075401Z","steps":["trace[1822818185] 'read index received' (duration: 21.426258ms)","trace[1822818185] 'applied index is now lower than readState.Index' (duration: 110.744517ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T18:07:47.075522Z","caller":"traceutil/trace.go:171","msg":"trace[1157840496] transaction","detail":"{read_only:false; response_revision:7940; number_of_response:1; }","duration":"186.980792ms","start":"2026-03-19T18:07:46.888526Z","end":"2026-03-19T18:07:47.075507Z","steps":["trace[1157840496] 'process raft request' (duration: 76.022881ms)","trace[1157840496] 'compare' (duration: 110.340629ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T18:07:47.075666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.076133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-19T18:07:47.075769Z","caller":"traceutil/trace.go:171","msg":"trace[760995258] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:7940; }","duration":"108.256457ms","start":"2026-03-19T18:07:46.967493Z","end":"2026-03-19T18:07:47.075749Z","steps":["trace[760995258] 'agreement among raft nodes before linearized reading' (duration: 108.074843ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T18:07:47.076064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.804317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-03-19T18:07:47.076172Z","caller":"traceutil/trace.go:171","msg":"trace[1726735041] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7940; }","duration":"132.96129ms","start":"2026-03-19T18:07:46.943177Z","end":"2026-03-19T18:07:47.076138Z","steps":["trace[1726735041] 'agreement among raft nodes before linearized reading' (duration: 132.766286ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T18:07:47.255763Z","caller":"traceutil/trace.go:171","msg":"trace[874220064] linearizableReadLoop","detail":"{readStateIndex:8243; appliedIndex:8242; }","duration":"170.270908ms","start":"2026-03-19T18:07:47.085472Z","end":"2026-03-19T18:07:47.255743Z","steps":["trace[874220064] 'read index received' (duration: 117.42056ms)","trace[874220064] 'applied index is now lower than readState.Index' (duration: 52.849078ms)"],"step_count":2} {"level":"info","ts":"2026-03-19T18:07:47.255808Z","caller":"traceutil/trace.go:171","msg":"trace[70271674] transaction","detail":"{read_only:false; response_revision:7941; number_of_response:1; }","duration":"170.678275ms","start":"2026-03-19T18:07:47.085108Z","end":"2026-03-19T18:07:47.255786Z","steps":["trace[70271674] 'process raft request' (duration: 117.830667ms)","trace[70271674] 'compare' (duration: 52.458731ms)"],"step_count":2} {"level":"warn","ts":"2026-03-19T18:07:47.255932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.41621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-03-19T18:07:47.255957Z","caller":"traceutil/trace.go:171","msg":"trace[1698846052] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7941; }","duration":"170.518693ms","start":"2026-03-19T18:07:47.085433Z","end":"2026-03-19T18:07:47.255951Z","steps":["trace[1698846052] 'agreement among raft nodes before linearized reading' (duration: 170.38846ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T18:07:47.278514Z","caller":"traceutil/trace.go:171","msg":"trace[1412379669] transaction","detail":"{read_only:false; response_revision:7942; number_of_response:1; }","duration":"192.948712ms","start":"2026-03-19T18:07:47.085549Z","end":"2026-03-19T18:07:47.278498Z","steps":["trace[1412379669] 'process raft request' (duration: 192.87424ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T18:07:47.943069Z","caller":"traceutil/trace.go:171","msg":"trace[911105131] transaction","detail":"{read_only:false; response_revision:7948; number_of_response:1; }","duration":"159.807348ms","start":"2026-03-19T18:07:47.783222Z","end":"2026-03-19T18:07:47.94303Z","steps":["trace[911105131] 'process raft request' (duration: 159.469271ms)"],"step_count":1} {"level":"warn","ts":"2026-03-19T18:08:49.204949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.205025ms","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-03-19T18:08:49.205067Z","caller":"traceutil/trace.go:171","msg":"trace[1871548403] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8574; }","duration":"103.385279ms","start":"2026-03-19T18:08:49.101659Z","end":"2026-03-19T18:08:49.205044Z","steps":["trace[1871548403] 'range keys from in-memory index tree' (duration: 103.007192ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T18:09:01.324514Z","caller":"traceutil/trace.go:171","msg":"trace[1692569014] transaction","detail":"{read_only:false; response_revision:8639; number_of_response:1; }","duration":"181.689046ms","start":"2026-03-19T18:09:01.142795Z","end":"2026-03-19T18:09:01.324484Z","steps":["trace[1692569014] 'process raft request' (duration: 181.460622ms)"],"step_count":1} {"level":"info","ts":"2026-03-19T18:11:22.473685Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"864e14457b828f9c","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-19T18:11:22.478904Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-19T18:11:22.478998Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-19T18:12:27.275247Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7755} {"level":"info","ts":"2026-03-19T18:12:27.338189Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7755,"took":"60.535856ms","hash":1655221688,"current-db-size-bytes":44421120,"current-db-size":"44 MB","current-db-size-in-use-bytes":25755648,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-03-19T18:12:27.338247Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1655221688,"revision":7755,"compact-revision":5726} {"level":"info","ts":"2026-03-19T18:17:27.281516Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9997} {"level":"info","ts":"2026-03-19T18:17:27.357565Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9997,"took":"73.668763ms","hash":691396499,"current-db-size-bytes":44421120,"current-db-size":"44 MB","current-db-size-in-use-bytes":16904192,"current-db-size-in-use":"17 MB"} {"level":"info","ts":"2026-03-19T18:17:27.35762Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":691396499,"revision":9997,"compact-revision":7755}