2026-02-21 10:51:13.139+0000: 97259130253328: debug : virThreadJobSet:94 : Thread 97259130253328 (prio-rpc-libvirtd) is now running job remoteDispatchStoragePoolLookupByName 2026-02-21 10:51:13.139+0000: 97259130253328: debug : remoteDispatchStoragePoolLookupByNameHelper:19081 : server=0x5874e8265590 client=0x5874e8222010 msg=0x5874e822ba80 rerr=0x3ce66354cc10 args=0x5874eb00f008 ret=0x5874e82a8aa0 2026-02-21 10:51:13.139+0000: 97259130253328: debug : remoteOpenConn:1829 : Getting secondary uri= readonly=0 preserveIdent=1 conn=0x5874e82223c8 2026-02-21 10:51:13.139+0000: 97259130253328: debug : virStoragePoolLookupByName:385 : conn=0x5874eaa1b0f0, name=isos 2026-02-21 10:51:13.139+0000: 97259130253328: debug : virAccessManagerCheckStoragePool:356 : manager=0x5874e83173d0(name=stack) driver=bhyve pool=0x5874ec801640 perm=0 2026-02-21 10:51:13.139+0000: 97259130253328: debug : virAccessManagerCheckStoragePool:356 : manager=0x5874e8317390(name=none) driver=bhyve pool=0x5874ec801640 perm=0 2026-02-21 10:51:13.139+0000: 97259130253328: debug : virStoragePoolDispose:552 : release pool 0x5874eb027010 isos a191bada-0bbf-4118-a6f1-6d2a2e8274ae 2026-02-21 10:51:13.139+0000: 97259130253328: debug : virThreadJobClear:119 : Thread 97259130253328 (prio-rpc-libvirtd) finished job remoteDispatchStoragePoolLookupByName with ret=0 2026-02-21 10:51:13.139+0000: 97259130191888: debug : virThreadJobSet:94 : Thread 97259130191888 (rpc-libvirtd) is now running job remoteDispatchStoragePoolIsActive 2026-02-21 10:51:13.139+0000: 97259130191888: debug : remoteDispatchStoragePoolIsActiveHelper:18807 : server=0x5874e8265590 client=0x5874e8222010 msg=0x5874e822bbd0 rerr=0x3ce65f6bdc10 args=0x5874e8318200 ret=0x5874e9e08000 2026-02-21 10:51:13.139+0000: 97259130191888: debug : remoteOpenConn:1829 : Getting secondary uri= readonly=0 preserveIdent=1 conn=0x5874e82223c8 2026-02-21 10:51:13.139+0000: 97259130191888: debug : virStoragePoolIsActive:2295 : pool=0x5874e9e0c010 2026-02-21 10:51:13.139+0000: 97259130191888: debug : virAccessManagerCheckStoragePool:356 : manager=0x5874e83173d0(name=stack) driver=bhyve pool=0x5874ec801640 perm=1 2026-02-21 10:51:13.139+0000: 97259130191888: debug : virAccessManagerCheckStoragePool:356 : manager=0x5874e8317390(name=none) driver=bhyve pool=0x5874ec801640 perm=1 2026-02-21 10:51:13.139+0000: 97259130191888: debug : virStoragePoolDispose:552 : release pool 0x5874e9e0c010 isos a191bada-0bbf-4118-a6f1-6d2a2e8274ae 2026-02-21 10:51:13.139+0000: 97259130191888: debug : virThreadJobClear:119 : Thread 97259130191888 (rpc-libvirtd) finished job remoteDispatchStoragePoolIsActive with ret=0 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virThreadJobSet:94 : Thread 97259130191888 (rpc-libvirtd) is now running job remoteDispatchStorageVolLookupByName 2026-02-21 10:51:13.140+0000: 97259130191888: debug : remoteDispatchStorageVolLookupByNameHelper:20052 : server=0x5874e8265590 client=0x5874e8222010 msg=0x5874e822ba10 rerr=0x3ce65f6bdc10 args=0x5874e82a8a00 ret=0x5874e82a88e0 2026-02-21 10:51:13.140+0000: 97259130191888: debug : remoteOpenConn:1829 : Getting secondary uri= readonly=0 preserveIdent=1 conn=0x5874e82223c8 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virStorageVolLookupByName:1401 : pool=0x5874e9e0c010, name=test.txt 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virAccessManagerCheckStorageVol:372 : manager=0x5874e83173d0(name=stack) driver=bhyve pool=0x5874ec801640 vol=0x5874ec8f2100 perm=0 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virAccessManagerCheckStorageVol:372 : manager=0x5874e8317390(name=none) driver=bhyve pool=0x5874ec801640 vol=0x5874ec8f2100 perm=0 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virStoragePoolDispose:552 : release pool 0x5874e9e0c010 isos a191bada-0bbf-4118-a6f1-6d2a2e8274ae 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virStorageVolDispose:618 : release vol 0x5874e9e0c070 test.txt 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virThreadJobClear:119 : Thread 97259130191888 (rpc-libvirtd) finished job remoteDispatchStorageVolLookupByName with ret=0 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virThreadJobSet:94 : Thread 97259130191888 (rpc-libvirtd) is now running job remoteDispatchStoragePoolLookupByVolume 2026-02-21 10:51:13.140+0000: 97259130191888: debug : remoteDispatchStoragePoolLookupByVolumeHelper:19243 : server=0x5874e8265590 client=0x5874e8222010 msg=0x5874e822ba80 rerr=0x3ce65f6bdc10 args=0x5874e82a8880 ret=0x5874e82a8860 2026-02-21 10:51:13.140+0000: 97259130191888: debug : remoteOpenConn:1829 : Getting secondary uri= readonly=0 preserveIdent=1 conn=0x5874e82223c8 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virStoragePoolLookupByVolume:506 : vol=0x5874e9e0c070 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virAccessManagerCheckStoragePool:356 : manager=0x5874e83173d0(name=stack) driver=bhyve pool=0x5874ec801640 perm=0 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virAccessManagerCheckStoragePool:356 : manager=0x5874e8317390(name=none) driver=bhyve pool=0x5874ec801640 perm=0 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virStorageVolDispose:618 : release vol 0x5874e9e0c070 test.txt 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virStoragePoolDispose:552 : release pool 0x5874e9e0c010 isos a191bada-0bbf-4118-a6f1-6d2a2e8274ae 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virThreadJobClear:119 : Thread 97259130191888 (rpc-libvirtd) finished job remoteDispatchStoragePoolLookupByVolume with ret=0 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virThreadJobSet:94 : Thread 97259130191888 (rpc-libvirtd) is now running job remoteDispatchStorageVolDownload 2026-02-21 10:51:13.140+0000: 97259130191888: debug : remoteDispatchStorageVolDownloadHelper:19693 : server=0x5874e8265590 client=0x5874e8222010 msg=0x5874e822bbd0 rerr=0x3ce65f6bdc10 args=0x5874e9e15000 ret=0x0 2026-02-21 10:51:13.140+0000: 97259130191888: debug : remoteOpenConn:1829 : Getting secondary uri= readonly=0 preserveIdent=1 conn=0x5874e82223c8 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virStreamNew:64 : conn=0x5874eaa1b0f0, flags=0x1 2026-02-21 10:51:13.140+0000: 97259130191888: debug : daemonCreateClientStream:357 : client=0x5874e8222010, proc=209, serial=15, st=0x5874e821ec20 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virStorageVolDownload:1706 : vol=0x5874e9e0c010, stream=0x5874e821ec20, offset=0, length=0, flags=0x0 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virAccessManagerCheckStorageVol:372 : manager=0x5874e83173d0(name=stack) driver=bhyve pool=0x5874ec801640 vol=0x5874ec8f2100 perm=6 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virAccessManagerCheckStorageVol:372 : manager=0x5874e8317390(name=none) driver=bhyve pool=0x5874ec801640 vol=0x5874ec8f2100 perm=6 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virFDStreamOpenFileInternal:1265 : st=0x5874e821ec20 path=/data/isos/test.txt oflags=0x0 offset=0 length=0 mode=00 2026-02-21 10:51:13.140+0000: 97259130191888: debug : virFDStreamOpenInternal:1139 : st=0x5874e821ec20 fd=21 threadData=0x5874e9e15030 length=0 2026-02-21 10:51:13.141+0000: 97259130191888: debug : daemonAddClientStream:433 : client=0x5874e8222010, proc=209, serial=15, st=0x5874e821ec20, transmit=1 2026-02-21 10:51:13.141+0000: 97259130191888: debug : virStreamEventAddCallback:1115 : stream=0x5874e821ec20, events=0, cb=0x3cde2184e510, opaque=0x5874e8222010, ff=0x3ce642e7c060 2026-02-21 10:51:13.141+0000: 97259130191888: debug : virStreamRef:96 : stream=0x5874e821ec20 2026-02-21 10:51:13.141+0000: 97259130191888: debug : virStreamEventUpdateCallback:1156 : stream=0x5874e821ec20, events=1 2026-02-21 10:51:13.141+0000: 97259130191888: debug : virStorageVolDispose:618 : release vol 0x5874e9e0c010 test.txt 2026-02-21 10:51:13.141+0000: 97259130525712: debug : virThreadJobSet:97 : Thread 97259130525712 is now running job fd-stream 2026-02-21 10:51:13.141+0000: 97259130191888: debug : virThreadJobClear:119 : Thread 97259130191888 (rpc-libvirtd) finished job remoteDispatchStorageVolDownload with ret=0 2026-02-21 10:51:13.141+0000: 97259130155024: debug : daemonStreamEvent:136 : st=0x5874e821ec20 events=1 EOF=0 closed=0 2026-02-21 10:51:13.141+0000: 97259130155024: debug : daemonStreamHandleRead:833 : client=0x5874e8222010, stream=0x5874e9e0f050 tx=1 closed=0 2026-02-21 10:51:13.141+0000: 97259130155024: debug : virStreamRecv:284 : stream=0x5874e821ec20, data=0x5874ed6005c0, nbytes=262120 2026-02-21 10:51:13.141+0000: 97259130525712: debug : virThreadJobClear:122 : Thread 97259130525712 finished job fd-stream with ret=0 2026-02-21 10:51:13.141+0000: 97259130155024: error : virFDStreamRead:921 : stream is not open: Bad file descriptor 2026-02-21 10:51:13.141+0000: 97259130155024: debug : virStreamEventUpdateCallback:1156 : stream=0x5874e821ec20, events=0 2026-02-21 10:51:13.141+0000: 97259130155024: debug : daemonStreamMessageFinished:103 : stream=0x5874e9e0f050 proc=209 serial=15 2026-02-21 10:51:13.141+0000: 97259130155024: debug : virStreamEventUpdateCallback:1156 : stream=0x5874e821ec20, events=1 2026-02-21 10:51:13.141+0000: 97259130155024: debug : daemonStreamEvent:136 : st=0x5874e821ec20 events=9 EOF=0 closed=0 2026-02-21 10:51:13.141+0000: 97259130155024: debug : daemonStreamHandleRead:833 : client=0x5874e8222010, stream=0x5874e9e0f050 tx=1 closed=0 2026-02-21 10:51:13.141+0000: 97259130155024: debug : virStreamRecv:284 : stream=0x5874e821ec20, data=0x5874ed600180, nbytes=262120 2026-02-21 10:51:13.141+0000: 97259130155024: error : virFDStreamRead:921 : stream is not open: Bad file descriptor 2026-02-21 10:51:13.141+0000: 97259130155024: debug : virStreamEventUpdateCallback:1156 : stream=0x5874e821ec20, events=0 2026-02-21 10:51:13.141+0000: 97259130155024: debug : daemonStreamMessageFinished:103 : stream=0x5874e9e0f050 proc=209 serial=15 2026-02-21 10:51:13.141+0000: 97259130155024: debug : virStreamEventUpdateCallback:1156 : stream=0x5874e821ec20, events=0