{"level":"warn","ts":"2026-05-09T05:07:54.537796Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T05:07:54.538088Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38: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.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38: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-05-09T05:07:54.538279Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T05:07:54.538445Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-05-09T05:07:54.538543Z","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-05-09T05:07:54.540148Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-05-09T05:07:54.540433Z","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.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38: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-05-09T05:07:54.544878Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.92443ms"} {"level":"info","ts":"2026-05-09T05:07:54.551184Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-05-09T05:07:54.55126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-05-09T05:07:54.551282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-05-09T05:07:54.551296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-09T05:07:54.551314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-05-09T05:07:54.551354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-05-09T05:07:54.562641Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-09T05:07:54.563991Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-09T05:07:54.565048Z","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-05-09T05:07:54.567278Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-09T05:07:54.572417Z","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-05-09T05:07:54.572772Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-09T05:07:54.573217Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-05-09T05:07:54.57327Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-05-09T05:07:54.574157Z","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-05-09T05:07:54.574243Z","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-05-09T05:07:54.574256Z","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-05-09T05:07:54.574321Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-09T05:07:54.574369Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-09T05:07:54.575261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-05-09T05:07:54.575372Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-05-09T05:07:54.852558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-05-09T05:07:54.852643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-09T05:07:54.852704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-05-09T05:07:54.85273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-05-09T05:07:54.852849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-05-09T05:07:54.852872Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-05-09T05:07:54.852896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-05-09T05:07:54.853857Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T05:07:54.854912Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T05:07:54.855094Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T05:07:54.855162Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T05:07:54.855179Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T05:07:54.857217Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-05-09T05:07:54.859176Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T05:07:54.85948Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-09T05:07:54.859508Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-09T05:07:54.859848Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-09T05:07:54.86445Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-05-09T05:08:29.653793Z","caller":"traceutil/trace.go:171","msg":"trace[1230541053] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"118.412726ms","start":"2026-05-09T05:08:29.535308Z","end":"2026-05-09T05:08:29.65372Z","steps":["trace[1230541053] 'read index received' (duration: 114.507373ms)","trace[1230541053] 'applied index is now lower than readState.Index' (duration: 3.903263ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:08:29.653877Z","caller":"traceutil/trace.go:171","msg":"trace[1899973261] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"266.993755ms","start":"2026-05-09T05:08:29.386836Z","end":"2026-05-09T05:08:29.65383Z","steps":["trace[1899973261] 'process raft request' (duration: 264.36005ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:08:29.654032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.697879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-09T05:08:29.654154Z","caller":"traceutil/trace.go:171","msg":"trace[1385722257] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:575; }","duration":"118.874589ms","start":"2026-05-09T05:08:29.535258Z","end":"2026-05-09T05:08:29.654133Z","steps":["trace[1385722257] 'agreement among raft nodes before linearized reading' (duration: 118.607118ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:08:30.166469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.869023ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T05:08:30.166755Z","caller":"traceutil/trace.go:171","msg":"trace[631133046] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"508.246969ms","start":"2026-05-09T05:08:29.65848Z","end":"2026-05-09T05:08:30.166726Z","steps":["trace[631133046] 'process raft request' (duration: 77.129838ms)","trace[631133046] 'compare' (duration: 429.688132ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:08:30.166767Z","caller":"traceutil/trace.go:171","msg":"trace[1849064771] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:593; }","duration":"405.029223ms","start":"2026-05-09T05:08:29.761722Z","end":"2026-05-09T05:08:30.166751Z","steps":["trace[1849064771] 'read index received' (duration: 35.84µs)","trace[1849064771] 'applied index is now lower than readState.Index' (duration: 404.992263ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:08:30.166929Z","caller":"traceutil/trace.go:171","msg":"trace[1446325990] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"459.616524ms","start":"2026-05-09T05:08:29.70726Z","end":"2026-05-09T05:08:30.166876Z","steps":["trace[1446325990] 'process raft request' (duration: 459.385212ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:08:30.166975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:08:29.658459Z","time spent":"508.42648ms","remote":"127.0.0.1:48168","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-05-09T05:08:30.167157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:08:29.707234Z","time spent":"459.817985ms","remote":"127.0.0.1:48404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T05:08:30.167188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.429326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-f9czm\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-09T05:08:30.16729Z","caller":"traceutil/trace.go:171","msg":"trace[467605081] range","detail":"{range_begin:/registry/pods/kube-system/cilium-f9czm; range_end:; response_count:1; response_revision:577; }","duration":"405.557147ms","start":"2026-05-09T05:08:29.761676Z","end":"2026-05-09T05:08:30.167233Z","steps":["trace[467605081] 'agreement among raft nodes before linearized reading' (duration: 405.153444ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:08:30.167392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:08:29.761656Z","time spent":"405.678217ms","remote":"127.0.0.1:48110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-f9czm\" "} {"level":"info","ts":"2026-05-09T05:08:30.169966Z","caller":"traceutil/trace.go:171","msg":"trace[112655144] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"134.428377ms","start":"2026-05-09T05:08:30.035503Z","end":"2026-05-09T05:08:30.169932Z","steps":["trace[112655144] 'process raft request' (duration: 134.273656ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:08:30.18045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.252153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T05:08:30.18051Z","caller":"traceutil/trace.go:171","msg":"trace[1836570549] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:579; }","duration":"390.344443ms","start":"2026-05-09T05:08:29.790151Z","end":"2026-05-09T05:08:30.180496Z","steps":["trace[1836570549] 'agreement among raft nodes before linearized reading' (duration: 390.245413ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:08:30.18054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T05:08:29.790138Z","time spent":"390.395265ms","remote":"127.0.0.1:47944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T05:08:30.598792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.274963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-09T05:08:30.598905Z","caller":"traceutil/trace.go:171","msg":"trace[877982989] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:580; }","duration":"207.386963ms","start":"2026-05-09T05:08:30.391498Z","end":"2026-05-09T05:08:30.598885Z","steps":["trace[877982989] 'range keys from in-memory index tree' (duration: 207.108721ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:08:30.598788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.559883ms","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-05-09T05:08:30.59905Z","caller":"traceutil/trace.go:171","msg":"trace[1605523599] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:580; }","duration":"205.856184ms","start":"2026-05-09T05:08:30.393164Z","end":"2026-05-09T05:08:30.59902Z","steps":["trace[1605523599] 'range keys from in-memory index tree' (duration: 205.431572ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:08:30.666171Z","caller":"traceutil/trace.go:171","msg":"trace[1792295860] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"106.454458ms","start":"2026-05-09T05:08:30.559692Z","end":"2026-05-09T05:08:30.666146Z","steps":["trace[1792295860] 'process raft request' (duration: 105.842875ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:09:17.866659Z","caller":"traceutil/trace.go:171","msg":"trace[101606246] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"109.647886ms","start":"2026-05-09T05:09:17.756978Z","end":"2026-05-09T05:09:17.866626Z","steps":["trace[101606246] 'process raft request' (duration: 71.399353ms)","trace[101606246] 'compare' (duration: 37.777771ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:10:14.419969Z","caller":"traceutil/trace.go:171","msg":"trace[62919807] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"122.413ms","start":"2026-05-09T05:10:14.297532Z","end":"2026-05-09T05:10:14.419945Z","steps":["trace[62919807] 'process raft request' (duration: 122.272629ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:10:14.422686Z","caller":"traceutil/trace.go:171","msg":"trace[1427590072] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"109.292496ms","start":"2026-05-09T05:10:14.313375Z","end":"2026-05-09T05:10:14.422667Z","steps":["trace[1427590072] 'process raft request' (duration: 109.176916ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:10:31.677787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.035139ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T05:10:31.677873Z","caller":"traceutil/trace.go:171","msg":"trace[1806559023] transaction","detail":"{read_only:false; response_revision:2028; number_of_response:1; }","duration":"261.524163ms","start":"2026-05-09T05:10:31.416334Z","end":"2026-05-09T05:10:31.677858Z","steps":["trace[1806559023] 'process raft request' (duration: 126.361713ms)","trace[1806559023] 'compare' (duration: 134.855828ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:10:31.701692Z","caller":"traceutil/trace.go:171","msg":"trace[1360262709] transaction","detail":"{read_only:false; response_revision:2030; number_of_response:1; }","duration":"285.076009ms","start":"2026-05-09T05:10:31.416599Z","end":"2026-05-09T05:10:31.701675Z","steps":["trace[1360262709] 'process raft request' (duration: 285.015569ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:10:31.701768Z","caller":"traceutil/trace.go:171","msg":"trace[1016209128] transaction","detail":"{read_only:false; response_revision:2029; number_of_response:1; }","duration":"285.23993ms","start":"2026-05-09T05:10:31.416426Z","end":"2026-05-09T05:10:31.701666Z","steps":["trace[1016209128] 'process raft request' (duration: 285.10142ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:11:43.541266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.891468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-09T05:11:43.541335Z","caller":"traceutil/trace.go:171","msg":"trace[138720411] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2517; }","duration":"102.024139ms","start":"2026-05-09T05:11:43.439296Z","end":"2026-05-09T05:11:43.54132Z","steps":["trace[138720411] 'range keys from in-memory index tree' (duration: 101.712307ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:15:49.158417Z","caller":"traceutil/trace.go:171","msg":"trace[2041614199] linearizableReadLoop","detail":"{readStateIndex:4615; appliedIndex:4614; }","duration":"121.136307ms","start":"2026-05-09T05:15:49.037257Z","end":"2026-05-09T05:15:49.158393Z","steps":["trace[2041614199] 'read index received' (duration: 53.724541ms)","trace[2041614199] 'applied index is now lower than readState.Index' (duration: 67.382086ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T05:15:49.158769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.488279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-01e084d0-ac70-4a89-933f-621504402e3f\" ","response":"range_response_count:1 size:4076"} {"level":"info","ts":"2026-05-09T05:15:49.158813Z","caller":"traceutil/trace.go:171","msg":"trace[1421273027] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-01e084d0-ac70-4a89-933f-621504402e3f; range_end:; response_count:1; response_revision:4451; }","duration":"121.550969ms","start":"2026-05-09T05:15:49.037252Z","end":"2026-05-09T05:15:49.158803Z","steps":["trace[1421273027] 'agreement among raft nodes before linearized reading' (duration: 121.245077ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:15:49.158962Z","caller":"traceutil/trace.go:171","msg":"trace[1953442155] transaction","detail":"{read_only:false; response_revision:4451; number_of_response:1; }","duration":"141.515301ms","start":"2026-05-09T05:15:49.017403Z","end":"2026-05-09T05:15:49.158919Z","steps":["trace[1953442155] 'process raft request' (duration: 73.476991ms)","trace[1953442155] 'compare' (duration: 67.226426ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:15:49.201089Z","caller":"traceutil/trace.go:171","msg":"trace[1422029411] transaction","detail":"{read_only:false; response_revision:4452; number_of_response:1; }","duration":"147.126174ms","start":"2026-05-09T05:15:49.053941Z","end":"2026-05-09T05:15:49.201067Z","steps":["trace[1422029411] 'process raft request' (duration: 147.005303ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:15:57.892036Z","caller":"traceutil/trace.go:171","msg":"trace[399308715] linearizableReadLoop","detail":"{readStateIndex:4802; appliedIndex:4801; }","duration":"103.083543ms","start":"2026-05-09T05:15:57.788911Z","end":"2026-05-09T05:15:57.891995Z","steps":["trace[399308715] 'read index received' (duration: 41.425351ms)","trace[399308715] 'applied index is now lower than readState.Index' (duration: 61.656122ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T05:15:57.89224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.311014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T05:15:57.892345Z","caller":"traceutil/trace.go:171","msg":"trace[255571738] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4634; }","duration":"103.479845ms","start":"2026-05-09T05:15:57.788841Z","end":"2026-05-09T05:15:57.892321Z","steps":["trace[255571738] 'agreement among raft nodes before linearized reading' (duration: 103.297024ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:15:57.899525Z","caller":"traceutil/trace.go:171","msg":"trace[1864673403] transaction","detail":"{read_only:false; response_revision:4635; number_of_response:1; }","duration":"100.312512ms","start":"2026-05-09T05:15:57.799188Z","end":"2026-05-09T05:15:57.899501Z","steps":["trace[1864673403] 'process raft request' (duration: 100.131191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:15:58.381507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.112547ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-09T05:15:58.381611Z","caller":"traceutil/trace.go:171","msg":"trace[1247686384] transaction","detail":"{read_only:false; response_revision:4641; number_of_response:1; }","duration":"280.789891ms","start":"2026-05-09T05:15:58.100806Z","end":"2026-05-09T05:15:58.381595Z","steps":["trace[1247686384] 'process raft request' (duration: 20.520704ms)","trace[1247686384] 'compare' (duration: 259.825386ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:15:58.398593Z","caller":"traceutil/trace.go:171","msg":"trace[1066537317] transaction","detail":"{read_only:false; response_revision:4642; number_of_response:1; }","duration":"126.442369ms","start":"2026-05-09T05:15:58.272116Z","end":"2026-05-09T05:15:58.398558Z","steps":["trace[1066537317] 'process raft request' (duration: 126.232688ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:15:58.419837Z","caller":"traceutil/trace.go:171","msg":"trace[1887063676] linearizableReadLoop","detail":"{readStateIndex:4811; appliedIndex:4809; }","duration":"118.787617ms","start":"2026-05-09T05:15:58.301028Z","end":"2026-05-09T05:15:58.419816Z","steps":["trace[1887063676] 'read index received' (duration: 97.235119ms)","trace[1887063676] 'applied index is now lower than readState.Index' (duration: 21.551108ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T05:15:58.41994Z","caller":"traceutil/trace.go:171","msg":"trace[1481703124] transaction","detail":"{read_only:false; response_revision:4643; number_of_response:1; }","duration":"147.458185ms","start":"2026-05-09T05:15:58.272431Z","end":"2026-05-09T05:15:58.41989Z","steps":["trace[1481703124] 'process raft request' (duration: 147.275283ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T05:15:58.420301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.257739ms","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-05-09T05:15:58.420438Z","caller":"traceutil/trace.go:171","msg":"trace[1620696106] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4643; }","duration":"119.46626ms","start":"2026-05-09T05:15:58.300955Z","end":"2026-05-09T05:15:58.420421Z","steps":["trace[1620696106] 'agreement among raft nodes before linearized reading' (duration: 119.078249ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:16:09.735246Z","caller":"traceutil/trace.go:171","msg":"trace[1092348442] transaction","detail":"{read_only:false; response_revision:4813; number_of_response:1; }","duration":"268.35265ms","start":"2026-05-09T05:16:09.466868Z","end":"2026-05-09T05:16:09.735221Z","steps":["trace[1092348442] 'process raft request' (duration: 267.895519ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:16:09.735714Z","caller":"traceutil/trace.go:171","msg":"trace[1565428738] transaction","detail":"{read_only:false; response_revision:4814; number_of_response:1; }","duration":"267.897889ms","start":"2026-05-09T05:16:09.467788Z","end":"2026-05-09T05:16:09.735686Z","steps":["trace[1565428738] 'process raft request' (duration: 267.375667ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T05:17:54.945543Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2900} {"level":"info","ts":"2026-05-09T05:17:55.036457Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2900,"took":"89.821619ms","hash":2355208903,"current-db-size-bytes":53035008,"current-db-size":"53 MB","current-db-size-in-use-bytes":29286400,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-09T05:17:55.037154Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2355208903,"revision":2900,"compact-revision":-1} {"level":"info","ts":"2026-05-09T05:22:54.950893Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5622} {"level":"info","ts":"2026-05-09T05:22:55.028689Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5622,"took":"76.659374ms","hash":2308594566,"current-db-size-bytes":53035008,"current-db-size":"53 MB","current-db-size-in-use-bytes":18042880,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-09T05:22:55.02876Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2308594566,"revision":5622,"compact-revision":2900}