[Bug 1200000] New: qla2xxx no longer detects LTO drive starting from kernel 5.17.4
http://bugzilla.opensuse.org/show_bug.cgi?id=1200000 Bug ID: 1200000 Summary: qla2xxx no longer detects LTO drive starting from kernel 5.17.4 Classification: openSUSE Product: openSUSE Tumbleweed Version: Current Hardware: x86-64 OS: openSUSE Tumbleweed Status: NEW Severity: Critical Priority: P5 - None Component: Kernel Assignee: kernel-bugs@opensuse.org Reporter: andreas.bolsch@alumni.tu-berlin.de QA Contact: qa-bugs@suse.de Found By: --- Blocker: --- Last known good kernel: 5.6.11 First known bad kernel: 5.17.4 Since recent update of kernel from 5.6.11 to 5.7.4 and now on 5.7.9 LTO tape drives attached to QLA2312 card are no longer detected. The relevant logs when modprobing qla2xxx are attached. Card has two ports, one is unused. 5.16.11, drive detected: 2022-05-28T19:26:46.095352+02:00 julia kernel: [ 78.236044] qla2xxx [0000:05:06.0]-b079:6: Removing driver 2022-05-28T19:26:53.584360+02:00 julia kernel: [ 85.725058] qla2xxx [0000:00:00.0]-0005: : QLogic Fibre Channel HBA Driver: 10.02.07.200-k-debug. 2022-05-28T19:26:53.585358+02:00 julia kernel: [ 85.725321] qla2xxx [0000:00:00.0]-001d: : Found an ISP2312 irq 21 iobase 0x000000009c34e664. 2022-05-28T19:26:53.687368+02:00 julia kernel: [ 85.828025] qla2xxx [0000:05:06.0]-ffff:6: FC4 priority set to FCP 2022-05-28T19:26:53.748461+02:00 julia kernel: [ 85.888246] qla2xxx [0000:05:06.0]-507b:6: SFP detect: Short-Range SFP (nvr=0 ll=0 lr=0 lrd=0). 2022-05-28T19:26:53.904414+02:00 julia kernel: [ 86.044427] scsi host6: qla2xxx 2022-05-28T19:26:53.904434+02:00 julia kernel: [ 86.044438] qla2xxx [0000:05:06.0]-4000:6: DPC handler sleeping. 2022-05-28T19:26:53.906374+02:00 julia kernel: [ 86.047110] qla2xxx [0000:05:06.0]-00fb:6: QLogic QLA2342 - . 2022-05-28T19:26:53.906398+02:00 julia kernel: [ 86.047120] qla2xxx [0000:05:06.0]-00fc:6: ISP2312: PCI (33 MHz) @ 0000:05:06.0 hdma+ host#=6 fw=3.03.28 IPX. 2022-05-28T19:26:53.907354+02:00 julia kernel: [ 86.047392] qla2xxx [0000:00:00.0]-001d: : Found an ISP2312 irq 22 iobase 0x000000005ec64c3e. 2022-05-28T19:26:54.009376+02:00 julia kernel: [ 86.150142] qla2xxx [0000:05:06.1]-ffff:7: FC4 priority set to FCP 2022-05-28T19:26:54.070421+02:00 julia kernel: [ 86.210240] qla2xxx [0000:05:06.1]-507b:7: SFP detect: Short-Range SFP (nvr=0 ll=0 lr=0 lrd=0). 2022-05-28T19:26:54.130385+02:00 julia kernel: [ 86.270426] scsi host7: qla2xxx 2022-05-28T19:26:54.130440+02:00 julia kernel: [ 86.270435] qla2xxx [0000:05:06.1]-4000:7: DPC handler sleeping. 2022-05-28T19:26:54.132350+02:00 julia kernel: [ 86.273127] qla2xxx [0000:05:06.1]-00fb:7: QLogic QLA2342 - . 2022-05-28T19:26:54.132367+02:00 julia kernel: [ 86.273136] qla2xxx [0000:05:06.1]-00fc:7: ISP2312: PCI (33 MHz) @ 0000:05:06.1 hdma+ host#=7 fw=3.03.28 IPX. 2022-05-28T19:26:54.418228+02:00 julia kernel: [ 86.558947] qla2xxx [0000:05:06.1]-500c:7: LIP reset occurred (f8f7). 2022-05-28T19:26:54.449099+02:00 julia kernel: [ 86.589819] qla2xxx [0000:05:06.1]-5009:7: LIP occurred (f8f7). 2022-05-28T19:26:54.453365+02:00 julia kernel: [ 86.594061] qla2xxx [0000:05:06.1]-500a:7: LOOP UP detected (2 Gbps). 2022-05-28T19:26:54.453384+02:00 julia kernel: [ 86.594105] qla2xxx [0000:05:06.1]-5012:7: Port database changed ffff 0006 0000. 2022-05-28T19:26:54.952456+02:00 julia kernel: [ 87.092253] qla2xxx [0000:05:06.0]-400f:6: Loop resync scheduled. 2022-05-28T19:26:55.144428+02:00 julia kernel: [ 87.284214] qla2xxx [0000:05:06.1]-400b:7: Reset marker scheduled. 2022-05-28T19:26:55.144446+02:00 julia kernel: [ 87.284222] qla2xxx [0000:05:06.1]-400c:7: Reset marker end. 2022-05-28T19:26:55.144455+02:00 julia kernel: [ 87.284225] qla2xxx [0000:05:06.1]-400f:7: Loop resync scheduled. 2022-05-28T19:26:55.144458+02:00 julia kernel: [ 87.284312] qla2xxx [0000:05:06.1]-8037:7: F/W Ready - OK. 2022-05-28T19:26:55.144460+02:00 julia kernel: [ 87.284345] qla2xxx [0000:05:06.1]-803a:7: fw_state=3 (ffff, ffff, ffff, ffff ffff) curr time=fffcc080. 2022-05-28T19:26:55.144463+02:00 julia kernel: [ 87.284390] qla2xxx [0000:05:06.1]-200b:7: HBA in NL topology. 2022-05-28T19:26:55.144465+02:00 julia kernel: [ 87.284398] qla2xxx [0000:05:06.1]-2014:7: Configure loop -- dpc flags = 0x112e0. 2022-05-28T19:26:55.145822+02:00 julia kernel: [ 87.286318] qla2xxx [0000:05:06.1]-2011:7: Entries in ID list (1). 2022-05-28T19:26:55.145840+02:00 julia kernel: [ 87.286441] qla2xxx [0000:05:06.1]-20d8:7: qla24xx_fcport_handle_login 50:01:10:a0:01:31:d7:2c DS 0 LS 7 P 0 fl 0 confl 0000000000000000 rscn 0|0 login 0 lid 125 scan 2 fc4type 0 2022-05-28T19:26:55.145853+02:00 julia kernel: [ 87.286454] qla2xxx [0000:05:06.1]-20bf:7: qla_chk_n2n_b4_login 1598 50:01:10:a0:01:31:d7:2c post login 2022-05-28T19:26:55.145857+02:00 julia kernel: [ 87.286468] qla2xxx [0000:05:06.1]-2069:7: LOOP READY. 2022-05-28T19:26:55.145859+02:00 julia kernel: [ 87.286471] qla2xxx [0000:05:06.1]-206b:7: qla2x00_configure_loop: exiting normally. local port wwpn 210100e08b3a321b id 0000ef) 2022-05-28T19:26:55.145862+02:00 julia kernel: [ 87.286477] qla2xxx [0000:05:06.1]-4010:7: Loop resync end. 2022-05-28T19:26:55.145864+02:00 julia kernel: [ 87.286481] qla2xxx [0000:05:06.1]-4000:7: DPC handler sleeping. 2022-05-28T19:26:55.145866+02:00 julia kernel: [ 87.286492] qla2xxx [0000:05:06.1]-2134:7: FCPort 50:01:10:a0:01:31:d7:2c disc_state transition: DELETED to LOGIN_PEND - portid=000001. 2022-05-28T19:26:55.145868+02:00 julia kernel: [ 87.286503] qla2xxx [0000:05:06.1]-2072:7: Async-login - 50:01:10:a0:01:31:d7:2c hdl=2, loopid=7d portid=000001 retries=15 . 2022-05-28T19:26:55.145870+02:00 julia kernel: [ 87.286529] qla2xxx [0000:05:06.1]-5046:7: Async-login failed - hdl=2 portid=000001 status=30 mb0=4006 mb1=7d mb2=0 mb6=0 mb7=0. 2022-05-28T19:26:55.145873+02:00 julia kernel: [ 87.286543] qla2xxx [0000:05:06.1]-20dd:7: qla2x00_async_login_sp_done 50:01:10:a0:01:31:d7:2c res 0 2022-05-28T19:26:55.145875+02:00 julia kernel: [ 87.286549] qla2xxx [0000:05:06.1]-ffff:7: qla24xx_handle_plogi_done_event 50:01:10:a0:01:31:d7:2c DS 3 LS 7 rc 0 login 0|0 rscn 0|0 data 4005|0 iop 0|0 2022-05-28T19:26:55.145878+02:00 julia kernel: [ 87.286559] qla2xxx [0000:05:06.1]-20eb:7: qla24xx_handle_plogi_done_event 2225 50:01:10:a0:01:31:d7:2c cmd error 0 2022-05-28T19:26:55.145880+02:00 julia kernel: [ 87.286564] qla2xxx [0000:05:06.1]-2134:7: FCPort 50:01:10:a0:01:31:d7:2c disc_state transition: LOGIN_PEND to LOGIN_FAILED - portid=000001. 2022-05-28T19:26:55.145883+02:00 julia kernel: [ 87.286571] qla2xxx [0000:05:06.1]-207d:7: FCPort 50:01:10:a0:01:31:d7:2c state transitioned from UNCONFIGURED to LOST - portid=000001. 2022-05-28T19:26:56.168378+02:00 julia kernel: [ 88.308194] qla2xxx [0000:05:06.1]-400d:7: Relogin scheduled. 2022-05-28T19:26:56.168396+02:00 julia kernel: [ 88.308207] qla2xxx [0000:05:06.1]-4000:7: DPC handler sleeping. 2022-05-28T19:26:56.168398+02:00 julia kernel: [ 88.308634] qla2xxx [0000:05:06.1]-2003:7: Port login OK: logged in ID 0x7d. 2022-05-28T19:26:56.168400+02:00 julia kernel: [ 88.308639] qla2xxx [0000:05:06.1]-20ef:7: qla2x00_update_fcport 50:01:10:a0:01:31:d7:2c 2022-05-28T19:26:56.168403+02:00 julia kernel: [ 88.308644] qla2xxx [0000:05:06.1]-2134:7: FCPort 50:01:10:a0:01:31:d7:2c disc_state transition: LOGIN_FAILED to UPD_FCPORT - portid=000001. 2022-05-28T19:26:56.168405+02:00 julia kernel: [ 88.309027] qla2xxx [0000:05:06.1]-20ee:7: qla2x00_reg_remote_port: 500110a00131d72c. rport 7:0:0 (00000000cc6da31a) is tgt mode 2022-05-28T19:26:56.168409+02:00 julia kernel: [ 88.309037] qla2xxx [0000:05:06.1]-207d:7: FCPort 50:01:10:a0:01:31:d7:2c state transitioned from LOST to ONLINE - portid=000001. 2022-05-28T19:26:56.168435+02:00 julia kernel: [ 88.309044] qla2xxx [0000:05:06.1]-2134:7: FCPort 50:01:10:a0:01:31:d7:2c disc_state transition: UPD_FCPORT to LOGIN_COMPLETE - portid=000001. 2022-05-28T19:26:56.168439+02:00 julia kernel: [ 88.309050] qla2xxx [0000:05:06.1]-400e:7: Relogin end. 2022-05-28T19:26:58.912365+02:00 julia kernel: [ 91.052455] scsi 7:0:0:0: Sequential-Access HP Ultrium 5-SCSI I66Z PQ: 0 ANSI: 6 2022-05-28T19:26:58.915404+02:00 julia kernel: [ 91.055945] st 7:0:0:0: Attached scsi tape st0 2022-05-28T19:26:58.915424+02:00 julia kernel: [ 91.055952] st 7:0:0:0: st0: try direct i/o: yes (alignment 4 B) 2022-05-28T19:26:58.915434+02:00 julia kernel: [ 91.056141] st 7:0:0:0: Attached scsi generic sg4 type 1 2022-05-28T19:27:15.112470+02:00 julia kernel: [ 107.251917] qla2xxx [0000:05:06.0]-8038:6: Cable is unplugged... 2022-05-28T19:27:15.112506+02:00 julia kernel: [ 107.251925] qla2xxx [0000:05:06.0]-803a:6: fw_state=4 (ffff, ffff, ffff, ffff ffff) curr time=fffd0e80. 2022-05-28T19:27:15.112509+02:00 julia kernel: [ 107.251933] qla2xxx [0000:05:06.0]-206c:6: qla2x00_loop_resync *** FAILED ***. 2022-05-28T19:27:15.112511+02:00 julia kernel: [ 107.251938] qla2xxx [0000:05:06.0]-4010:6: Loop resync end. 2022-05-28T19:27:15.112513+02:00 julia kernel: [ 107.251942] qla2xxx [0000:05:06.0]-4000:6: DPC handler sleeping. 5.17.9, drive not detected: 022-05-28T17:19:16.835616+02:00 julia kernel: [ 1220.512122] qla2xxx [0000:05:06.0]-8038:6: Cable is unplugged... 2022-05-28T17:19:32.407556+02:00 julia kernel: [ 1236.083771] qla2xxx [0000:00:00.0]-0005: : QLogic Fibre Channel HBA Driver: 10.02.07.200-k-debug. 2022-05-28T17:19:32.407581+02:00 julia kernel: [ 1236.084022] qla2xxx [0000:00:00.0]-001d: : Found an ISP2312 irq 21 iobase 0x00000000fd7d2d34. 2022-05-28T17:19:32.510602+02:00 julia kernel: [ 1236.186883] qla2xxx [0000:05:06.0]-ffff:6: FC4 priority set to FCP 2022-05-28T17:19:32.570612+02:00 julia kernel: [ 1236.246700] qla2xxx [0000:05:06.0]-507b:6: SFP detect: Short-Range SFP (nvr=0 ll=0 lr=0 lrd=0). 2022-05-28T17:19:32.726605+02:00 julia kernel: [ 1236.402884] scsi host6: qla2xxx 2022-05-28T17:19:32.726626+02:00 julia kernel: [ 1236.402893] qla2xxx [0000:05:06.0]-4000:6: DPC handler sleeping. 2022-05-28T17:19:32.728553+02:00 julia kernel: [ 1236.405581] qla2xxx [0000:05:06.0]-00fb:6: QLogic QLA2342 - . 2022-05-28T17:19:32.728570+02:00 julia kernel: [ 1236.405591] qla2xxx [0000:05:06.0]-00fc:6: ISP2312: PCI (33 MHz) @ 0000:05:06.0 hdma+ host#=6 fw=3.03.28 IPX. 2022-05-28T17:19:32.729541+02:00 julia kernel: [ 1236.405833] qla2xxx [0000:00:00.0]-001d: : Found an ISP2312 irq 22 iobase 0x000000004cbb5171. 2022-05-28T17:19:32.831611+02:00 julia kernel: [ 1236.507915] qla2xxx [0000:05:06.1]-ffff:7: FC4 priority set to FCP 2022-05-28T17:19:32.891651+02:00 julia kernel: [ 1236.567695] qla2xxx [0000:05:06.1]-507b:7: SFP detect: Short-Range SFP (nvr=0 ll=0 lr=0 lrd=0). 2022-05-28T17:19:32.951599+02:00 julia kernel: [ 1236.627831] scsi host7: qla2xxx 2022-05-28T17:19:32.951630+02:00 julia kernel: [ 1236.627842] qla2xxx [0000:05:06.1]-4000:7: DPC handler sleeping. 2022-05-28T17:19:32.953551+02:00 julia kernel: [ 1236.630581] qla2xxx [0000:05:06.1]-00fb:7: QLogic QLA2342 - . 2022-05-28T17:19:32.953577+02:00 julia kernel: [ 1236.630593] qla2xxx [0000:05:06.1]-00fc:7: ISP2312: PCI (33 MHz) @ 0000:05:06.1 hdma+ host#=7 fw=3.03.28 IPX. 2022-05-28T17:19:33.237312+02:00 julia kernel: [ 1236.914291] qla2xxx [0000:05:06.1]-500c:7: LIP reset occurred (f8f7). 2022-05-28T17:19:33.268132+02:00 julia kernel: [ 1236.945118] qla2xxx [0000:05:06.1]-5009:7: LIP occurred (f8f7). 2022-05-28T17:19:33.272433+02:00 julia kernel: [ 1236.949415] qla2xxx [0000:05:06.1]-500a:7: LOOP UP detected (2 Gbps). 2022-05-28T17:19:33.272456+02:00 julia kernel: [ 1236.949455] qla2xxx [0000:05:06.1]-5012:7: Port database changed ffff 0006 0000. 2022-05-28T17:19:33.731649+02:00 julia kernel: [ 1237.407734] qla2xxx [0000:05:06.0]-400f:6: Loop resync scheduled. 2022-05-28T17:19:33.987634+02:00 julia kernel: [ 1237.663718] qla2xxx [0000:05:06.1]-400b:7: Reset marker scheduled. 2022-05-28T17:19:33.987654+02:00 julia kernel: [ 1237.663725] qla2xxx [0000:05:06.1]-400c:7: Reset marker end. 2022-05-28T17:19:33.987658+02:00 julia kernel: [ 1237.663728] qla2xxx [0000:05:06.1]-400f:7: Loop resync scheduled. 2022-05-28T17:19:33.987660+02:00 julia kernel: [ 1237.663759] qla2xxx [0000:05:06.1]-8037:7: F/W Ready - OK. 2022-05-28T17:19:33.987662+02:00 julia kernel: [ 1237.663789] qla2xxx [0000:05:06.1]-803a:7: fw_state=3 (ffff, ffff, ffff, ffff ffff) curr time=1000e4e40. 2022-05-28T17:19:33.987665+02:00 julia kernel: [ 1237.663830] qla2xxx [0000:05:06.1]-200b:7: HBA in NL topology. 2022-05-28T17:19:33.987687+02:00 julia kernel: [ 1237.663837] qla2xxx [0000:05:06.1]-2014:7: Configure loop -- dpc flags = 0x112e0. 2022-05-28T17:19:33.989635+02:00 julia kernel: [ 1237.665671] qla2xxx [0000:05:06.1]-2011:7: Entries in ID list (1). 2022-05-28T17:19:33.989657+02:00 julia kernel: [ 1237.665793] qla2xxx [0000:05:06.1]-20d8:7: qla24xx_fcport_handle_login 50:01:10:a0:01:31:d7:2c DS 0 LS 7 P 0 fl 0 confl 0000000000000000 rscn 0|0 login 0 lid 125 scan 2 fc4type 0 2022-05-28T17:19:33.989663+02:00 julia kernel: [ 1237.665806] qla2xxx [0000:05:06.1]-307b:7: qla_chk_n2n_b4_login 50:01:10:a0:01:31:d7:2c DS 0 LS 7 lid 125 retries=16 2022-05-28T17:19:33.989666+02:00 julia kernel: [ 1237.665813] qla2xxx [0000:05:06.1]-20bf:7: qla_chk_n2n_b4_login 1628 50:01:10:a0:01:31:d7:2c post login 2022-05-28T17:19:33.989669+02:00 julia kernel: [ 1237.665830] qla2xxx [0000:05:06.1]-2134:7: FCPort 50:01:10:a0:01:31:d7:2c disc_state transition: DELETED to LOGIN_PEND - portid=000001. 2022-05-28T17:19:33.989692+02:00 julia kernel: [ 1237.665841] qla2xxx [0000:05:06.1]-2072:7: Async-login - 50:01:10:a0:01:31:d7:2c hdl=2, loopid=7d portid=000001 retries=15 . 2022-05-28T17:19:33.989697+02:00 julia kernel: [ 1237.665852] qla2xxx [0000:05:06.1]-2069:7: LOOP READY. 2022-05-28T17:19:33.989700+02:00 julia kernel: [ 1237.665860] qla2xxx [0000:05:06.1]-5046:7: Async-login failed - hdl=2 portid=000001 status=30 mb0=4006 mb1=7d mb2=0 mb6=0 mb7=0. 2022-05-28T17:19:33.989704+02:00 julia kernel: [ 1237.665869] qla2xxx [0000:05:06.1]-20dd:7: qla2x00_async_login_sp_done 50:01:10:a0:01:31:d7:2c res 0 2022-05-28T17:19:33.989708+02:00 julia kernel: [ 1237.665874] qla2xxx [0000:05:06.1]-ffff:7: qla24xx_handle_plogi_done_event 50:01:10:a0:01:31:d7:2c DS 3 LS 7 rc 0 login 0|0 rscn 0|0 data 4005|0 iop 0|0 2022-05-28T17:19:33.989712+02:00 julia kernel: [ 1237.665882] qla2xxx [0000:05:06.1]-20eb:7: qla24xx_handle_plogi_done_event 2249 50:01:10:a0:01:31:d7:2c cmd error 0 2022-05-28T17:19:33.989715+02:00 julia kernel: [ 1237.665887] qla2xxx [0000:05:06.1]-2134:7: FCPort 50:01:10:a0:01:31:d7:2c disc_state transition: LOGIN_PEND to DELETE_PEND - portid=000001. 2022-05-28T17:19:33.989718+02:00 julia kernel: [ 1237.665902] qla2xxx [0000:05:06.1]-210a:7: qlt_unreg_sess sess 00000000d609aa81 for deletion 50:01:10:a0:01:31:d7:2c 2022-05-28T17:19:33.989721+02:00 julia kernel: [ 1237.665909] qla2xxx [0000:05:06.1]-2134:7: FCPort 50:01:10:a0:01:31:d7:2c disc_state transition: DELETE_PEND to DELETE_PEND - portid=000001. 2022-05-28T17:19:33.989725+02:00 julia kernel: [ 1237.665915] qla2xxx [0000:05:06.1]-f084:7: qlt_free_session_done: se_sess 0000000000000000 / sess 00000000d609aa81 from port 50:01:10:a0:01:31:d7:2c loop_id 0x7d s_id 00:00:01 logout 1 keep 0 els_logo 0 2022-05-28T17:19:33.989728+02:00 julia kernel: [ 1237.665926] qla2xxx [0000:05:06.1]-207d:7: FCPort 50:01:10:a0:01:31:d7:2c state transitioned from UNCONFIGURED to LOST - portid=000001. 2022-05-28T17:19:33.989731+02:00 julia kernel: [ 1237.665933] qla2xxx [0000:05:06.1]-f086:7: qlt_free_session_done: waiting for sess 00000000d609aa81 logout 2022-05-28T17:19:33.989735+02:00 julia kernel: [ 1237.665947] qla2xxx [0000:05:06.1]-2070:7: Async-logout - hdl=0 loop-id=7d portid=000001 50:01:10:a0:01:31:d7:2c explicit 0. 2022-05-28T17:19:33.989739+02:00 julia kernel: [ 1237.665960] qla2xxx [0000:05:06.1]-206b:7: qla2x00_configure_loop: exiting normally. local port wwpn 210100e08b3a321b id 0000ef) 2022-05-28T17:19:33.989742+02:00 julia kernel: [ 1237.665965] qla2xxx [0000:05:06.1]-4010:7: Loop resync end. 2022-05-28T17:19:33.989745+02:00 julia kernel: [ 1237.665974] qla2xxx [0000:05:06.1]-5046:7: Async-logout failed - hdl=3 portid=000001 status=30 mb0=4006 mb1=7d mb2=0 mb6=0 mb7=0. 2022-05-28T17:19:33.989748+02:00 julia kernel: [ 1237.665987] qla2xxx [0000:05:06.1]-4000:7: DPC handler sleeping. 2022-05-28T17:19:34.091668+02:00 julia kernel: [ 1237.767930] qla2xxx [0000:05:06.1]-f087:7: qlt_free_session_done: sess 00000000d609aa81 logout completed 2022-05-28T17:19:34.091691+02:00 julia kernel: [ 1237.767940] qla2xxx [0000:05:06.1]-2134:7: FCPort 50:01:10:a0:01:31:d7:2c disc_state transition: DELETE_PEND to DELETED - portid=000001. 2022-05-28T17:19:34.091697+02:00 julia kernel: [ 1237.767948] qla2xxx [0000:05:06.1]-f001:7: Unregistration of sess 00000000d609aa81 50:01:10:a0:01:31:d7:2c finished fcp_cnt 0 2022-05-28T17:19:34.091700+02:00 julia kernel: [ 1237.767962] qla2xxx [0000:05:06.1]-400d:7: Relogin scheduled. 2022-05-28T17:19:34.091702+02:00 julia kernel: [ 1237.767970] qla2xxx [0000:05:06.1]-4000:7: DPC handler sleeping. 2022-05-28T17:19:34.091705+02:00 julia kernel: [ 1237.768008] qla2xxx [0000:05:06.1]-1820:7: **** Failed=102 2022-05-28T17:19:34.091727+02:00 julia kernel: [ 1237.768013] mb[0]=4006 2022-05-28T17:19:34.091731+02:00 julia kernel: [ 1237.768015] mb[1]=1000 2022-05-28T17:19:34.091734+02:00 julia kernel: [ 1237.768017] mb[6]=0 2022-05-28T17:19:34.091737+02:00 julia kernel: [ 1237.768019] mb[7]=0 2022-05-28T17:19:34.091740+02:00 julia kernel: [ 1237.768020] cmd=74 **** 2022-05-28T17:19:34.091743+02:00 julia kernel: [ 1237.768028] qla2xxx [0000:05:06.1]-400e:7: Relogin end. 2022-05-28T17:19:53.891582+02:00 julia kernel: [ 1257.567342] qla2xxx [0000:05:06.0]-8038:6: Cable is unplugged... 2022-05-28T17:19:53.891618+02:00 julia kernel: [ 1257.567350] qla2xxx [0000:05:06.0]-803a:6: fw_state=4 (ffff, ffff, ffff, ffff ffff) curr time=1000e9c00. 2022-05-28T17:19:53.891623+02:00 julia kernel: [ 1257.567359] qla2xxx [0000:05:06.0]-206c:6: qla2x00_loop_resync *** FAILED ***. 2022-05-28T17:19:53.891626+02:00 julia kernel: [ 1257.567363] qla2xxx [0000:05:06.0]-4010:6: Loop resync end. 2022-05-28T17:19:53.891628+02:00 julia kernel: [ 1257.567367] qla2xxx [0000:05:06.0]-4000:6: DPC handler sleeping. -- You are receiving this mail because: You are the assignee for the bug.
http://bugzilla.opensuse.org/show_bug.cgi?id=1200000
Andreas Stieger
http://bugzilla.opensuse.org/show_bug.cgi?id=1200000
http://bugzilla.opensuse.org/show_bug.cgi?id=1200000#c1
Daniel Wagner
http://bugzilla.opensuse.org/show_bug.cgi?id=1200000
http://bugzilla.opensuse.org/show_bug.cgi?id=1200000#c2
--- Comment #2 from Daniel Wagner
[0000:05:06.1]-2072:7: Async-login - 50:01:10:a0:01:31:d7:2c hdl=2, loopid=7d portid=000001 retries=15 . [0000:05:06.1]-5046:7: Async-login failed - hdl=2 portid=000001 status=30 mb0=4006 mb1=7d mb2=0 mb6=0 mb7=0. [0000:05:06.1]-20dd:7: qla2x00_async_login_sp_done 50:01:10:a0:01:31:d7:2c res 0 [0000:05:06.1]-ffff:7: qla24xx_handle_plogi_done_event 50:01:10:a0:01:31:d7:2c DS 3 LS 7 rc 0 login 0|0 rscn 0|0 data 4005|0 iop 0|0 [0000:05:06.1]-20eb:7: qla24xx_handle_plogi_done_event 2225 50:01:10:a0:01:31:d7:2c cmd error 0 [0000:05:06.1]-2134:7: FCPort 50:01:10:a0:01:31:d7:2c disc_state transition: LOGIN_PEND to LOGIN_FAILED - portid=000001. [0000:05:06.1]-207d:7: FCPort 50:01:10:a0:01:31:d7:2c state transitioned from UNCONFIGURED to LOST - portid=000001.
The login failed, remote port is marked as lost
[0000:05:06.1]-400d:7: Relogin scheduled. [0000:05:06.1]-4000:7: DPC handler sleeping. [0000:05:06.1]-2003:7: Port login OK: logged in ID 0x7d. [0000:05:06.1]-20ef:7: qla2x00_update_fcport 50:01:10:a0:01:31:d7:2c [0000:05:06.1]-2134:7: FCPort 50:01:10:a0:01:31:d7:2c disc_state transition: LOGIN_FAILED to UPD_FCPORT - portid=000001. [0000:05:06.1]-20ee:7: qla2x00_reg_remote_port: 500110a00131d72c. rport 7:0:0 (00000000cc6da31a) is tgt mode [0000:05:06.1]-207d:7: FCPort 50:01:10:a0:01:31:d7:2c state transitioned from LOST to ONLINE - portid=000001. [0000:05:06.1]-2134:7: FCPort 50:01:10:a0:01:31:d7:2c disc_state transition: UPD_FCPORT to LOGIN_COMPLETE - portid=000001. [0000:05:06.1]-400e:7: Relogin end.
A relogin is triggered with success. Bad case:
[0000:05:06.1]-20d8:7: qla24xx_fcport_handle_login 50:01:10:a0:01:31:d7:2c DS 0 LS 7 P 0 fl 0 confl 0000000000000000 rscn 0|0 login 0 lid 125 scan 2 fc4type 0 [0000:05:06.1]-307b:7: qla_chk_n2n_b4_login 50:01:10:a0:01:31:d7:2c DS 0 LS 7 lid 125 retries=16 [0000:05:06.1]-20bf:7: qla_chk_n2n_b4_login 1628 50:01:10:a0:01:31:d7:2c post login [0000:05:06.1]-2134:7: FCPort 50:01:10:a0:01:31:d7:2c disc_state transition: DELETED to LOGIN_PEND - portid=000001. [0000:05:06.1]-2072:7: Async-login - 50:01:10:a0:01:31:d7:2c hdl=2, loopid=7d portid=000001 retries=15 . [0000:05:06.1]-2069:7: LOOP READY. [0000:05:06.1]-5046:7: Async-login failed - hdl=2 portid=000001 status=30 mb0=4006 mb1=7d mb2=0 mb6=0 mb7=0. [0000:05:06.1]-20dd:7: qla2x00_async_login_sp_done 50:01:10:a0:01:31:d7:2c res 0 [0000:05:06.1]-ffff:7: qla24xx_handle_plogi_done_event 50:01:10:a0:01:31:d7:2c DS 3 LS 7 rc 0 login 0|0 rscn 0|0 data 4005|0 iop 0|0 [0000:05:06.1]-20eb:7: qla24xx_handle_plogi_done_event 2249 50:01:10:a0:01:31:d7:2c cmd error 0 [0000:05:06.1]-2134:7: FCPort 50:01:10:a0:01:31:d7:2c disc_state transition: LOGIN_PEND to DELETE_PEND - portid=000001. [0000:05:06.1]-210a:7: qlt_unreg_sess sess 00000000d609aa81 for deletion 50:01:10:a0:01:31:d7:2c [0000:05:06.1]-2134:7: FCPort 50:01:10:a0:01:31:d7:2c disc_state transition: DELETE_PEND to DELETE_PEND - portid=000001. [0000:05:06.1]-f084:7: qlt_free_session_done: se_sess 0000000000000000 / sess 00000000d609aa81 from port 50:01:10:a0:01:31:d7:2c loop_id 0x7d s_id 00:00:01 logout 1 keep 0 els_logo 0 [0000:05:06.1]-207d:7: FCPort 50:01:10:a0:01:31:d7:2c state transitioned from UNCONFIGURED to LOST - portid=000001.
Login failes again, remote port marked as lost
[0000:05:06.1]-f086:7: qlt_free_session_done: waiting for sess 00000000d609aa81 logout [0000:05:06.1]-2070:7: Async-logout - hdl=0 loop-id=7d portid=000001 50:01:10:a0:01:31:d7:2c explicit 0. [0000:05:06.1]-206b:7: qla2x00_configure_loop: exiting normally. local port wwpn 210100e08b3a321b id 0000ef) [0000:05:06.1]-4010:7: Loop resync end. [0000:05:06.1]-5046:7: Async-logout failed - hdl=3 portid=000001 status=30 mb0=4006 mb1=7d mb2=0 mb6=0 mb7=0. [0000:05:06.1]-4000:7: DPC handler sleeping. [0000:05:06.1]-f087:7: qlt_free_session_done: sess 00000000d609aa81 logout completed [0000:05:06.1]-2134:7: FCPort 50:01:10:a0:01:31:d7:2c disc_state transition: DELETE_PEND to DELETED - portid=000001. [0000:05:06.1]-f001:7: Unregistration of sess 00000000d609aa81 50:01:10:a0:01:31:d7:2c finished fcp_cnt 0
Logout is schedulled, remote port marked as deleted and eventually the session is removed -- You are receiving this mail because: You are the assignee for the bug.
participants (1)
-
bugzilla_noreply＠suse.com