On 04/05/2009 07:15 PM, Boaz Harrosh wrote:
> On 04/05/2009 06:48 PM, Boaz Harrosh wrote:
>> On 04/02/2009 07:29 PM, Boaz Harrosh wrote:
>>> Sorry, it's gating late here, I'll only get to it first thing Sunday.
>>>
>>> Have a good weekend
>>> Boaz
>>>
>> I'm back
>>
>> []$ ll /sbin/iscsi*
>> -rwxr-xr-x 1 root root  19836 Apr  5 11:18 /sbin/iscsi-iname
>> -rwxr-xr-x 1 root root   5309 Apr  5 11:18 /sbin/iscsi_discovery
>> -rwxr-xr-x 1 root root 723987 Apr  5 11:18 /sbin/iscsiadm
>> -rwxr-xr-x 1 root root 731275 Apr  5 11:18 /sbin/iscsid
>> -rwxr-xr-x 1 root root 792424 Oct  5  2007 /sbin/iscsistart
>>
>> []$ find ${PATH//:/ } -name iscsiadm
>> /sbin/iscsiadm
>>
>> []$ find ${PATH//:/ } -name iscsid
>> /sbin/iscsid
>>
>> []$ iscsid -d 8 -f &                               
>> [1] 1119                                                               
>> iscsid: sysfs_init: sysfs_path='/sys'                                  
>> iscsid: sysfs_attr_get_value: open '/module/scsi_transport_iscsi'/'version'
>> iscsid: sysfs_attr_get_value: new uncached attribute 
>> '/sys/module/scsi_transport_iscsi/version'
>> iscsid: sysfs_attr_get_value: add to cache 
>> '/sys/module/scsi_transport_iscsi/version'
>> iscsid: sysfs_attr_get_value: cache 
>> '/sys/module/scsi_transport_iscsi/version' with attribute value '2.0-870'    
>>                                                                              
>>     
>>
>> iscsid: transport class version 2.0-870. iscsid version 2.0-871
>> iscsid: in ctldev_open                                         
>> iscsid: created NETLINK_ISCSI socket...                        
>> iscsid: InitiatorName==iqn.2006-10.com.bhalevy:um.initiator    
>> iscsid: InitiatorAlias==um.bhalevy.com                         
>> iscsid: InitiatorName=iqn.2006-10.com.bhalevy:um.initiator     
>> iscsid: InitiatorAlias=um.bhalevy.com                          
>> iscsid: in ctldev_close                                        
>> iscsid: Max file limits 1024 1024                              
>> iscsid: reaped pid 1120, reap_count now 0
>>
>>
>> I run iscsiadm on same consul so you can see prints from both
>> iscsiadm && iscsid.
>>
>> []$ iscsiadm -d 9 -m discovery -t sendtargets -p 192.168.0.241:3260 --login
>> iscsiadm: ip 192.168.0.241, port 3260, tgpt -1                               
>>                   
>> iscsiadm: Max file limits 1024 1024                                          
>>                   
>>
>> iscsid: poll result 1
>> iscsid: mgmt_ipc_write_rsp: rsp to fd 5
>> iscsiadm: updating defaults from '/etc/iscsi/iscsid.conf'
>> iscsiadm: updated 'discovery.sendtargets.iscsi.MaxRecvDataSegmentLength', 
>> '32768' => '32768'
>> iscsiadm: updated 'node.startup', 'manual' => 'manual'                       
>>                
>> iscsiadm: updated 'node.session.timeo.replacement_timeout', '120' => '120'
>> iscsiadm: updated 'node.conn[0].timeo.login_timeout', '30' => '15'
>> iscsiadm: updated 'node.conn[0].timeo.logout_timeout', '15' => '15'
>> iscsiadm: updated 'node.conn[0].timeo.noop_out_interval', '5' => '5'
>> iscsiadm: updated 'node.conn[0].timeo.noop_out_timeout', '5' => '5'
>> iscsiadm: updated 'node.session.err_timeo.abort_timeout', '15' => '15'
>> iscsiadm: updated 'node.session.err_timeo.lu_reset_timeout', '30' => '20'
>> iscsiadm: updated 'node.session.initial_login_retry_max', '4' => '8'
>> iscsiadm: updated 'node.session.cmds_max', '128' => '128'
>> iscsiadm: updated 'node.session.queue_depth', '32' => '32'
>> iscsiadm: updated 'node.session.iscsi.InitialR2T', 'No' => 'No'
>> iscsiadm: updated 'node.session.iscsi.ImmediateData', 'Yes' => 'Yes'
>> iscsiadm: updated 'node.session.iscsi.FirstBurstLength', '262144' => '262144'
>> iscsiadm: updated 'node.session.iscsi.MaxBurstLength', '16776192' => 
>> '16776192'
>> iscsiadm: updated 'node.conn[0].iscsi.MaxRecvDataSegmentLength', '262144' => 
>> '131072'
>> iscsiadm: updated 'node.session.iscsi.FastAbort', 'Yes' => 'Yes'
>> iscsiadm: starting sendtargets discovery, address 192.168.0.241:3260,
>> iscsid: poll result 1
>> iscsid: mgmt_ipc_write_rsp: rsp to fd 5
>> iscsid: poll result 1
>> iscsid: mgmt_ipc_write_rsp: rsp to fd 5
>> iscsiadm: sendtargets discovery to 192.168.0.241:3260 using isid 
>> 0x00023d000000
>> iscsiadm: discovery timeouts: login 15, reopen_cnt 5, auth 45.
>> iscsiadm: connecting to 192.168.0.241:3260
>> iscsiadm: connected local port 55107 to 192.168.0.241:3260
>> iscsiadm: connected to discovery address 192.168.0.241
>> iscsiadm: discovery session to 192.168.0.241:3260 starting iSCSI login on fd 
>> 3
>> iscsiadm: InitiatorName is required on the first Login PDU
>> iscsiadm: login failed, couldn't make a login PDU
>> iscsiadm: discovery login to 192.168.0.241 failed, giving up
>> iscsiadm: disconnecting conn 0x639040, fd 3
>>
>>
>> Same stuff. I'll try to inspect the code and put some prints to understand 
>> where
>> it fails. I'll start with the hunk you sent
>>
>> Boaz
>>
> 
> I applied your print and got it the same as before but with the OK print
> here is the diff from above prints
> 
>  iscsiadm: updated 'node.session.iscsi.FastAbort', 'Yes' => 'Yes'
>  iscsiadm: starting sendtargets discovery, address 192.168.0.142:3260,
>  iscsid: poll result 1
>  iscsid: mgmt_ipc_write_rsp: rsp to fd 5
> +iscsiadm: ok got: iqn.2006-10.com.bhalevy:um.initiator.
>  iscsid: poll result 1
>  iscsid: mgmt_ipc_write_rsp: rsp to fd 5
>  iscsiadm: sendtargets discovery to 192.168.0.142:3260 using isid 
> 0x00023d000000
>  iscsiadm: discovery timeouts: login 15, reopen_cnt 5, auth 45.
> 
> So it is something to do with the actual protocol with the target. Now I'm
> angry with it. Maybe it is even my bug on the target, mmm... but why does it
> work with 2.0-870 and not 2.0-871. I'll investigate and come back to you.
> Time to compile every thing in debug. Both sides
> 
> Thanks
> Boaz
> 

One last update for today. I'll look into it tomorrow.

I'm using 2.6.30-rc0 [Linux tip including merge window patches]
and I do:

echo 1 > /sys/module/iscsi_tcp/parameters/debug_iscsi_tcp
echo 1 > /sys/module/libiscsi_tcp/parameters/debug_libiscsi_tcp
echo 1 > /sys/module/lbiscsi/parameters/debug_libiscsi

[cat will show ones]

then I do the above iscsiadm command above and I don't see even
a single print in /var/log/messages. I do see the usual:
  Apr  5 20:25:47 testlin2 kernel: Loading iSCSI transport class v2.0-870.
  Apr  5 20:25:47 testlin2 kernel: iscsi: registered transport (tcp)

What KERN_* level is it printing? One small request for me when I do
echo 1/0 > */debug_*iscsi* please printk an "Turning debug on/off" so we can
see that it works in /var/log/messages.

Thanks
Boaz

--~--~---------~--~----~------------~-------~--~----~
You received this message because you are subscribed to the Google Groups 
"open-iscsi" group.
To post to this group, send email to open-iscsi@googlegroups.com
To unsubscribe from this group, send email to 
open-iscsi+unsubscr...@googlegroups.com
For more options, visit this group at http://groups.google.com/group/open-iscsi
-~----------~----~----~----~------~----~------~--~---

Reply via email to