On Wed, Nov 11, 2015 at 01:07:44PM -0800, Bart Van Assche wrote: > On 11/10/2015 09:15 AM, Christoph Hellwig wrote: > >scsi host3: ib_srp: failed receive status WR flushed (5) for iu ffff880313f4ca40 > > Can you also post the logs from the target system from around the time this > message was logged on the initiator system ? Usually this message means that > the target system closed a QP. I'm looking for messages generated by the > following statement in ib_srpt.c: None of those as far as I can tell: [ 108.896609] ib_srpt Received SRP_LOGIN_REQ with i_port_id 0x0:0xf4521403007be042, t_port_id 0x2c903009f83a0:0x2c903009f83a0 and it_iu_len 260 on port 2 (guid=0xfe80000000000000:0x2c903009f83a2) [ 108.903032] ib_srpt Session : kernel thread ib_srpt_compl (PID 1258) started [ 108.910776] ib_srpt Received SRP_LOGIN_REQ with i_port_id 0x0:0xf4521403007be042, t_port_id 0x2c903009f83a0:0x2c903009f83a0 and it_iu_len 260 on port 2 (guid=0xfe80000000000000:0x2c903009f83a2) [ 108.916901] ib_srpt Session : kernel thread ib_srpt_compl (PID 1259) started [ 108.924338] ib_srpt Received SRP_LOGIN_REQ with i_port_id 0x0:0xf4521403007be042, t_port_id 0x2c903009f83a0:0x2c903009f83a0 and it_iu_len 260 on port 2 (guid=0xfe80000000000000:0x2c903009f83a2) [ 108.929974] ib_srpt Session : kernel thread ib_srpt_compl (PID 1260) started [ 108.937428] ib_srpt Received SRP_LOGIN_REQ with i_port_id 0x0:0xf4521403007be042, t_port_id 0x2c903009f83a0:0x2c903009f83a0 and it_iu_len 260 on port 2 (guid=0xfe80000000000000:0x2c903009f83a2) [ 108.943112] ib_srpt Session : kernel thread ib_srpt_compl (PID 1261) started [ 108.950896] ib_srpt Received SRP_LOGIN_REQ with i_port_id 0x0:0xf4521403007be042, t_port_id 0x2c903009f83a0:0x2c903009f83a0 and it_iu_len 260 on port 2 (guid=0xfe80000000000000:0x2c903009f83a2) [ 108.956066] ib_srpt Session : kernel thread ib_srpt_compl (PID 1262) started [ 108.964064] ib_srpt Received SRP_LOGIN_REQ with i_port_id 0x0:0xf4521403007be042, t_port_id 0x2c903009f83a0:0x2c903009f83a0 and it_iu_len 260 on port 2 (guid=0xfe80000000000000:0x2c903009f83a2) [ 108.969751] ib_srpt Session : kernel thread ib_srpt_compl (PID 1263) started [ 108.977249] ib_srpt Received SRP_LOGIN_REQ with i_port_id 0x0:0xf4521403007be042, t_port_id 0x2c903009f83a0:0x2c903009f83a0 and it_iu_len 260 on port 2 (guid=0xfe80000000000000:0x2c903009f83a2) [ 108.982943] ib_srpt Session : kernel thread ib_srpt_compl (PID 1264) started [ 108.990002] ib_srpt Received SRP_LOGIN_REQ with i_port_id 0x0:0xf4521403007be042, t_port_id 0x2c903009f83a0:0x2c903009f83a0 and it_iu_len 260 on port 2 (guid=0xfe80000000000000:0x2c903009f83a2) [ 108.995576] ib_srpt Session : kernel thread ib_srpt_compl (PID 1265) started [ 108.998564] ------------[ cut here ]------------ [ 108.998574] WARNING: CPU: 0 PID: 1258 at kernel/sched/core.c:7389 __might_sleep+0xa7/0xb0() [ 108.998580] do not call blocking ops when !TASK_RUNNING; state=1 set at [<ffffffff810cad4d>] prepare_to_wait_event+0x5d/0x100 [ 108.998582] Modules linked in: ib_srpt target_core_pscsi target_core_file target_core_iblock iscsi_target_mod target_core_mod configfs nfsd auth_rpcgss oid_registry nfs_acl nfs lockd grace fscache sunrpc intel_powerclamp coretemp kvm crct10dif_pclmul crc32_pclmul ghash_clmulni_intel mgag200 ttm sha256_ssse3 sha256_generic snd_pcm hmac drm_kms_helper drbg ansi_cprng drm snd_timer aesni_intel aes_x86_64 i2c_algo_bit lrw gf128mul snd soundcore glue_helper i2c_core ablk_helper cryptd psmouse ipmi_devintf iTCO_wdt dcdbas tpm_tis evdev iTCO_vendor_support serio_raw i7core_edac acpi_power_meter pcspkr ipmi_si tpm ib_ipoib shpchp ipmi_msghandler edac_core button acpi_cpufreq lpc_ich mfd_core ib_umad rdma_ucm rdma_cm iw_cm processor ib_uverbs ib_cm mlx4_ib ib_sa ib_mad ib_core ib_addr parport_pc ppdev lp [ 108.998652] parport autofs4 ext4 crc16 mbcache jbd2 sd_mod sg sr_mod cdrom ata_generic ata_piix crc32c_intel libata mptsas ehci_pci uhci_hcd scsi_transport_sas mptscsih ehci_hcd mptbase usbcore mlx4_core usb_common scsi_mod nvme bnx2 [ 108.998677] CPU: 0 PID: 1258 Comm: ib_srpt_compl Tainted: G I 4.2.0 #34 [ 108.998679] Hardware name: Dell Inc. PowerEdge R710/00NH4P, BIOS 3.0.0 01/31/2011 [ 108.998681] ffffffff81a01b6f ffff88061374ba28 ffffffff81621a32 0000000000000000 [ 108.998685] ffff88061374ba78 ffff88061374ba68 ffffffff8107d72a ffff88061374bb18 [ 108.998689] ffffffff81a11775 0000000000000b30 0000000000000000 00000000000000d0 [ 108.998692] Call Trace: [ 108.998699] [<ffffffff81621a32>] dump_stack+0x4c/0x65 [ 108.998704] [<ffffffff8107d72a>] warn_slowpath_common+0x8a/0xc0 [ 108.998707] [<ffffffff8107d7a6>] warn_slowpath_fmt+0x46/0x50 [ 108.998710] [<ffffffff810cad4d>] ? prepare_to_wait_event+0x5d/0x100 [ 108.998713] [<ffffffff810cad4d>] ? prepare_to_wait_event+0x5d/0x100 [ 108.998716] [<ffffffff810aa9a7>] __might_sleep+0xa7/0xb0 [ 108.998720] [<ffffffff811f66b4>] __kmalloc+0x1f4/0x680 [ 108.998737] [<ffffffffa068e0d9>] ? target_check_reservation+0x69/0x720 [target_core_mod] [ 108.998747] [<ffffffffa068fb59>] ? target_alua_state_check+0xa9/0x480 [target_core_mod] [ 108.998758] [<ffffffffa06998ed>] ? target_alloc_sgl+0x4d/0x160 [target_core_mod] [ 108.998769] [<ffffffffa06998ed>] target_alloc_sgl+0x4d/0x160 [target_core_mod] [ 108.998780] [<ffffffffa0699aa6>] transport_generic_new_cmd+0xa6/0x230 [target_core_mod] [ 108.998791] [<ffffffffa0699c6a>] transport_handle_cdb_direct+0x3a/0x90 [target_core_mod] [ 108.998801] [<ffffffffa0699e1e>] target_submit_cmd_map_sgls+0x15e/0x270 [target_core_mod] [ 108.998812] [<ffffffffa0699f89>] target_submit_cmd+0x59/0x60 [target_core_mod] [ 108.998817] [<ffffffffa057b6f1>] srpt_handle_new_iu+0x2a1/0x6c0 [ib_srpt] [ 108.998821] [<ffffffffa057bbd9>] srpt_process_completion+0xc9/0x4d0 [ib_srpt] [ 108.998826] [<ffffffffa057c0f6>] srpt_compl_thread+0x116/0x140 [ib_srpt] [ 108.998828] [<ffffffff810cac40>] ? wait_woken+0xb0/0xb0 [ 108.998832] [<ffffffffa057bfe0>] ? srpt_process_completion+0x4d0/0x4d0 [ib_srpt] [ 108.998836] [<ffffffff810a3819>] kthread+0x119/0x130 [ 108.998839] [<ffffffff810a3700>] ? kthread_create_on_node+0x240/0x240 [ 108.998843] [<ffffffff8162aa5f>] ret_from_fork+0x3f/0x70 [ 108.998845] [<ffffffff810a3700>] ? kthread_create_on_node+0x240/0x240 [ 108.998848] ---[ end trace b96d3b34157d1df6 ]--- [ 134.094662] ib_srpt Received DREQ and sent DREP for session 0x0000000000000000f4521403007be042. [ 134.094717] ib_srpt Received DREQ and sent DREP for session 0x0000000000000000f4521403007be042. [ 134.094746] ib_srpt Received DREQ and sent DREP for session 0x0000000000000000f4521403007be042. [ 134.094794] ib_srpt Received DREQ and sent DREP for session 0x0000000000000000f4521403007be042. [ 134.094826] ib_srpt Received DREQ and sent DREP for session 0x0000000000000000f4521403007be042. [ 134.094866] ib_srpt Received DREQ and sent DREP for session 0x0000000000000000f4521403007be042. [ 134.094904] ib_srpt Received DREQ and sent DREP for session 0x0000000000000000f4521403007be042. [ 134.094941] ib_srpt Received DREQ and sent DREP for session 0x0000000000000000f4521403007be042. [ 134.158698] ib_srpt Received SRP_LOGIN_REQ with i_port_id .. and so on -- To unsubscribe from this list: send the line "unsubscribe target-devel" in the body of a message to majordomo@xxxxxxxxxxxxxxx More majordomo info at http://vger.kernel.org/majordomo-info.html
