{"level":"warn","ts":"2026-04-07T00:05:43.875216Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T00:05:43.875304Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.65: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.65:2380","--initial-cluster=instance=https://199.19.213.65:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.65:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.65:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-07T00:05:43.875373Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T00:05:43.875382Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.65:2380"]} {"level":"info","ts":"2026-04-07T00:05:43.875397Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-07T00:05:43.876015Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.65:2379"]} {"level":"info","ts":"2026-04-07T00:05:43.876081Z","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.19.213.65:2380"],"listen-peer-urls":["https://199.19.213.65:2380"],"advertise-client-urls":["https://199.19.213.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.65:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-07T00:05:43.879933Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.651252ms"} {"level":"info","ts":"2026-04-07T00:05:43.889522Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a071a454a8148542","cluster-id":"aa233e43aeaf7fe5"} {"level":"info","ts":"2026-04-07T00:05:43.889655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T00:05:43.889694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became follower at term 0"} {"level":"info","ts":"2026-04-07T00:05:43.88971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a071a454a8148542 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T00:05:43.88973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became follower at term 1"} {"level":"info","ts":"2026-04-07T00:05:43.889789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 switched to configuration voters=(11561202401940899138)"} {"level":"warn","ts":"2026-04-07T00:05:43.898472Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T00:05:43.899652Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T00:05:43.900694Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-07T00:05:43.902756Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a071a454a8148542","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T00:05:43.903197Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a071a454a8148542","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T00:05:43.903126Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T00:05:43.903391Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T00:05:43.903409Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T00:05:43.907063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 switched to configuration voters=(11561202401940899138)"} {"level":"info","ts":"2026-04-07T00:05:43.907236Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aa233e43aeaf7fe5","local-member-id":"a071a454a8148542","added-peer-id":"a071a454a8148542","added-peer-peer-urls":["https://199.19.213.65:2380"]} {"level":"info","ts":"2026-04-07T00:05:43.908761Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-07T00:05:43.908842Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.65:2380"} {"level":"info","ts":"2026-04-07T00:05:43.908878Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.65:2380"} {"level":"info","ts":"2026-04-07T00:05:43.909071Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a071a454a8148542","initial-advertise-peer-urls":["https://199.19.213.65:2380"],"listen-peer-urls":["https://199.19.213.65:2380"],"advertise-client-urls":["https://199.19.213.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T00:05:43.909118Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T00:05:44.590265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T00:05:44.590356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T00:05:44.590375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 received MsgPreVoteResp from a071a454a8148542 at term 1"} {"level":"info","ts":"2026-04-07T00:05:44.590391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became candidate at term 2"} {"level":"info","ts":"2026-04-07T00:05:44.5904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 received MsgVoteResp from a071a454a8148542 at term 2"} {"level":"info","ts":"2026-04-07T00:05:44.59041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became leader at term 2"} {"level":"info","ts":"2026-04-07T00:05:44.59042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a071a454a8148542 elected leader a071a454a8148542 at term 2"} {"level":"info","ts":"2026-04-07T00:05:44.592204Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a071a454a8148542","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.65:2379]}","request-path":"/0/members/a071a454a8148542/attributes","cluster-id":"aa233e43aeaf7fe5","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T00:05:44.592352Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T00:05:44.59244Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T00:05:44.592856Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:05:44.594028Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aa233e43aeaf7fe5","local-member-id":"a071a454a8148542","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:05:44.594129Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:05:44.594231Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:05:44.594864Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.65:2379"} {"level":"info","ts":"2026-04-07T00:05:44.59569Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T00:05:44.596356Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T00:05:44.599361Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T00:05:48.710424Z","caller":"traceutil/trace.go:171","msg":"trace[1690426252] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"355.283777ms","start":"2026-04-07T00:05:48.355115Z","end":"2026-04-07T00:05:48.710399Z","steps":["trace[1690426252] 'process raft request' (duration: 355.112855ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:05:48.710972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:05:48.355097Z","time spent":"355.435678ms","remote":"127.0.0.1:43566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T00:05:49.069152Z","caller":"traceutil/trace.go:171","msg":"trace[1482396198] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"353.881939ms","start":"2026-04-07T00:05:48.71523Z","end":"2026-04-07T00:05:49.069112Z","steps":["trace[1482396198] 'process raft request' (duration: 353.09855ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:05:49.069277Z","caller":"traceutil/trace.go:171","msg":"trace[1619109508] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"352.619405ms","start":"2026-04-07T00:05:48.71664Z","end":"2026-04-07T00:05:49.069259Z","steps":["trace[1619109508] 'process raft request' (duration: 352.427893ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:05:49.069253Z","caller":"traceutil/trace.go:171","msg":"trace[715418528] linearizableReadLoop","detail":"{readStateIndex:264; appliedIndex:260; }","duration":"344.417222ms","start":"2026-04-07T00:05:48.72481Z","end":"2026-04-07T00:05:49.069227Z","steps":["trace[715418528] 'read index received' (duration: 78.009299ms)","trace[715418528] 'applied index is now lower than readState.Index' (duration: 266.406932ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:05:49.069391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.560123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T00:05:49.070093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.417408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T00:05:49.070138Z","caller":"traceutil/trace.go:171","msg":"trace[944070751] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:0; response_revision:258; }","duration":"345.339052ms","start":"2026-04-07T00:05:48.724786Z","end":"2026-04-07T00:05:49.070125Z","steps":["trace[944070751] 'agreement among raft nodes before linearized reading' (duration: 344.536793ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:05:49.070151Z","caller":"traceutil/trace.go:171","msg":"trace[1691912577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:258; }","duration":"263.50813ms","start":"2026-04-07T00:05:48.806629Z","end":"2026-04-07T00:05:49.070138Z","steps":["trace[1691912577] 'agreement among raft nodes before linearized reading' (duration: 263.415819ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:05:49.070184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:05:48.724779Z","time spent":"345.380452ms","remote":"127.0.0.1:43488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" "} {"level":"info","ts":"2026-04-07T00:05:49.069452Z","caller":"traceutil/trace.go:171","msg":"trace[1703570932] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"347.953332ms","start":"2026-04-07T00:05:48.721489Z","end":"2026-04-07T00:05:49.069442Z","steps":["trace[1703570932] 'process raft request' (duration: 347.698489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:05:49.070234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:05:48.716618Z","time spent":"353.237522ms","remote":"127.0.0.1:43472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4002,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:05:49.069797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:05:48.715212Z","time spent":"354.337634ms","remote":"127.0.0.1:43366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":753,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T00:05:49.070516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:05:48.721479Z","time spent":"348.791141ms","remote":"127.0.0.1:43566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:06:14.216288Z","caller":"traceutil/trace.go:171","msg":"trace[10713203] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"101.681263ms","start":"2026-04-07T00:06:14.114583Z","end":"2026-04-07T00:06:14.216264Z","steps":["trace[10713203] 'process raft request' (duration: 99.435639ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:06:14.530419Z","caller":"traceutil/trace.go:171","msg":"trace[1918271411] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"111.630791ms","start":"2026-04-07T00:06:14.418758Z","end":"2026-04-07T00:06:14.530389Z","steps":["trace[1918271411] 'process raft request' (duration: 111.457599ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:06:14.539498Z","caller":"traceutil/trace.go:171","msg":"trace[418172553] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"100.35545ms","start":"2026-04-07T00:06:14.439116Z","end":"2026-04-07T00:06:14.539472Z","steps":["trace[418172553] 'process raft request' (duration: 99.825714ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:06:15.27493Z","caller":"traceutil/trace.go:171","msg":"trace[1379496430] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"230.135312ms","start":"2026-04-07T00:06:15.044767Z","end":"2026-04-07T00:06:15.274902Z","steps":["trace[1379496430] 'process raft request' (duration: 229.94728ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:06:20.816996Z","caller":"traceutil/trace.go:171","msg":"trace[1145912939] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"161.417689ms","start":"2026-04-07T00:06:20.655559Z","end":"2026-04-07T00:06:20.816977Z","steps":["trace[1145912939] 'process raft request' (duration: 161.316018ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:06:21.453635Z","caller":"traceutil/trace.go:171","msg":"trace[819397277] linearizableReadLoop","detail":"{readStateIndex:698; appliedIndex:697; }","duration":"145.84282ms","start":"2026-04-07T00:06:21.30777Z","end":"2026-04-07T00:06:21.453617Z","steps":["trace[819397277] 'read index received' (duration: 145.754499ms)","trace[819397277] 'applied index is now lower than readState.Index' (duration: 87.411µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:06:21.453807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.016852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T00:06:21.453779Z","caller":"traceutil/trace.go:171","msg":"trace[590877964] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"147.487637ms","start":"2026-04-07T00:06:21.30626Z","end":"2026-04-07T00:06:21.453748Z","steps":["trace[590877964] 'process raft request' (duration: 147.246585ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:06:21.453842Z","caller":"traceutil/trace.go:171","msg":"trace[1742674978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:677; }","duration":"146.077233ms","start":"2026-04-07T00:06:21.307753Z","end":"2026-04-07T00:06:21.45383Z","steps":["trace[1742674978] 'agreement among raft nodes before linearized reading' (duration: 145.940592ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:06:21.65479Z","caller":"traceutil/trace.go:171","msg":"trace[555381968] linearizableReadLoop","detail":"{readStateIndex:699; appliedIndex:698; }","duration":"156.260111ms","start":"2026-04-07T00:06:21.498502Z","end":"2026-04-07T00:06:21.654762Z","steps":["trace[555381968] 'read index received' (duration: 139.535513ms)","trace[555381968] 'applied index is now lower than readState.Index' (duration: 16.723518ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:06:21.655032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.514974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T00:06:21.655074Z","caller":"traceutil/trace.go:171","msg":"trace[519312109] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:678; }","duration":"156.603295ms","start":"2026-04-07T00:06:21.498462Z","end":"2026-04-07T00:06:21.655065Z","steps":["trace[519312109] 'agreement among raft nodes before linearized reading' (duration: 156.453214ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:06:21.655118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.291318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:06:21.655156Z","caller":"traceutil/trace.go:171","msg":"trace[1062413331] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:678; }","duration":"150.341948ms","start":"2026-04-07T00:06:21.504803Z","end":"2026-04-07T00:06:21.655145Z","steps":["trace[1062413331] 'agreement among raft nodes before linearized reading' (duration: 150.276337ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:06:21.655194Z","caller":"traceutil/trace.go:171","msg":"trace[266577] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"194.547639ms","start":"2026-04-07T00:06:21.460638Z","end":"2026-04-07T00:06:21.655186Z","steps":["trace[266577] 'process raft request' (duration: 177.389586ms)","trace[266577] 'compare' (duration: 16.513056ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:06:38.832451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.361782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T00:06:38.83252Z","caller":"traceutil/trace.go:171","msg":"trace[900886289] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:788; }","duration":"104.477543ms","start":"2026-04-07T00:06:38.728026Z","end":"2026-04-07T00:06:38.832504Z","steps":["trace[900886289] 'range keys from in-memory index tree' (duration: 104.18883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:06:38.832685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.149265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2zbwl\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-07T00:06:38.832708Z","caller":"traceutil/trace.go:171","msg":"trace[2128913822] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2zbwl; range_end:; response_count:1; response_revision:788; }","duration":"147.192726ms","start":"2026-04-07T00:06:38.685509Z","end":"2026-04-07T00:06:38.832702Z","steps":["trace[2128913822] 'range keys from in-memory index tree' (duration: 146.68965ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:07:32.074492Z","caller":"traceutil/trace.go:171","msg":"trace[120968221] linearizableReadLoop","detail":"{readStateIndex:1500; appliedIndex:1499; }","duration":"106.389464ms","start":"2026-04-07T00:07:31.968078Z","end":"2026-04-07T00:07:32.074467Z","steps":["trace[120968221] 'read index received' (duration: 106.334232ms)","trace[120968221] 'applied index is now lower than readState.Index' (duration: 53.822µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:07:32.074591Z","caller":"traceutil/trace.go:171","msg":"trace[2142295401] transaction","detail":"{read_only:false; response_revision:1457; number_of_response:1; }","duration":"116.655063ms","start":"2026-04-07T00:07:31.95788Z","end":"2026-04-07T00:07:32.074535Z","steps":["trace[2142295401] 'process raft request' (duration: 116.424646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:07:32.074654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.554239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:07:32.074694Z","caller":"traceutil/trace.go:171","msg":"trace[1769351804] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1457; }","duration":"106.632062ms","start":"2026-04-07T00:07:31.968049Z","end":"2026-04-07T00:07:32.074681Z","steps":["trace[1769351804] 'agreement among raft nodes before linearized reading' (duration: 106.548789ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:07:57.060636Z","caller":"traceutil/trace.go:171","msg":"trace[1206073114] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"243.370837ms","start":"2026-04-07T00:07:56.817246Z","end":"2026-04-07T00:07:57.060616Z","steps":["trace[1206073114] 'process raft request' (duration: 243.244383ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:07:57.176895Z","caller":"traceutil/trace.go:171","msg":"trace[258019284] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"107.069344ms","start":"2026-04-07T00:07:57.069788Z","end":"2026-04-07T00:07:57.176858Z","steps":["trace[258019284] 'process raft request' (duration: 89.936915ms)","trace[258019284] 'compare' (duration: 16.569533ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:07:57.573846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.478451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T00:07:57.573985Z","caller":"traceutil/trace.go:171","msg":"trace[1844602165] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1866; }","duration":"199.660596ms","start":"2026-04-07T00:07:57.374308Z","end":"2026-04-07T00:07:57.573969Z","steps":["trace[1844602165] 'range keys from in-memory index tree' (duration: 199.265115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:07:57.574235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.095335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-07T00:07:57.574319Z","caller":"traceutil/trace.go:171","msg":"trace[99845039] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1866; }","duration":"203.230139ms","start":"2026-04-07T00:07:57.37107Z","end":"2026-04-07T00:07:57.5743Z","steps":["trace[99845039] 'range keys from in-memory index tree' (duration: 202.894398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:08:00.070202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.721006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:08:00.070278Z","caller":"traceutil/trace.go:171","msg":"trace[1720138132] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1893; }","duration":"185.87791ms","start":"2026-04-07T00:07:59.884385Z","end":"2026-04-07T00:08:00.070263Z","steps":["trace[1720138132] 'count revisions from in-memory index tree' (duration: 185.643944ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:08:00.070477Z","caller":"traceutil/trace.go:171","msg":"trace[1719579376] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"139.478497ms","start":"2026-04-07T00:07:59.93099Z","end":"2026-04-07T00:08:00.070468Z","steps":["trace[1719579376] 'process raft request' (duration: 134.056064ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:08:09.916191Z","caller":"traceutil/trace.go:171","msg":"trace[678897041] transaction","detail":"{read_only:false; response_revision:1969; number_of_response:1; }","duration":"225.3229ms","start":"2026-04-07T00:08:09.690821Z","end":"2026-04-07T00:08:09.916144Z","steps":["trace[678897041] 'process raft request' (duration: 220.220862ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:08:25.931184Z","caller":"traceutil/trace.go:171","msg":"trace[1636269962] transaction","detail":"{read_only:false; response_revision:2071; number_of_response:1; }","duration":"150.830705ms","start":"2026-04-07T00:08:25.780329Z","end":"2026-04-07T00:08:25.93116Z","steps":["trace[1636269962] 'process raft request' (duration: 150.702442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:08:26.114449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.466625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-07T00:08:26.11454Z","caller":"traceutil/trace.go:171","msg":"trace[1046943793] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2071; }","duration":"117.602588ms","start":"2026-04-07T00:08:25.996914Z","end":"2026-04-07T00:08:26.114517Z","steps":["trace[1046943793] 'range keys from in-memory index tree' (duration: 117.25201ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:08:26.774623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.673532ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:08:26.774842Z","caller":"traceutil/trace.go:171","msg":"trace[844295841] transaction","detail":"{read_only:false; response_revision:2077; number_of_response:1; }","duration":"267.994517ms","start":"2026-04-07T00:08:26.506827Z","end":"2026-04-07T00:08:26.774822Z","steps":["trace[844295841] 'process raft request' (duration: 160.881904ms)","trace[844295841] 'compare' (duration: 106.532058ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:08:27.396703Z","caller":"traceutil/trace.go:171","msg":"trace[1116365149] linearizableReadLoop","detail":"{readStateIndex:2153; appliedIndex:2152; }","duration":"119.553855ms","start":"2026-04-07T00:08:27.277121Z","end":"2026-04-07T00:08:27.396675Z","steps":["trace[1116365149] 'read index received' (duration: 119.278059ms)","trace[1116365149] 'applied index is now lower than readState.Index' (duration: 274.666µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:08:27.396845Z","caller":"traceutil/trace.go:171","msg":"trace[1271794810] transaction","detail":"{read_only:false; response_revision:2078; number_of_response:1; }","duration":"135.770845ms","start":"2026-04-07T00:08:27.261017Z","end":"2026-04-07T00:08:27.396787Z","steps":["trace[1271794810] 'process raft request' (duration: 135.491808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:08:27.396913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.773492ms","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-04-07T00:08:27.396958Z","caller":"traceutil/trace.go:171","msg":"trace[1527754392] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2078; }","duration":"119.867564ms","start":"2026-04-07T00:08:27.277077Z","end":"2026-04-07T00:08:27.396944Z","steps":["trace[1527754392] 'agreement among raft nodes before linearized reading' (duration: 119.70042ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:08:27.629547Z","caller":"traceutil/trace.go:171","msg":"trace[100744214] linearizableReadLoop","detail":"{readStateIndex:2154; appliedIndex:2153; }","duration":"205.977006ms","start":"2026-04-07T00:08:27.423553Z","end":"2026-04-07T00:08:27.62953Z","steps":["trace[100744214] 'read index received' (duration: 183.446918ms)","trace[100744214] 'applied index is now lower than readState.Index' (duration: 22.529318ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:08:27.629633Z","caller":"traceutil/trace.go:171","msg":"trace[1017483438] transaction","detail":"{read_only:false; response_revision:2079; number_of_response:1; }","duration":"228.253608ms","start":"2026-04-07T00:08:27.401373Z","end":"2026-04-07T00:08:27.629627Z","steps":["trace[1017483438] 'process raft request' (duration: 205.708049ms)","trace[1017483438] 'compare' (duration: 22.370514ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:08:27.629731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.85506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T00:08:27.629782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.224562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-07T00:08:27.629805Z","caller":"traceutil/trace.go:171","msg":"trace[362703432] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2079; }","duration":"206.294394ms","start":"2026-04-07T00:08:27.423504Z","end":"2026-04-07T00:08:27.629799Z","steps":["trace[362703432] 'agreement among raft nodes before linearized reading' (duration: 206.204892ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:08:27.62982Z","caller":"traceutil/trace.go:171","msg":"trace[779413761] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:2079; }","duration":"149.996114ms","start":"2026-04-07T00:08:27.479802Z","end":"2026-04-07T00:08:27.629798Z","steps":["trace[779413761] 'agreement among raft nodes before linearized reading' (duration: 149.859091ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:08:28.403252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.523338ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-04-07T00:08:28.403335Z","caller":"traceutil/trace.go:171","msg":"trace[858763996] linearizableReadLoop","detail":"{readStateIndex:2155; appliedIndex:2154; }","duration":"467.805862ms","start":"2026-04-07T00:08:27.935516Z","end":"2026-04-07T00:08:28.403322Z","steps":["trace[858763996] 'read index received' (duration: 156.366356ms)","trace[858763996] 'applied index is now lower than readState.Index' (duration: 311.438456ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:08:28.403391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:08:27.630876Z","time spent":"772.510629ms","remote":"127.0.0.1:43312","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-07T00:08:28.403851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.309784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T00:08:28.403977Z","caller":"traceutil/trace.go:171","msg":"trace[914744756] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2079; }","duration":"468.48819ms","start":"2026-04-07T00:08:27.935444Z","end":"2026-04-07T00:08:28.403932Z","steps":["trace[914744756] 'agreement among raft nodes before linearized reading' (duration: 468.149861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:08:28.404028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:08:27.935415Z","time spent":"468.603112ms","remote":"127.0.0.1:43566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T00:08:28.406064Z","caller":"traceutil/trace.go:171","msg":"trace[1117786280] transaction","detail":"{read_only:false; response_revision:2080; number_of_response:1; }","duration":"347.157664ms","start":"2026-04-07T00:08:28.058892Z","end":"2026-04-07T00:08:28.40605Z","steps":["trace[1117786280] 'process raft request' (duration: 346.946328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:08:28.406173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:08:28.058864Z","time spent":"347.230846ms","remote":"127.0.0.1:43566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:08:28.407776Z","caller":"traceutil/trace.go:171","msg":"trace[346754310] transaction","detail":"{read_only:false; response_revision:2081; number_of_response:1; }","duration":"148.184374ms","start":"2026-04-07T00:08:28.259576Z","end":"2026-04-07T00:08:28.407761Z","steps":["trace[346754310] 'process raft request' (duration: 147.969628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:08:28.408543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.355512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-07T00:08:28.408685Z","caller":"traceutil/trace.go:171","msg":"trace[1597536983] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2083; }","duration":"250.550546ms","start":"2026-04-07T00:08:28.158111Z","end":"2026-04-07T00:08:28.408661Z","steps":["trace[1597536983] 'agreement among raft nodes before linearized reading' (duration: 250.203398ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:09:30.749409Z","caller":"traceutil/trace.go:171","msg":"trace[129940272] transaction","detail":"{read_only:false; response_revision:2464; number_of_response:1; }","duration":"102.60414ms","start":"2026-04-07T00:09:30.646769Z","end":"2026-04-07T00:09:30.749373Z","steps":["trace[129940272] 'process raft request' (duration: 12.131757ms)","trace[129940272] 'compare' (duration: 89.953493ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:09:30.75195Z","caller":"traceutil/trace.go:171","msg":"trace[2132112680] transaction","detail":"{read_only:false; response_revision:2465; number_of_response:1; }","duration":"102.769963ms","start":"2026-04-07T00:09:30.649164Z","end":"2026-04-07T00:09:30.751933Z","steps":["trace[2132112680] 'process raft request' (duration: 102.60143ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:09:39.830841Z","caller":"traceutil/trace.go:171","msg":"trace[437719578] transaction","detail":"{read_only:false; response_revision:2571; number_of_response:1; }","duration":"100.238739ms","start":"2026-04-07T00:09:39.730578Z","end":"2026-04-07T00:09:39.830816Z","steps":["trace[437719578] 'process raft request' (duration: 99.872422ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:09:49.365375Z","caller":"traceutil/trace.go:171","msg":"trace[1917835121] transaction","detail":"{read_only:false; response_revision:2631; number_of_response:1; }","duration":"121.516708ms","start":"2026-04-07T00:09:49.243828Z","end":"2026-04-07T00:09:49.365345Z","steps":["trace[1917835121] 'process raft request' (duration: 121.213532ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:10:12.590985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.154276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T00:10:12.591075Z","caller":"traceutil/trace.go:171","msg":"trace[352345758] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2749; }","duration":"202.253608ms","start":"2026-04-07T00:10:12.388801Z","end":"2026-04-07T00:10:12.591055Z","steps":["trace[352345758] 'count revisions from in-memory index tree' (duration: 202.047495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:10:17.789336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.054417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18a3ea9268bbc216\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-04-07T00:10:17.789405Z","caller":"traceutil/trace.go:171","msg":"trace[288535977] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18a3ea9268bbc216; range_end:; response_count:1; response_revision:2780; }","duration":"129.174858ms","start":"2026-04-07T00:10:17.660215Z","end":"2026-04-07T00:10:17.78939Z","steps":["trace[288535977] 'range keys from in-memory index tree' (duration: 128.69003ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:13:15.836257Z","caller":"traceutil/trace.go:171","msg":"trace[476571477] transaction","detail":"{read_only:false; response_revision:3847; number_of_response:1; }","duration":"117.474292ms","start":"2026-04-07T00:13:15.718753Z","end":"2026-04-07T00:13:15.836227Z","steps":["trace[476571477] 'process raft request' (duration: 117.246889ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:14.416507Z","caller":"traceutil/trace.go:171","msg":"trace[1177016833] transaction","detail":"{read_only:false; response_revision:4794; number_of_response:1; }","duration":"186.718767ms","start":"2026-04-07T00:14:14.229762Z","end":"2026-04-07T00:14:14.416481Z","steps":["trace[1177016833] 'process raft request' (duration: 185.758444ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:14.416817Z","caller":"traceutil/trace.go:171","msg":"trace[1585274933] transaction","detail":"{read_only:false; response_revision:4795; number_of_response:1; }","duration":"164.186001ms","start":"2026-04-07T00:14:14.252621Z","end":"2026-04-07T00:14:14.416807Z","steps":["trace[1585274933] 'process raft request' (duration: 163.786276ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:16.866624Z","caller":"traceutil/trace.go:171","msg":"trace[303638682] transaction","detail":"{read_only:false; response_revision:4828; number_of_response:1; }","duration":"173.989613ms","start":"2026-04-07T00:14:16.69261Z","end":"2026-04-07T00:14:16.866599Z","steps":["trace[303638682] 'process raft request' (duration: 173.400675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:26.99358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.810281ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:14:26.993694Z","caller":"traceutil/trace.go:171","msg":"trace[1125862984] linearizableReadLoop","detail":"{readStateIndex:5127; appliedIndex:5126; }","duration":"486.988582ms","start":"2026-04-07T00:14:26.506688Z","end":"2026-04-07T00:14:26.993677Z","steps":["trace[1125862984] 'read index received' (duration: 189.915277ms)","trace[1125862984] 'applied index is now lower than readState.Index' (duration: 297.072065ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:14:26.994014Z","caller":"traceutil/trace.go:171","msg":"trace[604607959] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"527.263096ms","start":"2026-04-07T00:14:26.466733Z","end":"2026-04-07T00:14:26.993997Z","steps":["trace[604607959] 'process raft request' (duration: 229.949338ms)","trace[604607959] 'compare' (duration: 296.652569ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:14:26.99408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:26.466716Z","time spent":"527.328847ms","remote":"127.0.0.1:43566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:14:26.994537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.812274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:14:26.994661Z","caller":"traceutil/trace.go:171","msg":"trace[1423823811] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4946; }","duration":"488.001476ms","start":"2026-04-07T00:14:26.506635Z","end":"2026-04-07T00:14:26.994637Z","steps":["trace[1423823811] 'agreement among raft nodes before linearized reading' (duration: 487.763913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:26.994705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:26.506613Z","time spent":"488.082927ms","remote":"127.0.0.1:43280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T00:14:26.994765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.583619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-07T00:14:26.994892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.802295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-07T00:14:26.994958Z","caller":"traceutil/trace.go:171","msg":"trace[7523911] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4946; }","duration":"481.851883ms","start":"2026-04-07T00:14:26.513084Z","end":"2026-04-07T00:14:26.994936Z","steps":["trace[7523911] 'agreement among raft nodes before linearized reading' (duration: 481.489168ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:14:26.994966Z","caller":"traceutil/trace.go:171","msg":"trace[1726007976] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4946; }","duration":"388.897807ms","start":"2026-04-07T00:14:26.606044Z","end":"2026-04-07T00:14:26.994941Z","steps":["trace[1726007976] 'agreement among raft nodes before linearized reading' (duration: 388.776375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:26.995013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:26.606027Z","time spent":"388.973918ms","remote":"127.0.0.1:43566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-07T00:14:26.995011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:26.513053Z","time spent":"481.944925ms","remote":"127.0.0.1:43566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-07T00:14:26.99513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.85542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-07T00:14:26.995169Z","caller":"traceutil/trace.go:171","msg":"trace[2032734932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4946; }","duration":"446.950791ms","start":"2026-04-07T00:14:26.548207Z","end":"2026-04-07T00:14:26.995157Z","steps":["trace[2032734932] 'agreement among raft nodes before linearized reading' (duration: 446.831749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:14:26.995352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:14:26.548176Z","time spent":"447.162724ms","remote":"127.0.0.1:43566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T00:15:25.468146Z","caller":"traceutil/trace.go:171","msg":"trace[1588746390] transaction","detail":"{read_only:false; response_revision:5427; number_of_response:1; }","duration":"105.400495ms","start":"2026-04-07T00:15:25.362723Z","end":"2026-04-07T00:15:25.468124Z","steps":["trace[1588746390] 'process raft request' (duration: 80.697721ms)","trace[1588746390] 'compare' (duration: 24.31085ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:15:26.207533Z","caller":"traceutil/trace.go:171","msg":"trace[1042356660] transaction","detail":"{read_only:false; response_revision:5431; number_of_response:1; }","duration":"136.77082ms","start":"2026-04-07T00:15:26.070732Z","end":"2026-04-07T00:15:26.207503Z","steps":["trace[1042356660] 'process raft request' (duration: 136.512521ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:15:27.493278Z","caller":"traceutil/trace.go:171","msg":"trace[759730112] linearizableReadLoop","detail":"{readStateIndex:5633; appliedIndex:5632; }","duration":"131.464326ms","start":"2026-04-07T00:15:27.361774Z","end":"2026-04-07T00:15:27.493239Z","steps":["trace[759730112] 'read index received' (duration: 118.455748ms)","trace[759730112] 'applied index is now lower than readState.Index' (duration: 13.007328ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:15:27.493318Z","caller":"traceutil/trace.go:171","msg":"trace[1137839048] transaction","detail":"{read_only:false; response_revision:5438; number_of_response:1; }","duration":"226.734266ms","start":"2026-04-07T00:15:27.266564Z","end":"2026-04-07T00:15:27.493298Z","steps":["trace[1137839048] 'process raft request' (duration: 213.677067ms)","trace[1137839048] 'compare' (duration: 12.767429ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:15:27.493512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.709376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-07T00:15:27.493574Z","caller":"traceutil/trace.go:171","msg":"trace[544787011] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5438; }","duration":"131.816839ms","start":"2026-04-07T00:15:27.36174Z","end":"2026-04-07T00:15:27.493556Z","steps":["trace[544787011] 'agreement among raft nodes before linearized reading' (duration: 131.627813ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:15:44.637717Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2920} {"level":"info","ts":"2026-04-07T00:15:44.731247Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2920,"took":"91.935992ms","hash":2515712154,"current-db-size-bytes":53657600,"current-db-size":"54 MB","current-db-size-in-use-bytes":28844032,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-07T00:15:44.731338Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2515712154,"revision":2920,"compact-revision":-1} {"level":"info","ts":"2026-04-07T00:20:44.642813Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5581} {"level":"info","ts":"2026-04-07T00:20:44.737965Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5581,"took":"93.963181ms","hash":2018329634,"current-db-size-bytes":53657600,"current-db-size":"54 MB","current-db-size-in-use-bytes":18161664,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-07T00:20:44.738022Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2018329634,"revision":5581,"compact-revision":2920}