iscsi service fails to restart

Status
Not open for further replies.
U

unijabnx2000

Dabbler
Joined
Mar 30, 2012
Messages
27
FreeNAS-9.2.1.6-RELEASE-x64 (ddd1e39)

Upon boot, the service is running, but nothing can connect.
I will manually turn off the service (in the web gui) but when I tried to turn it back on, it fails.

I didnt have this issue until I added LUN#6 (under the associated targets section)
After messing around... if I set the 7th LUN to 'auto' instead of defining the number, iscsi service can restart.
 
D

dlavigne

Guest
Please paste the errors that occur in /var/log/messages when you try to restart the iscsi service.
 
U

unijabnx2000

Dabbler
Joined
Mar 30, 2012
Messages
27
Sep 7 18:49:06 freenas root: /etc/rc: WARNING: failed to start istgt
Sep 7 18:49:06 freenas kernel: ...............+++
Sep 7 18:49:07 freenas generate_smb4_conf.py: [common.pipesubr:58] Popen()ing: /sbin/sysctl -n 'kern.maxfilesperproc'
Sep 7 18:49:07 freenas generate_smb4_conf.py: [common.pipesubr:58] Popen()ing: /usr/local/bin/pdbedit -d 0 -i smbpasswd:/tmp/tmpf4k
_E6 -s /usr/local/etc/smb4.conf -e tdbsam:/var/etc/private/passdb.tdb
Sep 7 19:02:50 freenas notifier: istgt not running? (check /var/run/istgt.pid).
Sep 7 19:02:51 freenas notifier: istgt not running? (check /var/run/istgt.pid).
Sep 7 19:02:51 freenas notifier: Will not 'restart' istgt because istgt_enable is NO.
Sep 7 19:08:52 freenas notifier: istgt not running? (check /var/run/istgt.pid).
Sep 7 19:08:52 freenas notifier: istgt not running? (check /var/run/istgt.pid).
Sep 7 19:08:52 freenas notifier: Starting istgt.
Sep 7 19:08:52 freenas notifier: istgt version 0.5 (20121028)
Sep 7 19:08:52 freenas istgt[4572]: istgt version 0.5 (20121028)
Sep 7 19:08:52 freenas notifier: normal mode
Sep 7 19:08:52 freenas istgt[4572]: normal mode
Sep 7 19:08:52 freenas notifier: using kqueue
Sep 7 19:08:52 freenas istgt[4572]: using kqueue
Sep 7 19:08:52 freenas notifier: using host atomic
Sep 7 19:08:52 freenas istgt[4572]: using host atomic
Sep 7 19:08:52 freenas istgt[4572]: istgt_lu.c:1915:istgt_lu_add_unit: ***ERROR*** LU1: no LUN0
Sep 7 19:08:52 freenas notifier: istgt_lu.c:1915:istgt_lu_add_unit: ***ERROR*** LU1: no LUN0
Sep 7 19:08:52 freenas notifier: istgt_lu.c:2151:istgt_lu_init: ***ERROR*** lu_add_unit() failed
Sep 7 19:08:52 freenas istgt[4572]: istgt_lu.c:2151:istgt_lu_init: ***ERROR*** lu_add_unit() failed
Sep 7 19:08:52 freenas notifier: istgt.c:2799:main: ***ERROR*** istgt_lu_init() failed
Sep 7 19:08:52 freenas istgt[4572]: istgt.c:2799:main: ***ERROR*** istgt_lu_init() failed
Sep 7 19:08:52 freenas root: /usr/local/etc/rc.d/istgt: WARNING: failed to start istgt
Sep 7 19:08:52 freenas notifier: /usr/local/etc/rc.d/istgt: WARNING: failed to start istgt
Sep 7 19:09:34 freenas notifier: Will not 'reload' istgt because istgt_enable is NO.
Sep 7 19:10:25 freenas last message repeated 4 times
Sep 7 19:10:44 freenas notifier: Will not 'reload' istgt because istgt_enable is NO.
Sep 7 19:10:49 freenas notifier: istgt not running? (check /var/run/istgt.pid).
Sep 7 19:10:49 freenas notifier: istgt not running? (check /var/run/istgt.pid).
Sep 7 19:10:49 freenas notifier: Starting istgt.
Sep 7 19:10:49 freenas notifier: istgt version 0.5 (20121028)
Sep 7 19:10:49 freenas istgt[7437]: istgt version 0.5 (20121028)
Sep 7 19:10:49 freenas notifier: normal mode
Sep 7 19:10:49 freenas istgt[7437]: normal mode
Sep 7 19:10:49 freenas notifier: using kqueue
Sep 7 19:10:49 freenas istgt[7437]: using kqueue
Sep 7 19:10:49 freenas istgt[7437]: using host atomic
Sep 7 19:11:09 freenas istgt[7438]: reload configuration #1
Sep 7 19:11:09 freenas istgt[7438]: add PG1
Sep 7 19:11:16 freenas istgt[7438]: reload configuration #2
Sep 7 19:11:16 freenas istgt[7438]: add IG1
Sep 7 19:11:37 freenas istgt[7438]: reload configuration #3
Sep 7 19:12:04 freenas istgt[7438]: reload configuration #4
Sep 7 19:12:14 freenas istgt[7438]: reload configuration #5
Sep 7 19:12:14 freenas istgt[7438]: add LU1: Name=iqn.2014-03.org.example.istgt:08r2
Sep 7 19:12:22 freenas istgt[7438]: Login(discovery) from iqn.2013-05.com.microsoft:cont666 (172.16.0.123) on (172.16.0.25:3260,1),
ISID=400001370000, TSIH=1, CID=1, HeaderDigest=off, DataDigest=off
Sep 7 19:12:22 freenas istgt[7438]: Logout(discovery) from iqn.2013-05.com.microsoft:cont666 (172.16.0.123) on (172.16.0.25:3260,1)
, ISID=400001370000, TSIH=1, CID=1, HeaderDigest=off, DataDigest=off
Sep 7 19:12:22 freenas istgt[7438]: istgt_iscsi.c:6749:istgt_iscsi_drop_old_conns: ***WARNING*** drop old connections iqn.2014-03.o
rg.example.istgt:08r2 by iqn.2013-05.com.microsoft:cont666,i,0x400001370000
Sep 7 19:12:23 freenas istgt[7438]: Login from iqn.2013-05.com.microsoft:cont666 (172.16.0.123) on iqn.2014-03.org.example.istgt:08
r2 LU1 (172.16.0.25:3260,1), ISID=400001370000, TSIH=1, CID=1, HeaderDigest=off, DataDigest=off
Sep 7 19:12:58 freenas istgt[7438]: reload configuration #6
Sep 7 19:13:25 freenas istgt[7438]: reload configuration #7
Sep 7 19:13:40 freenas istgt[7438]: reload configuration #8
Sep 7 19:13:50 freenas istgt[7438]: reload configuration #9
Sep 7 19:13:50 freenas istgt[7438]: add LU3: Name=iqn.2014-03.org.example.istgt:ddom
Sep 7 19:14:03 freenas istgt[7438]: reload configuration #10
Sep 7 19:14:13 freenas istgt[7438]: reload configuration #11
Sep 7 19:14:13 freenas istgt[7438]: add LU2: Name=iqn.2014-03.org.example.istgt:ws2012
Sep 7 19:14:32 freenas istgt[7438]: reload configuration #12
Sep 7 19:14:32 freenas istgt[7438]: delete LU3: Name=iqn.2014-03.org.example.istgt:ddom
Sep 7 19:14:35 freenas istgt[7438]: reload configuration #13
Sep 7 19:14:35 freenas istgt[7438]: delete LU2: Name=iqn.2014-03.org.example.istgt:ws2012
Sep 7 19:14:38 freenas istgt[7438]: reload configuration #14
Sep 7 19:14:38 freenas istgt[7438]: istgt_lu.c:2218:istgt_lu_reload_delete: ***WARNING*** It is recommended that you disconnect the
target before deletion.
Sep 7 19:14:38 freenas istgt[7438]: istgt_lu.c:2223:istgt_lu_reload_delete: ***WARNING*** delete request for active LU1
Sep 7 19:14:44 freenas istgt[7438]: istgt_iscsi.c:6749:istgt_iscsi_drop_old_conns: ***WARNING*** drop old connections iqn.2014-03.o
rg.example.istgt:08r2 by iqn.2013-05.com.microsoft:cont666,i,0x400001370000
Sep 7 19:14:44 freenas istgt[7438]: istgt_iscsi.c:6770:istgt_iscsi_drop_old_conns: ***WARNING*** exiting conn by iqn.2013-05.com.mi
crosoft:cont666,i,0x400001370000(172.16.0.123), TSIH=1, CID=1
Sep 7 19:14:45 freenas istgt[7438]: istgt_iscsi.c:6816:istgt_iscsi_drop_old_conns: ***WARNING*** exiting 1 conns
Sep 7 19:14:45 freenas istgt[7438]: delete LU1: Name=iqn.2014-03.org.example.istgt:08r2
Sep 7 19:14:50 freenas istgt[7438]: istgt_lu.c: 524:istgt_lu_find_target: ***WARNING*** can't find target iqn.2014-03.org.example.i
stgt:08r2
Sep 7 19:14:50 freenas istgt[7438]: istgt_iscsi.c:2479:istgt_iscsi_op_login: ***ERROR*** lu_find_target() failed
Sep 7 19:14:52 freenas istgt[7438]: reload configuration #15
Sep 7 19:15:10 freenas istgt[7438]: Login(discovery) from iqn.2013-05.com.microsoft:cont666 (172.16.0.123) on (172.16.0.25:3260,1),
ISID=400001370000, TSIH=2, CID=1, HeaderDigest=off, DataDigest=off
Sep 7 19:15:10 freenas istgt[7438]: Logout(discovery) from iqn.2013-05.com.microsoft:cont666 (172.16.0.123) on (172.16.0.25:3260,1)
, ISID=400001370000, TSIH=2, CID=1, HeaderDigest=off, DataDigest=off
Sep 7 19:15:34 freenas istgt[7438]: reload configuration #16
Sep 7 19:15:45 freenas istgt[7438]: reload configuration #17
Sep 7 19:15:45 freenas istgt[7438]: add LU1: Name=iqn.2014-03.org.example.istgt:cont666
Sep 7 19:15:52 freenas istgt[7438]: reload configuration #18
Sep 7 19:15:52 freenas istgt[7438]: update LU1: Name=iqn.2014-03.org.example.istgt:cont666
Sep 7 19:16:02 freenas istgt[7438]: reload configuration #19
Sep 7 19:16:02 freenas istgt[7438]: update LU1: Name=iqn.2014-03.org.example.istgt:cont666
Sep 7 19:16:09 freenas istgt[7438]: reload configuration #20
Sep 7 19:16:09 freenas istgt[7438]: update LU1: Name=iqn.2014-03.org.example.istgt:cont666
Sep 7 19:16:36 freenas istgt[7438]: Login(discovery) from iqn.2013-05.com.microsoft:cont666 (172.16.0.123) on (172.16.0.25:3260,1),
ISID=400001370000, TSIH=3, CID=1, HeaderDigest=off, DataDigest=off
Sep 7 19:16:36 freenas istgt[7438]: Logout(discovery) from iqn.2013-05.com.microsoft:cont666 (172.16.0.123) on (172.16.0.25:3260,1)
, ISID=400001370000, TSIH=3, CID=1, HeaderDigest=off, DataDigest=off
Sep 7 19:16:36 freenas istgt[7438]: istgt_iscsi.c:6749:istgt_iscsi_drop_old_conns: ***WARNING*** drop old connections iqn.2014-03.o
rg.example.istgt:cont666 by iqn.2013-05.com.microsoft:cont666,i,0x400001370000
Sep 7 19:16:37 freenas istgt[7438]: Login from iqn.2013-05.com.microsoft:cont666 (172.16.0.123) on iqn.2014-03.org.example.istgt:co
nt666 LU1 (172.16.0.25:3260,1), ISID=400001370000, TSIH=1, CID=1, HeaderDigest=off, DataDigest=off
 
D

dlavigne

Guest
Were you able to figure this out yet?

If not, does switching to the experimental kernel iscsi resolve the problem?
 
U

unijabnx2000

Dabbler
Joined
Mar 30, 2012
Messages
27
Yes.

My last sentence was the solution I used.
"After messing around... if I set the 7th LUN to 'auto' instead of defining the number, iscsi service can restart."

I imagine any more LUNs I create will be 'auto' as well.
 
Status
Not open for further replies.

Important Announcement for the TrueNAS Community.

The TrueNAS Community has now been moved. This forum will now become READ-ONLY for historical purposes. Please feel free to join us on the new TrueNAS Community Forums.

Related topics on forums.truenas.com for thread: "iscsi service fails to restart"

Similar threads

C
  • Locked
Why expand a iSCSI target need restart iSCSI service??
Replies
1
Views
2K
pirateghost
pirateghost
C
  • Locked
UPS service does not start properly on boot
Replies
8
Views
2K
IonutZ
IonutZ
justgosh
  • Locked
iSCSI The service could not be started.
Replies
3
Views
2K
dlavigne
D
A
  • Locked
Not able to start iscsi service on 9.2.1.5
Replies
9
Views
3K
arumon
A
Stux
  • Locked
iSCSI, wanting to add another extent?
Replies
2
Views
3K
Stux
Stux
Top