Skip to content

Instantly share code, notes, and snippets.

@mcgrof
Created April 12, 2022 22:17
Show Gist options
  • Save mcgrof/72929570da5de920d9a37cb401225822 to your computer and use it in GitHub Desktop.
Save mcgrof/72929570da5de920d9a37cb401225822 to your computer and use it in GitHub Desktop.
blktests srp/012 failing with an NMI on v5.17-rc7
[ 89.708215] scsi host5: ib_srp: Already connected to target port with id_ext=505400fffea6d62d;ioc_guid=505400fffea6d62d;dest=fe80:0000:0000:0000:5054:00ff:fec2:d9c8
[ 89.708397] sd 4:0:0:2: [sdf] Write cache: enabled, read cache: enabled, supports DPO and FUA
[ 89.712899] sd 4:0:0:2: [sdf] Optimal transfer size 524288 bytes
[ 89.713073] sd 4:0:0:1: [sdg] 65536 512-byte logical blocks: (33.6 MB/32.0 MiB)
[ 89.716070] sd 4:0:0:1: [sdg] Write Protect is off
[ 89.717813] sd 4:0:0:1: [sdg] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[ 89.721073] sd 4:0:0:1: [sdg] Optimal transfer size 126976 bytes
[ 89.773493] sd 4:0:0:2: [sdf] Attached SCSI disk
[ 89.777473] sd 4:0:0:0: [sde] Attached SCSI disk
[ 89.789580] sd 4:0:0:1: [sdg] Attached SCSI disk
[ 111.968453] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
[ 111.971044] rcu: 1-...0: (1 GPs behind) idle=76b/1/0x4000000000000000 softirq=7612/7630 fqs=2228
[ 111.973025] (detected by 4, t=5252 jiffies, g=7589, q=18950)
[ 111.974771] Sending NMI from CPU 4 to CPUs 1:
[ 111.976109] NMI backtrace for cpu 1
[ 111.976124] CPU: 1 PID: 1739 Comm: multipathd Kdump: loaded Tainted: G E 5.17.0-rc7 #1
[ 111.976130] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.15.0-1 04/01/2014
[ 111.976138] RIP: 0010:native_queued_spin_lock_slowpath+0x28/0x200
[ 111.976184] Code: 00 00 0f 1f 44 00 00 41 54 55 53 48 89 fb 66 90 ba 01 00 00 00 8b 03 85 c0 75 0d f0 0f b1 13 85 c0 75 f2 5b 5d 41 5c c3 f3 90 <eb> e9 81 fe 00 01 00 00 74 45 40 30 f6 85 f6 75 67 f0 0f ba 2b 08
[ 111.976185] RSP: 0018:ffff9d54800f0e58 EFLAGS: 00000002
[ 111.976190] RAX: 0000000000000001 RBX: ffff8df822e2b190 RCX: 0000000000010006
[ 111.976193] RDX: 0000000000000001 RSI: 0000000000000001 RDI: ffff8df822e2b190
[ 111.976194] RBP: ffff8df822e2b180 R08: ffff8df80f87f840 R09: 0000000000000103
[ 111.976196] R10: ffffffffbbc060c0 R11: 0000000000000000 R12: 0000000000000282
[ 111.976197] R13: ffff8df822e2f7e0 R14: ffff8df80a8b2260 R15: ffff8df822e2b190
[ 111.976198] FS: 00007f0be53ef600(0000) GS:ffff8df937c40000(0000) knlGS:0000000000000000
[ 111.976200] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 111.976201] CR2: 00007f63bc0ce008 CR3: 0000000101c52004 CR4: 0000000000770ee0
[ 111.976205] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[ 111.976206] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
[ 111.976207] PKRU: 55555554
[ 111.976210] Call Trace:
[ 111.976223] <IRQ>
[ 111.976230] _raw_spin_lock_irqsave+0x44/0x50
[ 111.976278] srp_recv_done+0x11e/0x480 [ib_srp]
[ 111.976297] ? _raw_spin_lock_bh+0x13/0x30
[ 111.976305] __ib_process_cq+0x83/0x180 [ib_core]
[ 111.976375] ib_poll_handler+0x2b/0xc0 [ib_core]
[ 111.976388] irq_poll_softirq+0x8e/0x120
[ 111.976404] __do_softirq+0xec/0x2ea
[ 111.976411] do_softirq.part.0+0x9b/0xd0
[ 111.976427] </IRQ>
[ 111.976427] <TASK>
[ 111.976428] __local_bh_enable_ip+0x73/0x80
[ 111.976436] rxe_poll_cq+0xed/0x100 [rdma_rxe]
[ 111.976462] __ib_process_cq+0x54/0x180 [ib_core]
[ 111.976475] ib_process_cq_direct+0x2c/0x50 [ib_core]
[ 111.976491] __srp_get_tx_iu+0x20/0xa0 [ib_srp]
[ 111.976495] srp_queuecommand+0xbe/0x98a [ib_srp]
[ 111.976500] ? kvm_clock_get_cycles+0x14/0x30
[ 111.976511] scsi_queue_rq+0x37b/0xb10 [scsi_mod]
[ 111.976561] blk_mq_dispatch_rq_list+0x1ef/0x890
[ 111.976574] __blk_mq_sched_dispatch_requests+0xb0/0x140
[ 111.976579] blk_mq_sched_dispatch_requests+0x30/0x60
[ 111.976581] __blk_mq_run_hw_queue+0x35/0x90
[ 111.976585] __blk_mq_delay_run_hw_queue+0x178/0x1b0
[ 111.976588] blk_execute_rq+0x53/0xf0
[ 111.976593] sg_io+0x1a4/0x440 [scsi_mod]
[ 111.976606] ? get_sg_io_hdr+0xd3/0xf0 [scsi_mod]
[ 111.976617] scsi_ioctl+0x37a/0x8e0 [scsi_mod]
[ 111.976626] ? scsi_ioctl_block_when_processing_errors+0x41/0x50 [scsi_mod]
[ 111.976634] blkdev_ioctl+0x13b/0x280
[ 111.976639] __x64_sys_ioctl+0x7f/0xb0
[ 111.976657] do_syscall_64+0x38/0xc0
[ 111.976668] entry_SYSCALL_64_after_hwframe+0x44/0xae
[ 111.976671] RIP: 0033:0x7f0be6a8b397
[ 111.976692] Code: 3c 1c e8 1c ff ff ff 85 c0 79 87 49 c7 c4 ff ff ff ff 5b 5d 4c 89 e0 41 5c c3 66 0f 1f 84 00 00 00 00 00 b8 10 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d a9 da 0d 00 f7 d8 64 89 01 48
[ 111.976696] RSP: 002b:00007f0be53ee868 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
[ 111.976699] RAX: ffffffffffffffda RBX: 00007f0be53ee888 RCX: 00007f0be6a8b397
[ 111.976700] RDX: 00007f0be53ee880 RSI: 0000000000002285 RDI: 000000000000000f
[ 111.976701] RBP: 000000000000000f R08: 0000000000000000 R09: 00007f0be53ef600
[ 111.976702] R10: 0000000000000008 R11: 0000000000000246 R12: 0000000000000005
[ 111.976703] R13: 00007f0be53ee8da R14: 00007f0be53ee880 R15: 00007f0be53ee8e0
[ 111.976717] </TASK>
[ 122.164534] scsi host3: SRP abort called
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment