[2020-04-19 22:51:29,407] (DEBUG) VMService.vm_3.run():179 - ====> NIC_ATTACH: igb0
[2020-04-19 22:51:29,409] (DEBUG) VMService.vm_3.run():293 - Starting bhyve: bhyve -A -H -w -c 2 -m 4096 -s 0:0,hostbridge -s 31,lpc -l com1,/dev/nmdm3A -l bootrom,/usr/local/share/uefi-firmware/BHYVE_UEFI.fd -s 5,virtio-net,tap1,mac=00:a0:98:45:01:3a -s 29,fbuf,vncserver,tcp=0.0.0.0:6526,w=1024,h=768,, -s 30,xhci,tablet -s 3:0,ahci,cd:/mnt/iohyve/ISO/rancheros.iso -s 4:0,virtio-blk,/dev/zvol/systemtank/DockerHost-4zyfe7 3_DockerHost
[2020-04-19 22:51:29,434] (DEBUG) VMService.vm_3.run():306 - ==> Start WEBVNC at port 6426 with pid number 55066
[2020-04-19 22:51:29,435] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:29 Listening for VNC connections on TCP port 6526
[2020-04-19 22:51:29,435] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:29 Listening for VNC connections on TCP6 port 6526
[2020-04-19 22:51:39,951] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:39   other clients:
[2020-04-19 22:51:39,953] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:39 Client Protocol Version 3.8
[2020-04-19 22:51:39,954] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:39 Protocol version sent 3.8, using 3.8
[2020-04-19 22:51:39,955] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:39 rfbProcessClientSecurityType: executing handler for type 1
[2020-04-19 22:51:39,955] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:39 rfbProcessClientSecurityType: returning securityResult for client rfb version >= 3.8
[2020-04-19 22:51:40,058] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:40 Pixel format for client 127.0.0.1:
[2020-04-19 22:51:40,058] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:40   32 bpp, depth 24, little endian
[2020-04-19 22:51:40,058] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:40   true colour: max r 255 g 255 b 255, shift r 16 g 8 b 0
[2020-04-19 22:51:40,183] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:40 Using image quality level 6 for client 127.0.0.1
[2020-04-19 22:51:40,183] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:40 Using JPEG subsampling 0, Q79 for client 127.0.0.1
[2020-04-19 22:51:40,184] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:40 Using compression level 2 for client 127.0.0.1
[2020-04-19 22:51:40,184] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:40 Enabling NewFBSize protocol extension for client 127.0.0.1
[2020-04-19 22:51:40,184] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:40 Enabling LastRect protocol extension for client 127.0.0.1
[2020-04-19 22:51:40,184] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:40 rfbProcessClientNormalMessage: ignoring unsupported encoding type Enc(0xFFFFFEFE)
[2020-04-19 22:51:40,184] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:40 rfbProcessClientNormalMessage: ignoring unsupported encoding type Enc(0xFFFFFECC)
[2020-04-19 22:51:40,184] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:40 rfbProcessClientNormalMessage: ignoring unsupported encoding type Enc(0xFFFFFEC8)
[2020-04-19 22:51:40,184] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:40 rfbProcessClientNormalMessage: ignoring unsupported encoding type Enc(0xFFFFFEC7)
[2020-04-19 22:51:40,184] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:40 Enabling full-color cursor updates for client 127.0.0.1
[2020-04-19 22:51:40,185] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:40 Using tight encoding for client 127.0.0.1
[2020-04-19 22:51:53,547] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:53 Client 127.0.0.1 gone
[2020-04-19 22:51:53,547] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:53 Statistics             events    Transmit/ RawEquiv ( saved)
[2020-04-19 22:51:53,547] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:53  FramebufferUpdate   :      1 |         0/        0 (  0.0%)
[2020-04-19 22:51:53,547] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:53  LastRect            :      1 |        12/       12 (  0.0%)
[2020-04-19 22:51:53,548] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:53  tight               :      8 |       480/  3145824 (100.0%)
[2020-04-19 22:51:53,548] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:53  RichCursor          :      1 |       255/      255 (  0.0%)
[2020-04-19 22:51:53,548] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:53  TOTALS              :     11 |       747/  3146091 (100.0%)
[2020-04-19 22:51:53,548] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:53 Statistics             events    Received/ RawEquiv ( saved)
[2020-04-19 22:51:53,548] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:53  PointerEvent        :     55 |       330/      330 (  0.0%)
[2020-04-19 22:51:53,548] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:53  FramebufferUpdate   :      2 |        20/       20 (  0.0%)
[2020-04-19 22:51:53,548] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:53  SetEncodings        :      1 |        68/       68 (  0.0%)
[2020-04-19 22:51:53,549] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:53  SetPixelFormat      :      1 |        20/       20 (  0.0%)
[2020-04-19 22:51:53,549] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:51:53  TOTALS              :     59 |       438/      438 (  0.0%)
[2020-04-19 22:51:58,186] (DEBUG) VMService.vm_3.stop():478 - ===> Soft Stop VM: DockerHost ID: 3
[2020-04-19 22:51:58,547] (INFO) VMService.vm_3.run():346 - ===> Error VM: DockerHost ID: 3 BHYVE_CODE: -15
[2020-04-19 22:51:58,558] (ERROR) VMService.vm_3.running():490 - ===> VMM DockerHost is running without bhyve process.
[2020-04-19 22:51:58,562] (DEBUG) VMService.vm_3.__teardown_guest_vmemory():376 - ===> Give back guest memory to ARC: 31468457984
[2020-04-19 22:51:58,562] (WARNING) VMService.vm_3.destroy_vm():353 - ===> Destroying VM: DockerHost ID: 3 BHYVE_CODE: -15
[2020-04-19 22:52:25,313] (DEBUG) VMService.vm_3.run():179 - ====> NIC_ATTACH: igb0
[2020-04-19 22:52:25,316] (DEBUG) VMService.vm_3.run():293 - Starting bhyve: bhyve -A -H -w -c 2 -m 4096 -s 0:0,hostbridge -s 31,lpc -l com1,/dev/nmdm3A -l bootrom,/usr/local/share/uefi-firmware/BHYVE_UEFI.fd -s 5,virtio-net,tap1,mac=00:a0:98:45:01:3a -s 29,fbuf,vncserver,tcp=0.0.0.0:6526,w=1024,h=768,, -s 30,xhci,tablet -s 3:0,ahci,cd:/mnt/iohyve/ISO/rancheros.iso -s 4:0,virtio-blk,/dev/zvol/systemtank/DockerHost-4zyfe7 3_DockerHost
[2020-04-19 22:52:25,338] (DEBUG) VMService.vm_3.run():306 - ==> Start WEBVNC at port 6426 with pid number 55133
[2020-04-19 22:52:25,339] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:25 Listening for VNC connections on TCP port 6526
[2020-04-19 22:52:25,339] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:25 Listening for VNC connections on TCP6 port 6526
[2020-04-19 22:52:35,003] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35   other clients:
[2020-04-19 22:52:35,006] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35 Client Protocol Version 3.8
[2020-04-19 22:52:35,006] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35 Protocol version sent 3.8, using 3.8
[2020-04-19 22:52:35,008] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35 rfbProcessClientSecurityType: executing handler for type 1
[2020-04-19 22:52:35,008] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35 rfbProcessClientSecurityType: returning securityResult for client rfb version >= 3.8
[2020-04-19 22:52:35,080] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35 Pixel format for client 127.0.0.1:
[2020-04-19 22:52:35,080] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35   32 bpp, depth 24, little endian
[2020-04-19 22:52:35,080] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35   true colour: max r 255 g 255 b 255, shift r 16 g 8 b 0
[2020-04-19 22:52:35,184] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35 Using image quality level 6 for client 127.0.0.1
[2020-04-19 22:52:35,185] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35 Using JPEG subsampling 0, Q79 for client 127.0.0.1
[2020-04-19 22:52:35,185] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35 Using compression level 2 for client 127.0.0.1
[2020-04-19 22:52:35,185] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35 Enabling NewFBSize protocol extension for client 127.0.0.1
[2020-04-19 22:52:35,185] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35 Enabling LastRect protocol extension for client 127.0.0.1
[2020-04-19 22:52:35,185] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35 rfbProcessClientNormalMessage: ignoring unsupported encoding type Enc(0xFFFFFEFE)
[2020-04-19 22:52:35,185] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35 rfbProcessClientNormalMessage: ignoring unsupported encoding type Enc(0xFFFFFECC)
[2020-04-19 22:52:35,185] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35 rfbProcessClientNormalMessage: ignoring unsupported encoding type Enc(0xFFFFFEC8)
[2020-04-19 22:52:35,185] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35 rfbProcessClientNormalMessage: ignoring unsupported encoding type Enc(0xFFFFFEC7)
[2020-04-19 22:52:35,186] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35 Enabling full-color cursor updates for client 127.0.0.1
[2020-04-19 22:52:35,186] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 22:52:35 Using tight encoding for client 127.0.0.1
[2020-04-19 23:09:05,805] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 23:09:05 Client 127.0.0.1 gone
[2020-04-19 23:09:05,806] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 23:09:05 Statistics             events    Transmit/ RawEquiv ( saved)
[2020-04-19 23:09:05,806] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 23:09:05  FramebufferUpdate   :     42 |         0/        0 (  0.0%)
[2020-04-19 23:09:05,806] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 23:09:05  LastRect            :     42 |       504/      504 (  0.0%)
[2020-04-19 23:09:05,806] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 23:09:05  tight               :   1057 |     77409/132133260 ( 99.9%)
[2020-04-19 23:09:05,806] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 23:09:05  RichCursor          :      1 |       255/      255 (  0.0%)
[2020-04-19 23:09:05,806] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 23:09:05  TOTALS              :   1142 |     78168/132134019 ( 99.9%)
[2020-04-19 23:09:05,806] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 23:09:05 Statistics             events    Received/ RawEquiv ( saved)
[2020-04-19 23:09:05,807] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 23:09:05  KeyEvent            :     46 |       368/      368 (  0.0%)
[2020-04-19 23:09:05,807] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 23:09:05  PointerEvent        :     13 |        78/       78 (  0.0%)
[2020-04-19 23:09:05,807] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 23:09:05  FramebufferUpdate   :     43 |       430/      430 (  0.0%)
[2020-04-19 23:09:05,807] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 23:09:05  SetEncodings        :      1 |        68/       68 (  0.0%)
[2020-04-19 23:09:05,807] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 23:09:05  SetPixelFormat      :      1 |        20/       20 (  0.0%)
[2020-04-19 23:09:05,807] (DEBUG) VMService.vm_3.run():315 - DockerHost: 19/04/2020 23:09:05  TOTALS              :    104 |       964/      964 (  0.0%)
[2020-04-19 23:09:19,663] (DEBUG) VMService.vm_3.stop():478 - ===> Soft Stop VM: DockerHost ID: 3
[2020-04-19 23:09:20,033] (INFO) VMService.vm_3.run():346 - ===> Error VM: DockerHost ID: 3 BHYVE_CODE: -15
[2020-04-19 23:09:20,044] (ERROR) VMService.vm_3.running():490 - ===> VMM DockerHost is running without bhyve process.
[2020-04-19 23:09:20,048] (DEBUG) VMService.vm_3.__teardown_guest_vmemory():376 - ===> Give back guest memory to ARC: 31468457984
[2020-04-19 23:09:20,048] (WARNING) VMService.vm_3.destroy_vm():353 - ===> Destroying VM: DockerHost ID: 3 BHYVE_CODE: -15
