Volume Virtualization unable to connect

I’m having a really hard time trying to get my PR4100 to connect to a FreeNAS iSCSI target.

I got it to work once after I configured it then restart both the PR4100 and my FreeNAS box. I now removed that config (as it was just for testing) and created a new target on the FreeNAS box and now it just won’t connect no matter how many times I reboot the boxes.

I can configure it fine and select the LUN and the share folder but it stays in a “disconnected” state and doesn’t change.

I’ve tested this from Windows and it works flawlessly and as I mentioned I had this working previously.

I found the log for this in the temp folder, and it shows the following:

[virtual_vol.c:75][Target Search] - cmd:vvctl --search -i "192.168.1.20" -p "3260" -o /var/www/xml/vv_search.xml > /dev/null 2>&1

[virtual_vol.c:128][LUN Search] - cmd:vvctl --search_lun -n "iqn.2005-10.org.freenas.ctl:target-0" -i "192.168.1.20" -p "3260" -c "0" -o /var/www/xml/vv_search.xml > /dev/null 2>&1

[virtual_vol.c:168][Share Name Check] - cmd:vvctl --check_share_name -s "zfs" > /dev/null 2>&1

[virtual_vol.c:229][Create] - cmd:vvctl --add -n "iqn.2005-10.org.freenas.ctl:target-0" -l "0" -i "192.168.1.20" -p "3260" -s zfs -c "0" > /dev/null 2>&1

[virtual_vol.c:75][Target Search] - cmd:vvctl --search -i "192.168.2.1" -p "3260" -o /var/www/xml/vv_search.xml > /dev/null 2>&1

[virtual_vol.c:304][Target Connected] - cmd:vvctl --connect -n "iqn.2005-10.org.freenas.ctl:target-0" > /dev/null 2>&1 &

[virtual_vol.c:619][Refresh] - cmd:vvctl --status > /dev/null 2>&1

[virtual_vol.c:304][Target Connected] - cmd:vvctl --connect -n "iqn.2005-10.org.freenas.ctl:target-0" > /dev/null 2>&1 &

[virtual_vol.c:619][Refresh] - cmd:vvctl --status > /dev/null 2>&1

If I try to send the connect command as in the log it shows the following:

root@MyCloudPR4100 /tmp # vvctl --connect -n "iqn.2005-10.org.freenas.ctl:target-0"

New iSCSI node [tcp:[hw=,ip=,net_if=,iscsi_if=default] 192.168.1.20,3260,-1 iqn.2005-10.org.freenas.ctl:target-0] added
Logging out of session [sid: 6, target: iqn.2005-10.org.freenas.ctl:target-0, portal: 192.168.1.20,3260]
Logout of [sid: 6, target: iqn.2005-10.org.freenas.ctl:target-0, portal: 192.168.1.20,3260] successful.
execute failed.

All output from the vvctl command ends with execute failed (even a vvctl --help) - I don’t know if this should be happening.

Would really like to have this working again.

TiA

Hmm, okay. I managed to get it formatted and connected now by spamming the connect button. I just continued clicking it and after about the 8th click it started formatting.

I think there may be a problem with the firmware.

Hi,

What firmware are you running on the PR?

The latest firmware which is available as far as I can tell:

Current Version
2.21.119

I had to shutdown everything to recable a bunch of stuff and on reboot it lost connection to the FreeNAS target again.

This seemed due to the fact that the second network interface, which I’m using as a dedicated direct link for the iSCSI connection, doesn’t intitialize properly on reboot. The static IP I assigned for it doesn’t get set:

root@MyCloudPR4100 root # ifconfig
docker0   Link encap:Ethernet  HWaddr 8A:5B:BD:A9:2C:BC
          inet addr:172.17.42.1  Bcast:0.0.0.0  Mask:255.255.0.0
          UP BROADCAST RUNNING MULTICAST  MTU:1500  Metric:1
          RX packets:0 errors:0 dropped:0 overruns:0 frame:0
          TX packets:28 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:0
          RX bytes:0 (0.0 B)  TX bytes:10048 (9.8 KiB)

egiga0    Link encap:Ethernet  HWaddr 00:14:EE:00:A3:70
          inet addr:192.168.1.30  Bcast:192.168.1.255  Mask:255.255.255.0
          UP BROADCAST RUNNING MULTICAST  MTU:1500  Metric:1
          RX packets:1973 errors:0 dropped:0 overruns:0 frame:0
          TX packets:2120 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:1000
          RX bytes:596848 (582.8 KiB)  TX bytes:1182226 (1.1 MiB)

egiga1    Link encap:Ethernet  HWaddr 00:14:EE:00:A3:71
          UP BROADCAST RUNNING MULTICAST  MTU:1500  Metric:1
          RX packets:0 errors:0 dropped:0 overruns:0 frame:0
          TX packets:0 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:1000
          RX bytes:0 (0.0 B)  TX bytes:0 (0.0 B)

lo        Link encap:Local Loopback
          inet addr:127.0.0.1  Mask:255.0.0.0
          UP LOOPBACK RUNNING  MTU:65536  Metric:1
          RX packets:698 errors:0 dropped:0 overruns:0 frame:0
          TX packets:698 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:0
          RX bytes:207337 (202.4 KiB)  TX bytes:207337 (202.4 KiB)

See interface egiga1 above has no IP assigned even though in the web interface it says it has:

Either setting the static IP again in the settings or just plugging the cable out and back in again allows the interface to come online properly.

Then after multiple reboots again and attempting to spam the connect button didn’t want to work I eventually removed the volume in the settings again, rebooted, got the interface up and then re-added the volume. Then I spammed the connect command in the cli and got it working after the 40th connect:

root@MyCloudPR4100 /tmp # vvctl --connect -n "iqn.2005-10.org.freenas.ctl:target-0"

New iSCSI node [tcp:[hw=,ip=,net_if=,iscsi_if=default] 192.168.2.1,3260,-1 iqn.2005-10.org.freenas.ctl:target-0] added
Logging out of session [sid: 36, target: iqn.2005-10.org.freenas.ctl:target-0, portal: 192.168.2.1,3260]
Logout of [sid: 36, target: iqn.2005-10.org.freenas.ctl:target-0, portal: 192.168.2.1,3260] successful.
execute failed.
root@MyCloudPR4100 /tmp # vvctl --connect -n "iqn.2005-10.org.freenas.ctl:target-0"

New iSCSI node [tcp:[hw=,ip=,net_if=,iscsi_if=default] 192.168.2.1,3260,-1 iqn.2005-10.org.freenas.ctl:target-0] added
Logging out of session [sid: 37, target: iqn.2005-10.org.freenas.ctl:target-0, portal: 192.168.2.1,3260]
Logout of [sid: 37, target: iqn.2005-10.org.freenas.ctl:target-0, portal: 192.168.2.1,3260] successful.
execute failed.
root@MyCloudPR4100 /tmp # vvctl --connect -n "iqn.2005-10.org.freenas.ctl:target-0"

New iSCSI node [tcp:[hw=,ip=,net_if=,iscsi_if=default] 192.168.2.1,3260,-1 iqn.2005-10.org.freenas.ctl:target-0] added
Logging out of session [sid: 38, target: iqn.2005-10.org.freenas.ctl:target-0, portal: 192.168.2.1,3260]
Logout of [sid: 38, target: iqn.2005-10.org.freenas.ctl:target-0, portal: 192.168.2.1,3260] successful.
execute failed.
root@MyCloudPR4100 /tmp # vvctl --connect -n "iqn.2005-10.org.freenas.ctl:target-0"

New iSCSI node [tcp:[hw=,ip=,net_if=,iscsi_if=default] 192.168.2.1,3260,-1 iqn.2005-10.org.freenas.ctl:target-0] added
Logging out of session [sid: 39, target: iqn.2005-10.org.freenas.ctl:target-0, portal: 192.168.2.1,3260]
Logout of [sid: 39, target: iqn.2005-10.org.freenas.ctl:target-0, portal: 192.168.2.1,3260] successful.
execute failed.
root@MyCloudPR4100 /tmp # vvctl --connect -n "iqn.2005-10.org.freenas.ctl:target-0"

New iSCSI node [tcp:[hw=,ip=,net_if=,iscsi_if=default] 192.168.2.1,3260,-1 iqn.2005-10.org.freenas.ctl:target-0] added
Logging out of session [sid: 40, target: iqn.2005-10.org.freenas.ctl:target-0, portal: 192.168.2.1,3260]
Logout of [sid: 40, target: iqn.2005-10.org.freenas.ctl:target-0, portal: 192.168.2.1,3260] successful.
execute failed.
root@MyCloudPR4100 /tmp # vvctl --connect -n "iqn.2005-10.org.freenas.ctl:target-0"

New iSCSI node [tcp:[hw=,ip=,net_if=,iscsi_if=default] 192.168.2.1,3260,-1 iqn.2005-10.org.freenas.ctl:target-0] added
dumpe2fs 1.42.9 (28-Dec-2013)
resize2fs 1.42.9 (28-Dec-2013)
The filesystem is already 728760059 blocks long.  Nothing to do!

killall: cnid_metad: no process killed

I dread having to reboot anything again.