Re: kern/52126 (mvsata Marvell 88SX6081 panics on boot)

[Patrick Welche <prlw1%cam.ac.uk@localhost>]

The following reply was made to PR kern/52126; it has been noted by GNATS.

From: Patrick Welche <prlw1%cam.ac.uk@localhost>
To: gnats-bugs%netbsd.org@localhost
Cc: 
Subject: Re: kern/52126 (mvsata Marvell 88SX6081 panics on boot)
Date: Thu, 17 Oct 2019 14:24:53 +0100

 Just tried a today's NetBSD-9.99.17/amd64 kernel with:
 
 include "arch/amd64/conf/GENERIC"
 options         DEBUG
 options         LOCKDEBUG
 options         MVSATA_DEBUG
 options         MVSATA_WITHOUTDMA
 
 (I think the withoutdma is not longer necessary) and on boot, get
 
 Mutex error: assert_sleepable,70: spin lock held
 
 lock address : 0xfffff91bd38a4020 type     :               spin
 initialized  : 0xffffffff80284dd9
 shared holds :                  0 exclusive:                  1
 shares wanted:                  0 exclusive:                  0
 current cpu  :                  1 last held:                  1
 current lwp  : 0xfffff91bd3934ac0 last held: 0xfffff91bd3934ac0
 last locked* : 0xffffffff809c910f unlocked : 0xffffffff809c9070
 owner field  : 0x0000000000010600 wait/spin:                0/1
 
 panic: LOCKDEBUG: Mutex error: assert_sleepable,70: spin lock held
 cpu1: Begin traceback...
 vpanic() at netbsd:vpanic+0x160
 snprintf() at netbsd:snprintf
 lockdebug_more() at netbsd:lockdebug_more
 assert_sleepable() at netbsd:assert_sleepable+0x3d
 pool_cache_get_paddr() at netbsd:pool_cache_get_paddr+0x18e
 kmem_intr_alloc() at netbsd:kmem_intr_alloc+0x5b
 kmem_intr_zalloc() at netbsd:kmem_intr_zalloc+kmem_zalloc() at netbsd:kmem_zalloc+0x4a
 atabus_alloc_drives() at netbsd:atabus_alloc_drives+0x70
 sata_interpret_sig() at netbsd:sata_interpret_sig+0x1e5
 mvsata_probe_drive() at netbsd:mvsata_probe_drive+0x234
 atabusconfig() at netbsd:atabusconfig+0x65
 atabus_thread() at netbsd:atabus_thread+0x7e
 cpu1: End traceback...
 fatal breakpoint trap in supervisor mode
 trap type 1 code 0 rip 0xffffffff8021ddcd cs 0x8 rflags 0x202 cr2 0 ilevel 0x8 rsp 0xffffd5811bbfcce0
 curlwp 0xfffff91bd3934ac0 pid 0.52 lowest kstack 0xffffd5811bbf92c0
 0x11
 
 db{1}> show locks
 [Locks tracked through LWPs]
 Locks held by an LWP (ipmi0):
 Lock 0 (initialized at ipmi_attach)
 lock address : 0xfffff91e95a333c0 type     :     sleep/adaptive
 initialized  : 0xffffffff80a92655
 shared holds :                  0 exclusive:                  1
 shares wanted:                  0 exclusive:                  0
 current cpu  :                  1 last held:                  0
 current lwp  : 0xfffff91bd3934ac0 last held: 0xfffff91bd34f7600
 last locked* : 0xffffffff80a934f5 unlocked : 0xffffffff80a9354c
 owner field  : 0xfffff91bd34f7600 wait/spin:                0/0
 
 Turnstile chain at 0xffffffff816a0200.
 => No active turnstile for this lock.
 
 
 [Locks tracked through CPUs]
 Locks held on CPU 1:
 Lock 0 (initialized at main)
 lock address : 0xffffffff8169e800 type     :               spin
 initialized  : 0xffffffff80e3be69
 shared holds :                  0 exclusive:                  1
 shares wanted:                  0 exclusive:                  0
 current cpu  :                  1 last held:                  1
 current lwp  : 0xfffff91bd3934ac0 last held: 0xfffff91bd3934ac0
 last locked* : 0xffffffff809c60ac unlocked : 0xffffffff809c90dd
 curcpu holds :                  1 wanted by: 000000000000000000
 
 Lock 1 (initialized at ata_channel_init)
 lock address : 0xfffff91bd38a4020 type     :               spin
 initialized  : 0xffffffff80284dd9
 shared holds :                  0 exclusive:                  1
 shares wanted:                  0 exclusive:                  0
 current cpu  :                  1 last held:                  1
 current lwp  : 0xfffff91bd3934ac0 last held: 0xfffff91bd3934ac0
 last locked* : 0xffffffff809c910f unlocked : 0xffffffff809c9070
 	owner field  : 0x0000000000010600 wait/spin:                ine cpu 0 
 using CPU 0
 db{1}> trace
 _kernel_lock() at netbsd:_kernel_lock+0x1d7
 sleepq_block() at netbsd:sleepq_block+0x93
 kpause() at netbsd:kpause+0x11f
 sata_reset_interface() at netbsd:sata_reset_interface+0xa8
 mvsata_probe_drive() at netbsd:mvsata_probe_drive+0x36
 atabusconfig() at netbsd:atabusconfig+0x65
 atabus_thread() at netbsd:atabus_thread+0x7e
 db{1}> machine cpu 1
 using CPU 1
 db{1}> trace
 breakpoint() at netbsd:breakpoint+0x5
 vpanic() at netbsd:vpanic+0x160
 snprintf() at netbsd:snprintf
 lockdebug_more() at netbsd:lockdebug_more
 assert_sleepable() at netbsd:assert_sleepable+0x3d
 pool_cache_get_paddr() at netbsd:pool_cache_get_paddr+0x18e
 kmem_intr_alloc() at netbsd:kmem_intr_alloc+0x5b
 kmem_intr_zalloc() at netbsd:kmem_intr_zalloc+0x11
 kmem_zalloc() at netbsd:kmem_zalloc+0x4a
 atabus_alloc_drives() at netbsd:atabus_alloc_drives+0x70
 sata_interpret_sig() at netbsd:sata_interpret_sig+0x1e5
 mvsata_probe_drive() at netbsd:mvsata_probe_drive+0x234
 atabusconfig() at netbsd:atabusconfig+0x65
 atabus_thread() at netbsd:atabus_thread+0x7e
 db{1}> ps
 PID    LID S CPU     FLAGS       STRUCT LWP *               NAME WAIT
 ...
 0    >  52 7   1       200   fffff91bd3934ac0           atabus12