Not sure if I've categorized this correctly, but wanted to report a problem with version 11 that was not happening with 10.3. I use NAS4FREE which is built upon FREEBSD Unix O/S and run it as a virtual machine with Microsoft's HYPER-V on Windows 10 Professional. Integration services are included and it runs well as a virtual machine. A new problem has shown up testing version 11 with SCSI defined hard drives being attached to HYPER-V VM. Hard drives attached in this manner are no longer visible with V11.XXXX running in a VM. I've now tried several versions of V11.xxxx and all show the same problem. IDE defined drives do show up, however this limits me to 3 drives which is not adequate. As mentioned above this does not happen with all versions of NAS4FREE 10.3.XXXX based on FREEBSD 10.3.XXXX. I've submitted this same problem on NAS4FREE support site however they can't seem to be able to help me and wonder if this problem is part of the base system. I also tried running FREEBSD 11.xxxx as a VM under HYPER-V and the boot does not complete successfully but am not knowledgeable enough to provide enough information as to why. Thank you.
(In reply to ds from comment #0) Please try 11-stable or 10-stable. There are some known issues w/ 11.0.
I saw in a comment on german thread that Version 11 STABLE may have fixed this problem but not the RELEASE version. I don't get to choose what NAS4FREE uses as baseline O/S however. I have reported this problem on NAS4FREE site already and others have confirmed that this problem is consistent, not only if using HYPER-V virtualization but also in VMWARE ESX now. No fix is prevalent on their latest versions. I've tried several versions now over 4-5 months and no success yet. They must still be using RELEASE base. All versions of 10.3.xxxx are still working however so have using that for now.
Just tried this again with more recent versions and the problem reported here still remains. I can now boot FREENAS with FREEBSD 11 to completion as well (there is a reported bug that if you don't include legacy LAN it won't start). I have now tried both NAS4FREE 11.1 which uses FREEBSD 11.1-RELEASE version and have now also tried FREENAS 11.0-U2 which uses the FREEBSD 11-STABLE version. Both products have issues seeing attached hard drives that are defined using SCSI definition when running under HYPER-V. When attaching a hard drive with the IDE definition, the hard drive becomes visible. This is not terribly usable as you are limited to max of 3 drives outside of the O/S virtual disk. Not good enough for any significant storage. This seems to be an issue with FREEBSD itself 11 as this problem did not exist in when using NAS4FREE 10.3 that uses FREEBSD 10.X. I have contacted NAS4FREE to report this as well and will report it to FREENAS but from what I've seen they can't help me with this issue as it doesn't appear to be in their product. Their products work fine when running 11.X on a dedicated computer vs virtualized. Someone else reported this problem running VMWARE as well with similar issue. Dedicating a computer to just NAS functions is terribly wasteful when it can be doing other things at same time if virtualized. Any help would be appreciated.
(In reply to ds from comment #3) What's the version of the hosting Windows? Did you try 11.1?
(In reply to Sepherosa Ziehau from comment #4) Hosting Windows is W10 PRO 64 with HYPER-V, latest Creators' Update (1703) but previous anniversary version 1607 experienced this as well. I've been testing this now for about 6 months and various versions of 11.0.X and 11.1.X more recently. So, yes I have tried 11.1.X and problem still remains. IDE defined disks are recognized but not SCSI-defined drives whenever it's run in HYPER-V. When running on dedicated computer, all is well. None of the 10.X series of O/S had this issue with HYPER-V.
(In reply to ds from comment #5) Can you post the dmesg, when the issue happens?
(In reply to ds from comment #5) In addition to dmesg, please also give me your SCSI disk configuration: the SCSI controller index, the disk location, and whether it's virtual disk or real disk, etc.
(In reply to Sepherosa Ziehau from comment #7) ---------------------------------------------------------------------------- In addition to dmesg, please also give me your SCSI disk configuration: the SCSI controller index, the disk location, and whether it's virtual disk or real disk, etc. ---------------------------------------------------------------------------- I don't know what a dmesg is. I run this operating system embedded as part of NAS4FREE 11.1 NAS O/S, therefore I don't touch the FREEBSD operating system itself. I also tried running the other open source NAS O/S, FREENAS11. Both of these are now using FREEBSD 11.1 as base. See my comments above on these. I'm not familiar enough with pure FREEBSD to run it on its own. I have reported this issue to both NAS suppliers and they have confirmed that it's not part of their software, but part of base O/S and therefore can't help me. Someone else also reported this same issue on VMWARE virtualization platform which I can't verify since I don't have that platform. As for SCSI drive, it is a physical hard drive, either blank unformatted or sometimes it might have NTFS on it, however when I go into NAS platform, I usually format it for ZFS file system. Since the drive can't be seen at all when defined as SCSI to HYPER-V, I can't proceed as usual. The disk is on a standard onboard SATA3 port connected disk, with AHCI chosen on the motherboard bios as it is for all drives. Not sure what you mean by SCSI controller index. As mentioned above, this issue does not occur with previous generation of FREEBSD 10.X embedded as part of NAS o/s platforms. I'm still running those successfully. Only since 11.X has this started to happen.
Some additional info that might be useful: ----------------------------------------------------------------------- I'm using a SEAGATE 1 TB standalone hard drive as a test drive attached using SCSI definition via HYPER-V. It is invisible when I run Clear Config and Import Disks after bootup in NAS4FREE 11.1. This is what I get when I run RESCAN BUSSES after the O/S is running this is what shows up on the console and log file as well (device da1 would normally be what I should see as available for this hard drive): kernel: (da1:storvsc2:0:0:0): Periph destroyed Aug 24 13:56:45 nas4free kernel: da1 at storvsc2 bus 0 scbus4 target 0 lun 0 Aug 24 13:56:45 nas4free kernel: da1: < ST1000DM003-1SB1 CC43> Fixed Direct Access SCSI device Aug 24 13:56:45 nas4free kernel: da1: Serial Number Z9A4S5TQ Aug 24 13:56:45 nas4free kernel: da1: 300.000MB/s transfers Aug 24 13:56:45 nas4free kernel: da1: Command Queueing enabled Aug 24 13:56:45 nas4free kernel: da1: 953869MB (1953525168 512 byte sectors) Aug 24 13:56:45 nas4free kernel: da1 at storvsc2 bus 0 scbus4 target 0 lun 0 Aug 24 13:56:45 nas4free kernel: da1: < ST1000DM003-1SB1 CC43> s/n Z9A4S5TQ detached Aug 24 13:56:45 nas4free kernel: g_access(918): provider da1 has error Aug 24 13:56:45 nas4free last message repeated 8 times This tells me that the disk is being seen at start but something is causing it to detach. The drive itself is healthy. If I define the drive in HYPER-V as an IDE drive (similar to the O/S virtual disk), then it is seen successfully. If I were to guess there is a flaw in the integration between Microsoft's provided integration software embedded into FREEBSD 11 as it relates to SCSI only. Microsoft site indicates that FREEBSD 11.1 is fully supported in HYPER-V as it was with 10.X which previously worked well. See link: https://docs.microsoft.com/en-us/windows-server/virtualization/hyper-v/supported-freebsd-virtual-machines-on-hyper-v
These are the components included in the latest version of NAS4FREE 11.1 which includes the version of FREEBSD it's based on. BUILD 11.1.0.4.4528 =================== Changes: - Upgrade to FreeBSD 11.1-RELEASE-P1. - Update translations. - Add option to make USB devices available in virtualbox-ose. - Upgrade virtualbox-ose to 5.1.26. - Upgrade php to 7.1.8. - Upgrade samba to 4.6.6. - Upgrade syncthing to 0.14.36. - Upgrade e2fsprogs to 1.43.5.
I tried to reproduce this issue on my local Hyper-V (win2016), but I cannot reproduce it. win2016 is win10's corresponding version for server. I install both NAS4Free-x64-LiveCD-11.1.0.4.4528.iso and FreeNAS-11.0-U2.iso, and attach a raw disk to them. There is no issue occurs either for hot adding SCSI disk or add SCSI disk before boot. Could you please enable boot_verbose in order to dump more information? You can enable boot_verbose by adding 'boot_verbose="YES"' in /boot/loader.conf
Created attachment 185743 [details] FreeNAS 11.0u2 on win2k16
Created attachment 185744 [details] NAS4Free on win2k16
(In reply to ds from comment #8) > I don't know what a dmesg is. The command "man dmesg" may help. (In reply to ds from comment #12) Seems that your SCSI devices are got recognized a bit later then kernel expects. I'm not sure of delay nature, but you may try either/both lines at /boot/loader.conf: --- kern.cam.boot_delay="10000" kern.cam.scsi_delay="10000" --- The values are in ms and may vary. HTH & WBR -- bsam
Here is a copy of LOG after adding the parameters to loader.conf (no change to behaviour - still cannot see hard drive when SCSI connected) VM is running on W10PRO-64 Creators' update HYPERV, PC IS using Core i7-4770, 16 GB RAM, O/S Virtual disk on SAMSUNG 950PRO SSD VM has 2 virtual cpu's, 5 GB dedicated RAM, 1 virtual disk for O/S, 1 Seagate 1 TB disk defined as SCSI. LOG is below: --------------------------------------------------------------------------- Aug 25 10:07:19 nas4free kernel: (probe1:storvsc1:0:1:1): Down reving Protocol Version from 4 to 2? Aug 25 10:07:19 nas4free kernel: (probe0:storvsc2:0:1:1): Down reving Protocol Version from 4 to 2? Aug 25 10:07:19 nas4free kernel: (probe1:storvsc1:0:1:1): invalid LUN 1 for op: INQUIRY Aug 25 10:07:19 nas4free kernel: (probe4:storvsc2:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:07:19 nas4free kernel: (probe0:storvsc2:0:1:1): invalid LUN 1 for op: INQUIRY Aug 25 10:07:19 nas4free kernel: (probe4:storvsc2:0:0:0): storvsc inquiry (5) [0 0 0 6 0 ... ] Aug 25 10:07:19 nas4free kernel: (probe4:storvsc2:0:0:0): storvsc inquiry (24) [0 80 0 14 20 ... ] Aug 25 10:07:19 nas4free kernel: (probe4:storvsc2:0:0:0): Down reving Protocol Version from 4 to 0? Aug 25 10:07:19 nas4free kernel: (probe0:storvsc2:0:0:1): Down reving Protocol Version from 4 to 0? Aug 25 10:07:19 nas4free kernel: (probe0:storvsc2:0:0:1): invalid LUN 1 for op: INQUIRY Aug 25 10:07:19 nas4free kernel: GEOM: new disk da0 Aug 25 10:07:19 nas4free kernel: pass0 at ata1 bus 0 scbus1 target 0 lun 0 Aug 25 10:07:19 nas4free kernel: pass0: da0 at blkvsc0 bus 0 scbus2 target 0 lun 0 Aug 25 10:07:19 nas4free kernel: <Msft Virtual CD/ROM 1.0> Removable CD-ROM SPC-3 SCSI device Aug 25 10:07:19 nas4free kernel: da0: <Msft Virtual Disk 1.0> Fixed Direct Access SPC-3 SCSI device Aug 25 10:07:19 nas4free kernel: da0: 300.000MB/s transferspass0: 16.700MB/s transfers Aug 25 10:07:19 nas4free kernel: da0: Command Queueing enabled Aug 25 10:07:19 nas4free kernel: (WDMA2, ATAPI 12bytes, PIO 65534bytes) Aug 25 10:07:19 nas4free kernel: da0: 8192MB (16777216 512 byte sectors) Aug 25 10:07:19 nas4free kernel: (da0:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:07:19 nas4free kernel: pass1 at blkvsc0 bus 0 scbus2 target 0 lun 0 Aug 25 10:07:19 nas4free kernel: pass1: <Msft Virtual Disk 1.0> Fixed Direct Access SPC-3 SCSI device Aug 25 10:07:19 nas4free kernel: pass1: 300.000MB/s transfers Aug 25 10:07:19 nas4free kernel: pass1: Command Queueing enabled Aug 25 10:07:19 nas4free kernel: (da0:blkvsc0:0:0:0): storvsc inquiry (5) [0 b0 0 3c 0 ... ] Aug 25 10:07:19 nas4free kernel: (da0:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:07:19 nas4free kernel: da0: Delete methods: <UNMAP(*),ZERO> Aug 25 10:07:19 nas4free kernel: cd0 at ata1 bus 0 scbus1 target 0 lun 0 Aug 25 10:07:19 nas4free kernel: cd0: <Msft Virtual CD/ROM 1.0> Removable CD-ROM SPC-3 SCSI device Aug 25 10:07:19 nas4free kernel: cd0: 16.700MB/s transfers (WDMA2, ATAPI 12bytes, PIO 65534bytes) Aug 25 10:07:19 nas4free kernel: cd0: Attempt to query device size failed: NOT READY, Medium not present Aug 25 10:07:19 nas4free kernel: GEOM: new disk cd0 Aug 25 10:07:19 nas4free kernel: pci0: driver added Aug 25 10:07:19 nas4free kernel: found-> vendor=0x8086, dev=0x7113, revid=0x02 Aug 25 10:07:19 nas4free kernel: domain=0, bus=0, slot=7, func=3 Aug 25 10:07:19 nas4free kernel: class=06-80-00, hdrtype=0x00, mfdev=0 Aug 25 10:07:19 nas4free kernel: cmdreg=0x0001, statreg=0x0280, cachelnsz=0 (dwords) Aug 25 10:07:19 nas4free kernel: lattimer=0x00 (0 ns), mingnt=0x00 (0 ns), maxlat=0x00 (0 ns) Aug 25 10:07:19 nas4free kernel: intpin=a, irq=255 Aug 25 10:07:19 nas4free kernel: pci0:0:7:3: reprobing on driver added Aug 25 10:07:19 nas4free kernel: Trying to mount root from ufs:/dev/md0 []... Aug 25 10:07:19 nas4free kernel: start_init: trying /sbin/init Aug 25 10:07:19 nas4free kernel: hvtimesync0: apply sample request, hv: 1503670026393758200, vm: 1503670031458362999 Aug 25 10:07:19 nas4free kernel: random: unblocking device. Aug 25 10:07:19 nas4free kernel: hn0: set RX filter 0x00000009 done Aug 25 10:07:19 nas4free kernel: hn0: set RX filter 0x0000000d done Aug 25 10:07:19 nas4free kernel: hn0: set RX filter 0x00000009 done Aug 25 10:07:19 nas4free kernel: hn0: set RX filter 0x0000000d done Aug 25 10:07:26 nas4free nmbd[2008]: [2017/08/25 10:07:26.768961, 0] ../lib/util/become_daemon.c:124(daemon_ready) Aug 25 10:07:26 nas4free nmbd[2008]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Aug 25 10:07:26 nas4free nmbd[2008]: [2017/08/25 10:07:26.770613, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Aug 25 10:07:26 nas4free nmbd[2008]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.23 for name WORKGROUP<1d>. Aug 25 10:07:26 nas4free nmbd[2008]: This response was from IP 192.168.1.27, reporting an IP address of 192.168.1.27. Aug 25 10:07:26 nas4free smbd[2010]: [2017/08/25 10:07:26.827542, 0] ../lib/util/become_daemon.c:124(daemon_ready) Aug 25 10:07:26 nas4free smbd[2010]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Aug 25 10:07:26 nas4free lighttpd[2276]: (log.c.217) server started Aug 25 10:07:27 nas4free login: login on ttyv0 as root Aug 25 10:07:31 nas4free kernel: hvtimesync0: apply sample request, hv: 1503670051437612600, vm: 1503670049867119399 Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:07 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:19 nas4free kernel: fuse-freebsd: version 0.4.4, FUSE ABI 7.8 Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:19 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:20 nas4free mount.exfat: exFAT file system is not found Aug 25 10:08:20 nas4free mount.exfat: exFAT file system is not found Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:20 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:22 nas4free root: ataidle service restarted Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:22 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:24 nas4free kernel: (aprobe0:ata0:0:0:0): Disable ATA disks on simulated ATA controller (0x71118086) Aug 25 10:08:24 nas4free kernel: (probe1:blkvsc0:0:1:0): Down reving Protocol Version from 4 to 2? Aug 25 10:08:24 nas4free kernel: (probe1:blkvsc0:0:1:0): storvsc inquiry (36) [7f 0 5 2 1f ... ] Aug 25 10:08:24 nas4free kernel: (probe0:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:24 nas4free kernel: (probe0:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:24 nas4free kernel: (probe1:blkvsc0:0:1:1): Down reving Protocol Version from 4 to 2? Aug 25 10:08:24 nas4free kernel: (probe0:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:24 nas4free kernel: (probe1:blkvsc0:0:1:1): invalid LUN 1 for op: INQUIRY Aug 25 10:08:24 nas4free kernel: (probe0:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:24 nas4free kernel: (probe0:storvsc1:0:0:0): Down reving Protocol Version from 4 to 2? Aug 25 10:08:24 nas4free kernel: (probe1:storvsc1:0:1:0): Down reving Protocol Version from 4 to 2? Aug 25 10:08:24 nas4free kernel: (probe0:storvsc1:0:0:0): storvsc inquiry (36) [7f 0 5 2 1f ... ] Aug 25 10:08:24 nas4free kernel: (probe1:storvsc1:0:1:0): storvsc inquiry (36) [7f 0 5 2 1f ... ] Aug 25 10:08:24 nas4free kernel: (probe0:storvsc1:0:0:1): Down reving Protocol Version from 4 to 2? Aug 25 10:08:24 nas4free kernel: (probe1:storvsc1:0:1:1): Down reving Protocol Version from 4 to 2? Aug 25 10:08:24 nas4free kernel: (probe0:storvsc1:0:0:1): invalid LUN 1 for op: INQUIRY Aug 25 10:08:24 nas4free kernel: (probe1:storvsc1:0:1:1): invalid LUN 1 for op: INQUIRY Aug 25 10:08:24 nas4free kernel: (probe0:storvsc2:0:0:0): Down reving Protocol Version from 4 to 2? Aug 25 10:08:24 nas4free kernel: (probe1:storvsc2:0:1:0): Down reving Protocol Version from 4 to 2? Aug 25 10:08:24 nas4free kernel: (probe0:storvsc2:0:0:0): storvsc inquiry (36) [0 0 0 2 37 ... ] Aug 25 10:08:24 nas4free kernel: (probe1:storvsc2:0:1:0): storvsc inquiry (36) [7f 0 5 2 1f ... ] Aug 25 10:08:24 nas4free kernel: (probe0:storvsc2:0:0:0): storvsc inquiry (60) [0 0 0 2 37 ... ] Aug 25 10:08:24 nas4free kernel: (probe1:storvsc2:0:1:1): Down reving Protocol Version from 4 to 2? Aug 25 10:08:24 nas4free kernel: (probe0:storvsc2:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:24 nas4free kernel: (probe1:storvsc2:0:1:1): invalid LUN 1 for op: INQUIRY Aug 25 10:08:24 nas4free kernel: (probe0:storvsc2:0:0:0): storvsc inquiry (5) [0 0 0 6 0 ... ] Aug 25 10:08:24 nas4free kernel: (probe0:storvsc2:0:0:0): storvsc inquiry (24) [0 80 0 14 20 ... ] Aug 25 10:08:24 nas4free kernel: (probe0:storvsc2:0:0:0): Down reving Protocol Version from 4 to 0? Aug 25 10:08:24 nas4free kernel: pass2 at storvsc2 bus 0 scbus4 target 0 lun 0 Aug 25 10:08:24 nas4free kernel: pass2: < ST1000DM003-1SB1 CC43> Fixed Direct Access SCSI device Aug 25 10:08:24 nas4free kernel: pass2: Serial Number Z9A4S5TQ Aug 25 10:08:24 nas4free kernel: pass2: 300.000MB/s transfers Aug 25 10:08:24 nas4free kernel: pass2: Command Queueing enabled Aug 25 10:08:24 nas4free kernel: GEOM: new disk da1 Aug 25 10:08:24 nas4free kernel: (probe0:storvsc2:0:0:1): Down reving Protocol Version from 4 to 0? Aug 25 10:08:24 nas4free kernel: da1 at storvsc2 bus 0 scbus4 target 0 lun 0 Aug 25 10:08:24 nas4free kernel: da1: < ST1000DM003-1SB1 CC43> Fixed Direct Access SCSI device Aug 25 10:08:24 nas4free kernel: da1: Serial Number Z9A4S5TQ Aug 25 10:08:24 nas4free kernel: da1: 300.000MB/s transfers Aug 25 10:08:24 nas4free kernel: da1: Command Queueing enabled Aug 25 10:08:24 nas4free kernel: da1: 953869MB (1953525168 512 byte sectors) Aug 25 10:08:24 nas4free kernel: (probe0:storvsc2:0:0:1): invalid LUN 1 for op: INQUIRY Aug 25 10:08:24 nas4free kernel: da1 at storvsc2 bus 0 scbus4 target 0 lun 0 Aug 25 10:08:24 nas4free kernel: da1: < ST1000DM003-1SB1 CC43> s/n Z9A4S5TQ detached Aug 25 10:08:24 nas4free kernel: pass2 at storvsc2 bus 0 scbus4 target 0 lun 0 Aug 25 10:08:24 nas4free kernel: (da1:pass2: < ST1000DM003-1SB1 CC43> s/n Z9A4S5TQ detached Aug 25 10:08:24 nas4free kernel: storvsc2:0:0:0): storvsc inquiry (33) [0 b1 0 3c 1c ... ] Aug 25 10:08:24 nas4free kernel: (pass2:storvsc2:0:0:0): Periph destroyed Aug 25 10:08:24 nas4free kernel: (da1:storvsc2:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:24 nas4free kernel: da1: Delete methods: <NONE(*),ZERO> Aug 25 10:08:24 nas4free kernel: Opened disk da1 -> 6 Aug 25 10:08:24 nas4free kernel: g_access(918): provider da1 has error Aug 25 10:08:24 nas4free last message repeated 4 times Aug 25 10:08:24 nas4free kernel: (da1:storvsc2:0:0:0): Periph destroyed Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 0 0 8 0 ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (36) [0 0 5 2 1f ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 b2 0 4 1 ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (5) [0 b1 0 3c 0 ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6 Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc inquiry (6) [0 83 0 30 1 ... ] Aug 25 10:08:24 nas4free kernel: (pass1:blkvsc0:0:0:0): storvsc scsi_status = 2, srb_status = 6
Adding some additional testing I performed. Just to ensure I didn't have some anomaly in my test system described above (given that your internal test showed that running on Windows server 2016 HYPER-V didn't seem to reveal a problem running with virtual SCSI drives - I can't replicate this as I don't have the server version of Windows), I repeated a test with another pc, running same O/S platform as my test platform (Windows 10PRO64 - but older 3rd gen Intel CPU platform, i5-3570K, 16 GB RAM). That system is running a VM image of NAS4FREE 10.3 based on FREEBSD 10.3 successfully with a ZFS volume of 4 drives using RAID-Z1 resiliency. I created a new VM with newer NAS4FREE 11.1 image and imported the config file of the 10.3 NAS image which all ran fine, however the SCSI-defined disk drives attached to VM were no longer visible - same problem as reported on my test platform. I've done enough testing to know that this process doesn't damage the content of an existing ZFS volume, so I wasn't concerned about going back to 10.3 after doing this (which worked fine). If NAS4FREE 11 with FREEBSD11 runs fine in the Server 2016 version of HYPER-V but not on the desktop version (which is the same series - Server 2016 latest and W10 PRO Creators' Update then it begs the question as to what is different with those 2 platforms as it relates to virtual machines with integrations services and how FREEBSD11 works with them differently than 10.3 did. In the NAS4FREE support forum, someone else also reported running into this problem with VMWARE ESX hypervisor but don't know which version so that led me to think that HYPER-V was not be cause.
(In reply to ds from comment #16) I highly suspect this bug can be fixed by the attached patch in comment #2 of https://bugs.freebsd.org/bugzilla/show_bug.cgi?id=226583, but I don't have a physical disk on the host to pass through to the VM.
This bug seems to be fixed in version in XIGMANAS 11.2 that uses the 11.2-RELEASE Freebsd kernel. I can now see hard drives attached via SCCI virtual definition under HYPER-V in Windows 10 Professional. Thanks.
(In reply to ds from comment #18) Since it works for you, can you please close the bug?