Re: head/amd64 @r288358: panic: lock (sleep mutex) iwn0_com_lock not locked @ /usr/src/sys/dev/iwn/if_iwn.c:5356

[Adrian Chadd]

Thanks for being quick and on the ball. I did another review of the
drivers to see which others needed fixing and luckily it was only
if_iwn.



-a


On 30 September 2015 at 05:54, David Wolfskill  wrote:
> On Tue, Sep 29, 2015 at 12:12:02PM -0700, Adrian Chadd wrote:
>> hi
>>
>> (please subscribe and email freebsd-wireless@ these things, I'm more
>> likely to notice!)
>>
>> It looks due to my recent taskqueue change for updateedca. I'll go fix
>> that today.
>>
>> Thanks,
>> ...
>
> Looks as if you did:
>
> FreeBSD g1-252.catwhisker.org 11.0-CURRENT FreeBSD 11.0-CURRENT #199  
> r288418M/288418:1100079: Wed Sep 30 04:51:56 PDT 2015 
> r...@g1-252.catwhisker.org:/common/S4/obj/usr/src/sys/CANARY  amd64
>
> Thanks!  :-)
>
> Peace,
> david
> --
> David H. Wolfskill  da...@catwhisker.org
> Those who would murder in the name of God or prophet are blasphemous cowards.
>
> See http://www.catwhisker.org/~david/publickey.gpg for my public key.
___
freebsd-current@freebsd.org mailing list
https://lists.freebsd.org/mailman/listinfo/freebsd-current
To unsubscribe, send any mail to "freebsd-current-unsubscr...@freebsd.org"

Re: head/amd64 @r288358: panic: lock (sleep mutex) iwn0_com_lock not locked @ /usr/src/sys/dev/iwn/if_iwn.c:5356

[David Wolfskill]

On Tue, Sep 29, 2015 at 12:12:02PM -0700, Adrian Chadd wrote:
> hi
> 
> (please subscribe and email freebsd-wireless@ these things, I'm more
> likely to notice!)
> 
> It looks due to my recent taskqueue change for updateedca. I'll go fix
> that today.
> 
> Thanks,
> ...

Looks as if you did:

FreeBSD g1-252.catwhisker.org 11.0-CURRENT FreeBSD 11.0-CURRENT #199  
r288418M/288418:1100079: Wed Sep 30 04:51:56 PDT 2015 
r...@g1-252.catwhisker.org:/common/S4/obj/usr/src/sys/CANARY  amd64

Thanks!  :-)

Peace,
david
-- 
David H. Wolfskill  da...@catwhisker.org
Those who would murder in the name of God or prophet are blasphemous cowards.

See http://www.catwhisker.org/~david/publickey.gpg for my public key.


signature.asc
Description: PGP signature

Re: head/amd64 @r288358: panic: lock (sleep mutex) iwn0_com_lock not locked @ /usr/src/sys/dev/iwn/if_iwn.c:5356

[Adrian Chadd]

hi

(please subscribe and email freebsd-wireless@ these things, I'm more
likely to notice!)

It looks due to my recent taskqueue change for updateedca. I'll go fix
that today.

Thanks,



-a


On 29 September 2015 at 06:05, David Wolfskill  wrote:
> No known/observed issues with:
> FreeBSD localhost 11.0-CURRENT FreeBSD 11.0-CURRENT #197  
> r288335M/288335:1100079: Mon Sep 28 04:14:47 PDT 2015 
> root@localhost:/common/S4/obj/usr/src/sys/CANARY  amd64
>
> on my laptop, but:
> FreeBSD localhost 11.0-CURRENT FreeBSD 11.0-CURRENT #198  
> r288358M/288358:1100079: Tue Sep 29 04:46:49 PDT 2015 
> root@localhost:/common/S4/obj/usr/src/sys/CANARY  amd64
>
> was OK up to the point of attempting to establish a link using the
> wlan0 interface (the underlying hardware for which is iwn on the laptop).
>
> I was able to get a crash dump, and am presently copying it to
>  (along with the
> core.txt, which has already made it over).  (I am 3 time zones east
> of home, and will be spending the bulk of the day returning home
> -- and thus, without ability to respond to email for a while).
>
> Here's an excerpt from the core.txt.5:
>
> localhost dumped core - see /var/crash/vmcore.5
>
> Tue Sep 29 05:14:30 PDT 2015
>
> FreeBSD localhost 11.0-CURRENT FreeBSD 11.0-CURRENT #198  
> r288358M/288358:1100079: Tue Sep 29 04:46:49 PDT 2015 
> root@localhost:/common/S4/obj/usr/src/sys/CANARY  amd64
>
> panic: lock (sleep mutex) iwn0_com_lock not locked @ 
> /usr/src/sys/dev/iwn/if_iwn.c:5356
>
> GNU gdb 6.1.1 [FreeBSD]
> ...
> Unread portion of the kernel message buffer:
> d:
> ACPI: SSDT 0xF80006E30800 0005AA (v01 PmRef  ApIst3000 INTL 
> 20120711)
> ACPI: Dynamic OEM Table Load:
> ACPI: SSDT 0xF800067F6A00 000119 (v01 PmRef  ApCst3000 INTL 
> 20120711)
> random: harvesting attach, 8 bytes (4 bits) from cpu1
> cpu2: Processor \_PR_.CPU2 (ACPI ID 3) -> APIC ID 4
> cpu2:  on acpi0
> random: harvesting attach, 8 bytes (4 bits) from cpu2
> cpu3: Processor \_PR_.CPU3 (ACPI ID 4) -> APIC ID 6
> cpu3:  on acpi0
> random: harvesting attach, 8 bytes (4 bits) from cpu3
> cpu4: Processor \_PR_.CPU4 (ACPI ID 5) -> APIC ID 1
> cpu4:  on acpi0
> random: harvesting attach, 8 bytes (4 bits) from cpu4
> cpu5: Processor \_PR_.CPU5 (ACPI ID 6) -> APIC ID 3
> cpu5:  on acpi0
> random: harvesting attach, 8 bytes (4 bits) from cpu5
> cpu6: Processor \_PR_.CPU6 (ACPI ID 7) -> APIC ID 5
> cpu6:  on acpi0
> random: harvesting attach, 8 bytes (4 bits) from cpu6
> cpu7: Processor \_PR_.CPU7 (ACPI ID 8) -> APIC ID 7
> cpu7:  on acpi0
> random: harvesting attach, 8 bytes (4 bits) from cpu7
> hpet0:  iomem 0xfed0-0xfed003ff on acpi0
> hpet0: vendor 0x8086, rev 0x1, 14318180Hz 64bit, 8 timers, legacy route
> hpet0:  t0: irqs 0x00f0 (0), MSI, 64bit, periodic
> hpet0:  t1: irqs 0x00f0 (0), MSI
> hpet0:  t2: irqs 0x00f00800 (0), MSI
> hpet0:  t3: irqs 0x00f01000 (0), MSI
> hpet0:  t4: irqs 0x (0), MSI
> hpet0:  t5: irqs 0x (0), MSI
> hpet0:  t6: irqs 0x (0), MSI
> hpet0:  t7: irqs 0x (0), MSI
> Timecounter "HPET" frequency 14318180 Hz quality 950
> msi: routing MSI-X IRQ 256 to local APIC 0 vector 49
> msi: routing MSI-X IRQ 257 to local APIC 0 vector 50
> msi: routing MSI-X IRQ 258 to local APIC 0 vector 51
> msi: routing MSI-X IRQ 259 to local APIC 0 vector 52
> msi: routing MSI-X IRQ 260 to local APIC 0 vector 53
> msi: routing MSI-X IRQ 261 to local APIC 0 vector 54
> msi: routing MSI-X IRQ 262 to local APIC 0 vector 55
> msi: routing MSI-X IRQ 263 to local APIC 0 vector 56
> Event timer "HPET" frequency 14318180 Hz quality 550
> random: harvesting attach, 8 bytes (4 bits) from hpet0
> atrtc0:  port 0x70-0x77 irq 8 on acpi0
> atrtc0: Warning: Couldn't map I/O.
> atrtc0: registered as a time-of-day clock (resolution 100us, adjustment 
> 0.5s)
> ioapic0: routing intpin 8 (ISA IRQ 8) to lapic 0 vector 57
> Event timer "RTC" frequency 32768 Hz quality 0
> random: harvesting attach, 8 bytes (4 bits) from atrtc0
> attimer0:  port 0x40-0x43,0x50-0x53 irq 0 on acpi0
> Timecounter "i8254" frequency 1193182 Hz quality 0
> ioapic0: routing intpin 2 (ISA IRQ 0) to lapic 0 vector 58
> Event timer "i8254" frequency 1193182 Hz quality 100
> random: harvesting attach, 8 bytes (4 bits) from attimer0
> ACPI timer: 1/1 1/1 1/1 1/1 1/1 1/1 1/1 1/1 1/1 1/1 -> 10
> Timecounter "ACPI-fast" frequency 3579545 Hz quality 900
> acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1808-0x180b on acpi0
> random: harvesting attach, 8 bytes (4 bits) from acpi_timer0
> acpi_ec0:  port 0x930,0x934 on acpi0
> random: harvesting attach, 8 bytes (4 bits) from acpi_ec0
> pci_link0:Index  IRQ  Rtd  Ref  IRQs
>   Initial Probe   0   11   N 0  3 4 5 6 10 11 12 14 15
>   Validation  0   11   N 0  3 4 5 6 10 11 12 14 15
>   After Disable   0  255   N 0  3 4 5 6 10 11 12 14 15
> random: harvesting attach, 8 bytes (4 bits) from pci_l

head/amd64 @r288358: panic: lock (sleep mutex) iwn0_com_lock not locked @ /usr/src/sys/dev/iwn/if_iwn.c:5356

[David Wolfskill]

No known/observed issues with:
FreeBSD localhost 11.0-CURRENT FreeBSD 11.0-CURRENT #197  
r288335M/288335:1100079: Mon Sep 28 04:14:47 PDT 2015 
root@localhost:/common/S4/obj/usr/src/sys/CANARY  amd64

on my laptop, but:
FreeBSD localhost 11.0-CURRENT FreeBSD 11.0-CURRENT #198  
r288358M/288358:1100079: Tue Sep 29 04:46:49 PDT 2015 
root@localhost:/common/S4/obj/usr/src/sys/CANARY  amd64

was OK up to the point of attempting to establish a link using the
wlan0 interface (the underlying hardware for which is iwn on the laptop).

I was able to get a crash dump, and am presently copying it to
 (along with the
core.txt, which has already made it over).  (I am 3 time zones east
of home, and will be spending the bulk of the day returning home
-- and thus, without ability to respond to email for a while).

Here's an excerpt from the core.txt.5:

localhost dumped core - see /var/crash/vmcore.5

Tue Sep 29 05:14:30 PDT 2015

FreeBSD localhost 11.0-CURRENT FreeBSD 11.0-CURRENT #198  
r288358M/288358:1100079: Tue Sep 29 04:46:49 PDT 2015 
root@localhost:/common/S4/obj/usr/src/sys/CANARY  amd64

panic: lock (sleep mutex) iwn0_com_lock not locked @ 
/usr/src/sys/dev/iwn/if_iwn.c:5356

GNU gdb 6.1.1 [FreeBSD]
...
Unread portion of the kernel message buffer:
d:
ACPI: SSDT 0xF80006E30800 0005AA (v01 PmRef  ApIst3000 INTL 
20120711)
ACPI: Dynamic OEM Table Load:
ACPI: SSDT 0xF800067F6A00 000119 (v01 PmRef  ApCst3000 INTL 
20120711)
random: harvesting attach, 8 bytes (4 bits) from cpu1
cpu2: Processor \_PR_.CPU2 (ACPI ID 3) -> APIC ID 4
cpu2:  on acpi0
random: harvesting attach, 8 bytes (4 bits) from cpu2
cpu3: Processor \_PR_.CPU3 (ACPI ID 4) -> APIC ID 6
cpu3:  on acpi0
random: harvesting attach, 8 bytes (4 bits) from cpu3
cpu4: Processor \_PR_.CPU4 (ACPI ID 5) -> APIC ID 1
cpu4:  on acpi0
random: harvesting attach, 8 bytes (4 bits) from cpu4
cpu5: Processor \_PR_.CPU5 (ACPI ID 6) -> APIC ID 3
cpu5:  on acpi0
random: harvesting attach, 8 bytes (4 bits) from cpu5
cpu6: Processor \_PR_.CPU6 (ACPI ID 7) -> APIC ID 5
cpu6:  on acpi0
random: harvesting attach, 8 bytes (4 bits) from cpu6
cpu7: Processor \_PR_.CPU7 (ACPI ID 8) -> APIC ID 7
cpu7:  on acpi0
random: harvesting attach, 8 bytes (4 bits) from cpu7
hpet0:  iomem 0xfed0-0xfed003ff on acpi0
hpet0: vendor 0x8086, rev 0x1, 14318180Hz 64bit, 8 timers, legacy route
hpet0:  t0: irqs 0x00f0 (0), MSI, 64bit, periodic
hpet0:  t1: irqs 0x00f0 (0), MSI
hpet0:  t2: irqs 0x00f00800 (0), MSI
hpet0:  t3: irqs 0x00f01000 (0), MSI
hpet0:  t4: irqs 0x (0), MSI
hpet0:  t5: irqs 0x (0), MSI
hpet0:  t6: irqs 0x (0), MSI
hpet0:  t7: irqs 0x (0), MSI
Timecounter "HPET" frequency 14318180 Hz quality 950
msi: routing MSI-X IRQ 256 to local APIC 0 vector 49
msi: routing MSI-X IRQ 257 to local APIC 0 vector 50
msi: routing MSI-X IRQ 258 to local APIC 0 vector 51
msi: routing MSI-X IRQ 259 to local APIC 0 vector 52
msi: routing MSI-X IRQ 260 to local APIC 0 vector 53
msi: routing MSI-X IRQ 261 to local APIC 0 vector 54
msi: routing MSI-X IRQ 262 to local APIC 0 vector 55
msi: routing MSI-X IRQ 263 to local APIC 0 vector 56
Event timer "HPET" frequency 14318180 Hz quality 550
random: harvesting attach, 8 bytes (4 bits) from hpet0
atrtc0:  port 0x70-0x77 irq 8 on acpi0
atrtc0: Warning: Couldn't map I/O.
atrtc0: registered as a time-of-day clock (resolution 100us, adjustment 
0.5s)
ioapic0: routing intpin 8 (ISA IRQ 8) to lapic 0 vector 57
Event timer "RTC" frequency 32768 Hz quality 0
random: harvesting attach, 8 bytes (4 bits) from atrtc0
attimer0:  port 0x40-0x43,0x50-0x53 irq 0 on acpi0
Timecounter "i8254" frequency 1193182 Hz quality 0
ioapic0: routing intpin 2 (ISA IRQ 0) to lapic 0 vector 58
Event timer "i8254" frequency 1193182 Hz quality 100
random: harvesting attach, 8 bytes (4 bits) from attimer0
ACPI timer: 1/1 1/1 1/1 1/1 1/1 1/1 1/1 1/1 1/1 1/1 -> 10
Timecounter "ACPI-fast" frequency 3579545 Hz quality 900
acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1808-0x180b on acpi0
random: harvesting attach, 8 bytes (4 bits) from acpi_timer0
acpi_ec0:  port 0x930,0x934 on acpi0
random: harvesting attach, 8 bytes (4 bits) from acpi_ec0
pci_link0:Index  IRQ  Rtd  Ref  IRQs
  Initial Probe   0   11   N 0  3 4 5 6 10 11 12 14 15
  Validation  0   11   N 0  3 4 5 6 10 11 12 14 15
  After Disable   0  255   N 0  3 4 5 6 10 11 12 14 15
random: harvesting attach, 8 bytes (4 bits) from pci_link0
pci_link1:Index  IRQ  Rtd  Ref  IRQs
  Initial Probe   0   10   N 0  3 4 5 6 10 11 12 14 15
  Validation  0   10   N 0  3 4 5 6 10 11 12 14 15
  After Disable   0  255   N 0  3 4 5 6 10 11 12 14 15
random: harvesting attach, 8 bytes (4 bits) from pci_link1
pci_link2:Index  IRQ  Rtd  Ref  IRQs
  Initial Probe   0   10   N 0  3 4 5 6 10 11 12 14 15
  Validation  0   10   N 0  3