{"level":"warn","ts":"2026-06-22T15:43:35.29007Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-22T15:43:35.290199Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156: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-06-22T15:43:35.290277Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-22T15:43:35.290285Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-06-22T15:43:35.290306Z","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-06-22T15:43:35.291193Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-06-22T15:43:35.291276Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156: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-06-22T15:43:35.295928Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.377936ms"} {"level":"info","ts":"2026-06-22T15:43:35.303242Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-06-22T15:43:35.303384Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-06-22T15:43:35.303422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-06-22T15:43:35.303442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-22T15:43:35.303455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-06-22T15:43:35.30353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-06-22T15:43:35.320565Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-22T15:43:35.32495Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-22T15:43:35.330907Z","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-06-22T15:43:35.334144Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-22T15:43:35.334485Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-22T15:43:35.334465Z","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-06-22T15:43:35.334557Z","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-06-22T15:43:35.334575Z","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-06-22T15:43:35.338055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-06-22T15:43:35.342565Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-06-22T15:43:35.343836Z","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-06-22T15:43:35.343896Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-06-22T15:43:35.343939Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-06-22T15:43:35.3441Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-22T15:43:35.344143Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-22T15:43:35.90445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-06-22T15:43:35.904516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-22T15:43:35.904561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-06-22T15:43:35.904581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-06-22T15:43:35.904592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-06-22T15:43:35.904604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-06-22T15:43:35.904677Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-06-22T15:43:35.906267Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-06-22T15:43:35.906625Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T15:43:35.906904Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-22T15:43:35.906915Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T15:43:35.907917Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T15:43:35.907984Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T15:43:35.908009Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-22T15:43:35.908093Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-22T15:43:35.908107Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-22T15:43:35.909216Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-22T15:43:35.911476Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-06-22T15:44:14.377079Z","caller":"traceutil/trace.go:171","msg":"trace[1461481227] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"189.601474ms","start":"2026-06-22T15:44:14.187455Z","end":"2026-06-22T15:44:14.377056Z","steps":["trace[1461481227] 'process raft request' (duration: 189.550933ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:14.377171Z","caller":"traceutil/trace.go:171","msg":"trace[105970954] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"192.227678ms","start":"2026-06-22T15:44:14.184924Z","end":"2026-06-22T15:44:14.377151Z","steps":["trace[105970954] 'process raft request' (duration: 191.925539ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:14.393241Z","caller":"traceutil/trace.go:171","msg":"trace[2028859784] transaction","detail":"{read_only:false; number_of_response:0; response_revision:503; }","duration":"192.486598ms","start":"2026-06-22T15:44:14.200728Z","end":"2026-06-22T15:44:14.393215Z","steps":["trace[2028859784] 'process raft request' (duration: 192.258461ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:14.393335Z","caller":"traceutil/trace.go:171","msg":"trace[2140221966] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"190.319948ms","start":"2026-06-22T15:44:14.202993Z","end":"2026-06-22T15:44:14.393313Z","steps":["trace[2140221966] 'process raft request' (duration: 190.07998ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:14.395151Z","caller":"traceutil/trace.go:171","msg":"trace[1299990866] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"189.555474ms","start":"2026-06-22T15:44:14.204057Z","end":"2026-06-22T15:44:14.393612Z","steps":["trace[1299990866] 'process raft request' (duration: 189.124521ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:14.395941Z","caller":"traceutil/trace.go:171","msg":"trace[277088752] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"184.670717ms","start":"2026-06-22T15:44:14.208977Z","end":"2026-06-22T15:44:14.393648Z","steps":["trace[277088752] 'process raft request' (duration: 184.615895ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:14.396327Z","caller":"traceutil/trace.go:171","msg":"trace[1606492872] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"187.516848ms","start":"2026-06-22T15:44:14.208775Z","end":"2026-06-22T15:44:14.396292Z","steps":["trace[1606492872] 'process raft request' (duration: 184.708877ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:14.400312Z","caller":"traceutil/trace.go:171","msg":"trace[2132900805] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"183.938104ms","start":"2026-06-22T15:44:14.214436Z","end":"2026-06-22T15:44:14.398374Z","steps":["trace[2132900805] 'process raft request' (duration: 181.084512ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:14.404477Z","caller":"traceutil/trace.go:171","msg":"trace[1915498211] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"168.719023ms","start":"2026-06-22T15:44:14.235715Z","end":"2026-06-22T15:44:14.404434Z","steps":["trace[1915498211] 'process raft request' (duration: 164.518938ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:14.416171Z","caller":"traceutil/trace.go:171","msg":"trace[1558828919] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:521; }","duration":"116.147373ms","start":"2026-06-22T15:44:14.299981Z","end":"2026-06-22T15:44:14.416128Z","steps":["trace[1558828919] 'read index received' (duration: 76.812989ms)","trace[1558828919] 'applied index is now lower than readState.Index' (duration: 39.333594ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:44:14.416628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.611928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-22T15:44:14.416671Z","caller":"traceutil/trace.go:171","msg":"trace[2014733160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:512; }","duration":"116.723941ms","start":"2026-06-22T15:44:14.299938Z","end":"2026-06-22T15:44:14.416662Z","steps":["trace[2014733160] 'agreement among raft nodes before linearized reading' (duration: 116.622508ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:21.016307Z","caller":"traceutil/trace.go:171","msg":"trace[22357609] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"102.520342ms","start":"2026-06-22T15:44:20.91376Z","end":"2026-06-22T15:44:21.016281Z","steps":["trace[22357609] 'process raft request' (duration: 101.519583ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:21.414986Z","caller":"traceutil/trace.go:171","msg":"trace[956257631] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"239.919068ms","start":"2026-06-22T15:44:21.175034Z","end":"2026-06-22T15:44:21.414953Z","steps":["trace[956257631] 'read index received' (duration: 226.286814ms)","trace[956257631] 'applied index is now lower than readState.Index' (duration: 13.630814ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:44:21.41529Z","caller":"traceutil/trace.go:171","msg":"trace[35562029] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"334.586713ms","start":"2026-06-22T15:44:21.08068Z","end":"2026-06-22T15:44:21.415267Z","steps":["trace[35562029] 'process raft request' (duration: 320.698916ms)","trace[35562029] 'compare' (duration: 13.144659ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:44:21.415627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.572085ms","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-06-22T15:44:21.415684Z","caller":"traceutil/trace.go:171","msg":"trace[1653177371] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:589; }","duration":"240.675776ms","start":"2026-06-22T15:44:21.174994Z","end":"2026-06-22T15:44:21.415669Z","steps":["trace[1653177371] 'agreement among raft nodes before linearized reading' (duration: 240.467374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:21.415788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.84832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-22T15:44:21.415912Z","caller":"traceutil/trace.go:171","msg":"trace[51623447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:589; }","duration":"141.032553ms","start":"2026-06-22T15:44:21.274852Z","end":"2026-06-22T15:44:21.415884Z","steps":["trace[51623447] 'agreement among raft nodes before linearized reading' (duration: 140.606099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:21.416453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:44:21.080662Z","time spent":"334.677314ms","remote":"127.0.0.1:41312","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-22T15:44:23.030329Z","caller":"traceutil/trace.go:171","msg":"trace[230745764] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"106.20243ms","start":"2026-06-22T15:44:22.924084Z","end":"2026-06-22T15:44:23.030286Z","steps":["trace[230745764] 'process raft request' (duration: 105.990348ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:23.038608Z","caller":"traceutil/trace.go:171","msg":"trace[1856582766] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"111.487117ms","start":"2026-06-22T15:44:22.927107Z","end":"2026-06-22T15:44:23.038594Z","steps":["trace[1856582766] 'process raft request' (duration: 111.145693ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:44:35.787855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.619274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-22T15:44:35.787912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.431658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-22T15:44:35.787973Z","caller":"traceutil/trace.go:171","msg":"trace[1509369325] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:756; }","duration":"212.518129ms","start":"2026-06-22T15:44:35.57544Z","end":"2026-06-22T15:44:35.787958Z","steps":["trace[1509369325] 'range keys from in-memory index tree' (duration: 212.271916ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:44:35.787991Z","caller":"traceutil/trace.go:171","msg":"trace[1588542256] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:756; }","duration":"213.794326ms","start":"2026-06-22T15:44:35.574153Z","end":"2026-06-22T15:44:35.787947Z","steps":["trace[1588542256] 'range keys from in-memory index tree' (duration: 213.395441ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:28.264089Z","caller":"traceutil/trace.go:171","msg":"trace[1744767714] transaction","detail":"{read_only:false; response_revision:1415; number_of_response:1; }","duration":"126.98567ms","start":"2026-06-22T15:45:28.137073Z","end":"2026-06-22T15:45:28.264059Z","steps":["trace[1744767714] 'process raft request' (duration: 115.107335ms)","trace[1744767714] 'compare' (duration: 11.65908ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:45:53.565489Z","caller":"traceutil/trace.go:171","msg":"trace[1875734940] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"328.58362ms","start":"2026-06-22T15:45:53.236876Z","end":"2026-06-22T15:45:53.56546Z","steps":["trace[1875734940] 'process raft request' (duration: 328.412346ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:53.56589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:53.236859Z","time spent":"328.725404ms","remote":"127.0.0.1:41160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T15:45:53.566648Z","caller":"traceutil/trace.go:171","msg":"trace[1663709894] linearizableReadLoop","detail":"{readStateIndex:1899; appliedIndex:1899; }","duration":"275.877535ms","start":"2026-06-22T15:45:53.290757Z","end":"2026-06-22T15:45:53.566634Z","steps":["trace[1663709894] 'read index received' (duration: 275.872975ms)","trace[1663709894] 'applied index is now lower than readState.Index' (duration: 3.66µs)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:45:53.566818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.062269ms","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-06-22T15:45:53.566872Z","caller":"traceutil/trace.go:171","msg":"trace[471866033] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1830; }","duration":"276.155491ms","start":"2026-06-22T15:45:53.290702Z","end":"2026-06-22T15:45:53.566858Z","steps":["trace[471866033] 'agreement among raft nodes before linearized reading' (duration: 276.012368ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:53.60217Z","caller":"traceutil/trace.go:171","msg":"trace[389626095] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"244.57385ms","start":"2026-06-22T15:45:53.357545Z","end":"2026-06-22T15:45:53.602119Z","steps":["trace[389626095] 'process raft request' (duration: 244.382935ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:53.602752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.207206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-22T15:45:53.60284Z","caller":"traceutil/trace.go:171","msg":"trace[1705191022] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1831; }","duration":"187.321579ms","start":"2026-06-22T15:45:53.415494Z","end":"2026-06-22T15:45:53.602815Z","steps":["trace[1705191022] 'agreement among raft nodes before linearized reading' (duration: 187.100304ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:53.757708Z","caller":"traceutil/trace.go:171","msg":"trace[876497203] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"183.423849ms","start":"2026-06-22T15:45:53.574273Z","end":"2026-06-22T15:45:53.757697Z","steps":["trace[876497203] 'process raft request' (duration: 183.340287ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:53.757824Z","caller":"traceutil/trace.go:171","msg":"trace[1725527242] linearizableReadLoop","detail":"{readStateIndex:1904; appliedIndex:1900; }","duration":"155.728138ms","start":"2026-06-22T15:45:53.602088Z","end":"2026-06-22T15:45:53.757816Z","steps":["trace[1725527242] 'read index received' (duration: 60.530975ms)","trace[1725527242] 'applied index is now lower than readState.Index' (duration: 95.196303ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:45:53.757705Z","caller":"traceutil/trace.go:171","msg":"trace[1965419454] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"184.709293ms","start":"2026-06-22T15:45:53.572971Z","end":"2026-06-22T15:45:53.757681Z","steps":["trace[1965419454] 'process raft request' (duration: 184.61442ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:53.757872Z","caller":"traceutil/trace.go:171","msg":"trace[1063592753] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"184.832485ms","start":"2026-06-22T15:45:53.572908Z","end":"2026-06-22T15:45:53.757741Z","steps":["trace[1063592753] 'process raft request' (duration: 184.63243ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:45:53.757936Z","caller":"traceutil/trace.go:171","msg":"trace[1137389679] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"185.00462ms","start":"2026-06-22T15:45:53.572909Z","end":"2026-06-22T15:45:53.757913Z","steps":["trace[1137389679] 'process raft request' (duration: 89.189051ms)","trace[1137389679] 'compare' (duration: 95.316826ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:45:53.758045Z","caller":"traceutil/trace.go:171","msg":"trace[930498983] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"149.434368ms","start":"2026-06-22T15:45:53.608604Z","end":"2026-06-22T15:45:53.758038Z","steps":["trace[930498983] 'process raft request' (duration: 149.057728ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:53.758291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.18618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bb40a6fc-8f94-47ba-9b9b-ada8a2203e3c\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-22T15:45:53.758319Z","caller":"traceutil/trace.go:171","msg":"trace[1245516731] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bb40a6fc-8f94-47ba-9b9b-ada8a2203e3c; range_end:; response_count:1; response_revision:1836; }","duration":"186.25259ms","start":"2026-06-22T15:45:53.572058Z","end":"2026-06-22T15:45:53.758311Z","steps":["trace[1245516731] 'agreement among raft nodes before linearized reading' (duration: 185.785319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:45:54.068196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.344151ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T15:45:54.0683Z","caller":"traceutil/trace.go:171","msg":"trace[957809010] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"300.728928ms","start":"2026-06-22T15:45:53.767556Z","end":"2026-06-22T15:45:54.068285Z","steps":["trace[957809010] 'process raft request' (duration: 153.123121ms)","trace[957809010] 'compare' (duration: 147.205997ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:45:54.068346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:45:53.767531Z","time spent":"300.793741ms","remote":"127.0.0.1:41160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T15:46:31.941376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.863533ms","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-06-22T15:46:31.941451Z","caller":"traceutil/trace.go:171","msg":"trace[1059527888] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2095; }","duration":"120.994716ms","start":"2026-06-22T15:46:31.820441Z","end":"2026-06-22T15:46:31.941436Z","steps":["trace[1059527888] 'range keys from in-memory index tree' (duration: 120.692158ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:46:33.006791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.36721ms","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-06-22T15:46:33.006952Z","caller":"traceutil/trace.go:171","msg":"trace[445287095] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2100; }","duration":"280.567086ms","start":"2026-06-22T15:46:32.726362Z","end":"2026-06-22T15:46:33.00693Z","steps":["trace[445287095] 'range keys from in-memory index tree' (duration: 280.212475ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:46:33.222816Z","caller":"traceutil/trace.go:171","msg":"trace[1125098540] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"212.11543ms","start":"2026-06-22T15:46:33.01064Z","end":"2026-06-22T15:46:33.222756Z","steps":["trace[1125098540] 'process raft request' (duration: 211.904044ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:47:34.472405Z","caller":"traceutil/trace.go:171","msg":"trace[685561560] transaction","detail":"{read_only:false; response_revision:2534; number_of_response:1; }","duration":"170.030064ms","start":"2026-06-22T15:47:34.302314Z","end":"2026-06-22T15:47:34.472344Z","steps":["trace[685561560] 'process raft request' (duration: 169.489168ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:52:10.013061Z","caller":"traceutil/trace.go:171","msg":"trace[1928552965] transaction","detail":"{read_only:false; response_revision:4758; number_of_response:1; }","duration":"137.31195ms","start":"2026-06-22T15:52:09.875719Z","end":"2026-06-22T15:52:10.013031Z","steps":["trace[1928552965] 'process raft request' (duration: 137.146595ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:52:10.026879Z","caller":"traceutil/trace.go:171","msg":"trace[626602881] transaction","detail":"{read_only:false; response_revision:4759; number_of_response:1; }","duration":"149.637819ms","start":"2026-06-22T15:52:09.877212Z","end":"2026-06-22T15:52:10.02685Z","steps":["trace[626602881] 'process raft request' (duration: 149.429124ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:52:10.026883Z","caller":"traceutil/trace.go:171","msg":"trace[1770350869] linearizableReadLoop","detail":"{readStateIndex:4935; appliedIndex:4933; }","duration":"117.393141ms","start":"2026-06-22T15:52:09.909446Z","end":"2026-06-22T15:52:10.026839Z","steps":["trace[1770350869] 'read index received' (duration: 103.440861ms)","trace[1770350869] 'applied index is now lower than readState.Index' (duration: 13.95019ms)"],"step_count":2} {"level":"warn","ts":"2026-06-22T15:52:10.027141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.686319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-22T15:52:10.027189Z","caller":"traceutil/trace.go:171","msg":"trace[1735035361] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4759; }","duration":"117.768061ms","start":"2026-06-22T15:52:09.909395Z","end":"2026-06-22T15:52:10.027163Z","steps":["trace[1735035361] 'agreement among raft nodes before linearized reading' (duration: 117.565436ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:53:35.935421Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2867} {"level":"info","ts":"2026-06-22T15:53:36.0199Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2867,"took":"83.173477ms","hash":3034547801,"current-db-size-bytes":53616640,"current-db-size":"54 MB","current-db-size-in-use-bytes":29122560,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-22T15:53:36.019972Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3034547801,"revision":2867,"compact-revision":-1} {"level":"info","ts":"2026-06-22T15:56:17.912799Z","caller":"traceutil/trace.go:171","msg":"trace[737790085] linearizableReadLoop","detail":"{readStateIndex:6845; appliedIndex:6844; }","duration":"407.149459ms","start":"2026-06-22T15:56:17.505612Z","end":"2026-06-22T15:56:17.912761Z","steps":["trace[737790085] 'read index received' (duration: 402.191041ms)","trace[737790085] 'applied index is now lower than readState.Index' (duration: 4.956978ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:56:17.912837Z","caller":"traceutil/trace.go:171","msg":"trace[803043776] transaction","detail":"{read_only:false; response_revision:6609; number_of_response:1; }","duration":"503.493443ms","start":"2026-06-22T15:56:17.409321Z","end":"2026-06-22T15:56:17.912814Z","steps":["trace[803043776] 'process raft request' (duration: 498.518915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:56:17.913036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:56:17.4093Z","time spent":"503.671598ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T15:56:17.913006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.391576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-22T15:56:17.913828Z","caller":"traceutil/trace.go:171","msg":"trace[2005757270] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6609; }","duration":"408.210818ms","start":"2026-06-22T15:56:17.505597Z","end":"2026-06-22T15:56:17.913808Z","steps":["trace[2005757270] 'agreement among raft nodes before linearized reading' (duration: 407.296073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:56:17.913904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:56:17.505543Z","time spent":"408.333111ms","remote":"127.0.0.1:40978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-22T15:56:17.979462Z","caller":"traceutil/trace.go:171","msg":"trace[344059935] transaction","detail":"{read_only:false; response_revision:6610; number_of_response:1; }","duration":"186.391144ms","start":"2026-06-22T15:56:17.79302Z","end":"2026-06-22T15:56:17.979411Z","steps":["trace[344059935] 'process raft request' (duration: 186.084824ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:56:17.979562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.605759ms","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-06-22T15:56:17.979932Z","caller":"traceutil/trace.go:171","msg":"trace[271774436] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6610; }","duration":"344.907127ms","start":"2026-06-22T15:56:17.634888Z","end":"2026-06-22T15:56:17.979795Z","steps":["trace[271774436] 'agreement among raft nodes before linearized reading' (duration: 344.470175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:56:17.980305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:56:17.634869Z","time spent":"345.200345ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-22T15:56:18.437771Z","caller":"traceutil/trace.go:171","msg":"trace[163976584] linearizableReadLoop","detail":"{readStateIndex:6847; appliedIndex:6846; }","duration":"441.287294ms","start":"2026-06-22T15:56:17.996456Z","end":"2026-06-22T15:56:18.437743Z","steps":["trace[163976584] 'read index received' (duration: 431.136544ms)","trace[163976584] 'applied index is now lower than readState.Index' (duration: 10.14948ms)"],"step_count":2} {"level":"info","ts":"2026-06-22T15:56:18.437781Z","caller":"traceutil/trace.go:171","msg":"trace[977150999] transaction","detail":"{read_only:false; response_revision:6611; number_of_response:1; }","duration":"449.523542ms","start":"2026-06-22T15:56:17.988226Z","end":"2026-06-22T15:56:18.437749Z","steps":["trace[977150999] 'process raft request' (duration: 439.390282ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:56:18.438066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:56:17.988206Z","time spent":"449.665135ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-22T15:56:18.438221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.97599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"warn","ts":"2026-06-22T15:56:18.438234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.663454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"info","ts":"2026-06-22T15:56:18.438383Z","caller":"traceutil/trace.go:171","msg":"trace[144239527] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6611; }","duration":"441.934572ms","start":"2026-06-22T15:56:17.996418Z","end":"2026-06-22T15:56:18.438353Z","steps":["trace[144239527] 'agreement among raft nodes before linearized reading' (duration: 441.456428ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:56:18.438303Z","caller":"traceutil/trace.go:171","msg":"trace[1824253060] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6611; }","duration":"281.098874ms","start":"2026-06-22T15:56:18.15719Z","end":"2026-06-22T15:56:18.438288Z","steps":["trace[1824253060] 'agreement among raft nodes before linearized reading' (duration: 280.892738ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:56:18.438511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.675232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-22T15:56:18.438467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:56:17.996403Z","time spent":"442.045474ms","remote":"127.0.0.1:41216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4806,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"warn","ts":"2026-06-22T15:56:18.43833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.598665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"info","ts":"2026-06-22T15:56:18.438644Z","caller":"traceutil/trace.go:171","msg":"trace[1845794825] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6611; }","duration":"284.811716ms","start":"2026-06-22T15:56:18.15378Z","end":"2026-06-22T15:56:18.438592Z","steps":["trace[1845794825] 'agreement among raft nodes before linearized reading' (duration: 284.530188ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:56:18.438712Z","caller":"traceutil/trace.go:171","msg":"trace[1884839043] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6611; }","duration":"316.992677ms","start":"2026-06-22T15:56:18.121665Z","end":"2026-06-22T15:56:18.438658Z","steps":["trace[1884839043] 'agreement among raft nodes before linearized reading' (duration: 316.229015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:56:18.438904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:56:18.121625Z","time spent":"317.221444ms","remote":"127.0.0.1:41216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4806,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"info","ts":"2026-06-22T15:57:08.94413Z","caller":"traceutil/trace.go:171","msg":"trace[942291805] transaction","detail":"{read_only:false; response_revision:6930; number_of_response:1; }","duration":"129.646956ms","start":"2026-06-22T15:57:08.814462Z","end":"2026-06-22T15:57:08.944109Z","steps":["trace[942291805] 'process raft request' (duration: 128.889832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:57:09.270777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.751538ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-22T15:57:09.270904Z","caller":"traceutil/trace.go:171","msg":"trace[1464238652] transaction","detail":"{read_only:false; response_revision:6931; number_of_response:1; }","duration":"160.486948ms","start":"2026-06-22T15:57:09.1104Z","end":"2026-06-22T15:57:09.270887Z","steps":["trace[1464238652] 'store kv pair into bolt db' {req_type:put; key:/registry/masterleases/199.204.45.156; req_size:118; } (duration: 156.579184ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:57:09.27482Z","caller":"traceutil/trace.go:171","msg":"trace[50071289] transaction","detail":"{read_only:false; response_revision:6932; number_of_response:1; }","duration":"160.956187ms","start":"2026-06-22T15:57:09.113847Z","end":"2026-06-22T15:57:09.274803Z","steps":["trace[50071289] 'process raft request' (duration: 157.025983ms)"],"step_count":1} {"level":"info","ts":"2026-06-22T15:57:09.276418Z","caller":"traceutil/trace.go:171","msg":"trace[1256405134] transaction","detail":"{read_only:false; response_revision:6933; number_of_response:1; }","duration":"127.703684ms","start":"2026-06-22T15:57:09.148702Z","end":"2026-06-22T15:57:09.276406Z","steps":["trace[1256405134] 'process raft request' (duration: 125.827358ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:57:22.109247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.520879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-22T15:57:22.109335Z","caller":"traceutil/trace.go:171","msg":"trace[88514146] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7015; }","duration":"496.651032ms","start":"2026-06-22T15:57:21.612671Z","end":"2026-06-22T15:57:22.109322Z","steps":["trace[88514146] 'range keys from in-memory index tree' (duration: 496.424147ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:57:22.109367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:57:21.612655Z","time spent":"496.704182ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-22T15:57:22.109591Z","caller":"traceutil/trace.go:171","msg":"trace[482567063] transaction","detail":"{read_only:false; response_revision:7016; number_of_response:1; }","duration":"474.394809ms","start":"2026-06-22T15:57:21.635149Z","end":"2026-06-22T15:57:22.109544Z","steps":["trace[482567063] 'process raft request' (duration: 467.955344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:57:22.109714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:57:21.635126Z","time spent":"474.526431ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T15:57:22.11116Z","caller":"traceutil/trace.go:171","msg":"trace[930671095] transaction","detail":"{read_only:false; response_revision:7017; number_of_response:1; }","duration":"405.266396ms","start":"2026-06-22T15:57:21.705858Z","end":"2026-06-22T15:57:22.111125Z","steps":["trace[930671095] 'process raft request' (duration: 405.147484ms)"],"step_count":1} {"level":"warn","ts":"2026-06-22T15:57:22.111323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-22T15:57:21.705835Z","time spent":"405.391268ms","remote":"127.0.0.1:41236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-22T15:58:35.941965Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5528} {"level":"info","ts":"2026-06-22T15:58:36.046194Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5528,"took":"102.889958ms","hash":3088999022,"current-db-size-bytes":53616640,"current-db-size":"54 MB","current-db-size-in-use-bytes":18382848,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-22T15:58:36.046278Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3088999022,"revision":5528,"compact-revision":2867}