[PlanetCCRMA] Kernel errors when running jack

David Cornette david at davidcornette.com
Wed Jul 29 00:17:24 PDT 2009


I have a Fedora 8 system, running a CCRMA rt kernel, and I have an issue with getting a lot of kernel errors.  They occur occasionally all the time, and continually when I run jack.  The ones that happen when jack is running all seem to be related to my firewire card (to which my Presonus Firebox is connected).

Here is an example of the most common error, but there are others sprinkled in, too. I have attached a sampling of the contents of /var/log/messages from when jack is running.

Jul 29 02:55:56 rivendell kernel: Pid: 847, comm: IRQ-21 Tainted: P         2.6.24.7-1.rt3.2.fc8.ccrmart #1
Jul 29 02:55:56 rivendell kernel:  [<c041ce3a>] smp_error_interrupt+0x67/0x72
Jul 29 02:55:56 rivendell kernel:  [<c040a912>] sched_clock+0x8/0x18
Jul 29 02:55:56 rivendell kernel:  [<c0405ca0>] error_interrupt+0x28/0x30
Jul 29 02:55:56 rivendell kernel:  [<f89973b6>] ohci_irq_handler+0x29/0x74e [ohci1394]
Jul 29 02:55:56 rivendell kernel:  [<c0434eb0>] trigger_softirqs+0x28/0x32
Jul 29 02:55:56 rivendell kernel:  [<c04641f2>] handle_IRQ_event+0x4a/0xd2
Jul 29 02:55:56 rivendell kernel:  [<c04646a7>] thread_simple_irq+0x3f/0x74
Jul 29 02:55:56 rivendell kernel:  [<c0464daa>] do_irqd+0xab/0x225
Jul 29 02:55:56 rivendell kernel:  [<c0464cff>] do_irqd+0x0/0x225
Jul 29 02:55:56 rivendell kernel:  [<c0442113>] kthread+0x38/0x5d
Jul 29 02:55:56 rivendell kernel:  [<c04420db>] kthread+0x0/0x5d
Jul 29 02:55:56 rivendell kernel:  [<c0405e0f>] kernel_thread_helper+0x7/0x10
Jul 29 02:55:56 rivendell kernel:  =======================

Even though these errors are occurring, everything seems to work.

Here is the output of uname -a:

Linux rivendell.davidcornette.com 2.6.24.7-1.rt3.2.fc8.ccrmart #1 SMP PREEMPT RT Mon May 12 17:53:55 EDT 2008 i686 athlon i386 GNU/Linux

And here is the contents of /proc/interrupts:

           CPU0
  0:        776   IO-APIC-edge      timer
  1:      11799   IO-APIC-edge      i8042
  4:          6   IO-APIC-edge
  6:          6   IO-APIC-edge      floppy
  7:          0   IO-APIC-edge      parport0
  8:          1   IO-APIC-edge      rtc
  9:          0   IO-APIC-fasteoi   acpi
 12:    1534402   IO-APIC-edge      i8042
 14:    6819170   IO-APIC-edge      libata
 15:      24406   IO-APIC-edge      libata
 16:          2   IO-APIC-fasteoi   ehci_hcd:usb1
 17:       2774   IO-APIC-fasteoi   ohci_hcd:usb2
 18:          0   IO-APIC-fasteoi   ohci_hcd:usb3
 19:  127762258   IO-APIC-fasteoi   sata_sil, nvidia
 20:    3951525   IO-APIC-fasteoi   eth0
 21:   14263646   IO-APIC-fasteoi   ohci1394
 22:   79346222   IO-APIC-fasteoi   SiS SI7012
NMI:    2361981   Non-maskable interrupts
LOC: 3057101728   Local timer interrupts
RES:          0   Rescheduling interrupts
CAL:          0   function call interrupts
TLB:          0   TLB shootdowns
TRM:          0   Thermal event interrupts
SPU:          0   Spurious interrupts
ERR:       4652
MIS:          0

Here is my /etc/sysconfig/rtirq file (with comments stripped for space)

RTIRQ_NAME_LIST="rtc ohci snd usb i8042"
RTIRQ_PRIO_HIGH=80
RTIRQ_PRIO_DECR=5
RTIRQ_RESET_ALL=0
RTIRQ_NON_THREADED="rtc ohci snd"

And here is the output of /etc/init.d/rtirq status

  PID CLS RTPRIO  NI PRI %CPU STAT COMMAND
  279 FF      80   - 120  0.0 S<   IRQ-8        rtc
  363 FF      75   - 115  0.0 S<   IRQ-17       ohci_hcd:usb2
  364 FF      74   - 114  0.0 S<   IRQ-18       ohci_hcd:usb3
  847 FF      73   - 113  0.0 S<   IRQ-21       ohci1394
  877 FF      70   - 110  0.0 S<   IRQ-22       SiS SI7012
  360 FF      65   - 105  0.0 S<   IRQ-16       ehci_hcd:usb1
  338 FF      60   - 100  0.0 S<   IRQ-1        i8042
  337 FF      59   -  99  0.0 S<   IRQ-12       i8042
    5 FF      50   -  90  0.0 S<   softirq-high/0
    6 FF      50   -  90  0.7 S<   softirq-timer/0
    7 FF      50   -  90  0.0 S<   softirq-net-tx/
    8 FF      50   -  90  0.0 S<   softirq-net-rx/
    9 FF      50   -  90  0.0 S<   softirq-block/0
   10 FF      50   -  90  0.3 S<   softirq-tasklet
   11 FF      50   -  90  0.0 S<   softirq-sched/0
   12 FF      50   -  90  0.0 S<   softirq-hrtimer
   13 FF      50   -  90  0.0 S<   softirq-rcu/0
   76 FF      50   -  90  0.0 S<   IRQ-9        acpi
  383 FF      50   -  90  0.3 S<   IRQ-19       sata_sil, nvidia
  397 FF      50   -  90  0.0 S<   IRQ-14       libata
  398 FF      50   -  90  0.0 S<   IRQ-15       libata
  865 FF      50   -  90  0.0 S<   IRQ-6        floppy
  894 FF      50   -  90  0.0 S<   IRQ-7        parport0
 1608 FF      50   -  90  0.0 S<   IRQ-20       eth0
 2891 FF      50   -  90  0.0 S<   IRQ-4

Jack runs at priority 71.

Here is the entry for my firewire card in lspci -v

00:0b.0 FireWire (IEEE 1394): VIA Technologies, Inc. IEEE 1394 Host Controller (rev 80) (prog-if 10 [OHCI])
        Subsystem: VIA Technologies, Inc. IEEE 1394 Host Controller
        Flags: bus master, medium devsel, latency 64, IRQ 21
        Memory at cffff000 (32-bit, non-prefetchable) [size=2K]
        I/O ports at bc00 [size=128]
        Capabilities: <access denied>
        Kernel driver in use: ohci1394
        Kernel modules: ohci1394


Does anyone have any idea what the problem could be?  Should Ijust ignore it, as long as things seem to work?  Do I have to bite the bullet and upgrade Fedora 10 or a 11, and hope that a newer kernel works better?

Thanks for looking hrough all of this.

-------------- next part --------------
Jul 29 02:55:56 rivendell kernel: Pid: 847, comm: IRQ-21 Tainted: P         2.6.24.7-1.rt3.2.fc8.ccrmart #1
Jul 29 02:55:56 rivendell kernel:  [<c041ce3a>] smp_error_interrupt+0x67/0x72
Jul 29 02:55:56 rivendell kernel:  [<c040a912>] sched_clock+0x8/0x18
Jul 29 02:55:56 rivendell kernel:  [<c0405ca0>] error_interrupt+0x28/0x30
Jul 29 02:55:56 rivendell kernel:  [<f89973b6>] ohci_irq_handler+0x29/0x74e [ohci1394]
Jul 29 02:55:56 rivendell kernel:  [<c0434eb0>] trigger_softirqs+0x28/0x32
Jul 29 02:55:56 rivendell kernel:  [<c04641f2>] handle_IRQ_event+0x4a/0xd2
Jul 29 02:55:56 rivendell kernel:  [<c04646a7>] thread_simple_irq+0x3f/0x74
Jul 29 02:55:56 rivendell kernel:  [<c0464daa>] do_irqd+0xab/0x225
Jul 29 02:55:56 rivendell kernel:  [<c0464cff>] do_irqd+0x0/0x225
Jul 29 02:55:56 rivendell kernel:  [<c0442113>] kthread+0x38/0x5d
Jul 29 02:55:56 rivendell kernel:  [<c04420db>] kthread+0x0/0x5d
Jul 29 02:55:56 rivendell kernel:  [<c0405e0f>] kernel_thread_helper+0x7/0x10
Jul 29 02:55:56 rivendell kernel:  =======================
Jul 29 02:55:59 rivendell kernel: Pid: 847, comm: IRQ-21 Tainted: P         2.6.24.7-1.rt3.2.fc8.ccrmart #1
Jul 29 02:55:59 rivendell kernel:  [<c041ce3a>] smp_error_interrupt+0x67/0x72
Jul 29 02:55:59 rivendell kernel:  [<c040a912>] sched_clock+0x8/0x18
Jul 29 02:55:59 rivendell kernel:  [<c0405ca0>] error_interrupt+0x28/0x30
Jul 29 02:56:00 rivendell kernel:  [<f89973b6>] ohci_irq_handler+0x29/0x74e [ohci1394]
Jul 29 02:56:00 rivendell kernel:  [<c0434eb0>] trigger_softirqs+0x28/0x32
Jul 29 02:56:00 rivendell kernel:  [<c04641f2>] handle_IRQ_event+0x4a/0xd2
Jul 29 02:56:00 rivendell kernel:  [<c04646a7>] thread_simple_irq+0x3f/0x74
Jul 29 02:56:00 rivendell kernel:  [<c0464daa>] do_irqd+0xab/0x225
Jul 29 02:56:00 rivendell kernel:  [<c0464cff>] do_irqd+0x0/0x225
Jul 29 02:56:00 rivendell kernel:  [<c0442113>] kthread+0x38/0x5d
Jul 29 02:56:00 rivendell kernel:  [<c04420db>] kthread+0x0/0x5d
Jul 29 02:56:00 rivendell kernel:  [<c0405e0f>] kernel_thread_helper+0x7/0x10
Jul 29 02:56:00 rivendell kernel:  =======================
Jul 29 02:56:00 rivendell kernel: Pid: 847, comm: IRQ-21 Tainted: P         2.6.24.7-1.rt3.2.fc8.ccrmart #1
Jul 29 02:56:00 rivendell kernel:  [<c041ce3a>] smp_error_interrupt+0x67/0x72
Jul 29 02:56:00 rivendell kernel:  [<c040a912>] sched_clock+0x8/0x18
Jul 29 02:56:00 rivendell kernel:  [<c0405ca0>] error_interrupt+0x28/0x30
Jul 29 02:56:00 rivendell kernel:  [<f89973b6>] ohci_irq_handler+0x29/0x74e [ohci1394]
Jul 29 02:56:00 rivendell kernel:  [<c0434eb0>] trigger_softirqs+0x28/0x32
Jul 29 02:56:00 rivendell kernel:  [<c04641f2>] handle_IRQ_event+0x4a/0xd2
Jul 29 02:56:00 rivendell kernel:  [<c04646a7>] thread_simple_irq+0x3f/0x74
Jul 29 02:56:00 rivendell kernel:  [<c0464daa>] do_irqd+0xab/0x225
Jul 29 02:56:00 rivendell kernel:  [<c0464cff>] do_irqd+0x0/0x225
Jul 29 02:56:00 rivendell kernel:  [<c0442113>] kthread+0x38/0x5d
Jul 29 02:56:00 rivendell kernel:  [<c04420db>] kthread+0x0/0x5d
Jul 29 02:56:00 rivendell kernel:  [<c0405e0f>] kernel_thread_helper+0x7/0x10
Jul 29 02:56:00 rivendell kernel:  =======================
Jul 29 02:56:38 rivendell kernel: Pid: 847, comm: IRQ-21 Tainted: P         2.6.24.7-1.rt3.2.fc8.ccrmart #1
Jul 29 02:56:38 rivendell kernel:  [<c041ce3a>] smp_error_interrupt+0x67/0x72
Jul 29 02:56:38 rivendell kernel:  [<c0435888>] irq_exit+0x6f/0x7a
Jul 29 02:56:38 rivendell kernel:  [<c041d2c9>] smp_apic_timer_interrupt+0x71/0x7d
Jul 29 02:56:38 rivendell kernel:  [<c0405ca0>] error_interrupt+0x28/0x30
Jul 29 02:56:38 rivendell kernel:  [<c0634ab3>] schedule+0x10e/0x114
Jul 29 02:56:38 rivendell kernel:  [<c041dcdc>] unmask_IO_APIC_irq+0x17/0x25
Jul 29 02:56:38 rivendell kernel:  [<c0464f00>] do_irqd+0x201/0x225
Jul 29 02:56:38 rivendell kernel:  [<c0464cff>] do_irqd+0x0/0x225
Jul 29 02:56:38 rivendell kernel:  [<c0442113>] kthread+0x38/0x5d
Jul 29 02:56:38 rivendell kernel:  [<c04420db>] kthread+0x0/0x5d
Jul 29 02:56:38 rivendell kernel:  [<c0405e0f>] kernel_thread_helper+0x7/0x10
Jul 29 02:56:38 rivendell kernel:  =======================
Jul 29 02:56:38 rivendell kernel: Pid: 26868, comm: jackd Tainted: P         2.6.24.7-1.rt3.2.fc8.ccrmart #1
Jul 29 02:56:38 rivendell kernel:  [<c041ce3a>] smp_error_interrupt+0x67/0x72
Jul 29 02:56:38 rivendell kernel:  [<c0634fe0>] do_nanosleep+0x4f/0x73
Jul 29 02:56:38 rivendell kernel:  [<c0445164>] hrtimer_nanosleep+0x50/0xaf
Jul 29 02:56:38 rivendell kernel:  [<c0405ca0>] error_interrupt+0x28/0x30
Jul 29 02:56:38 rivendell kernel:  [<c048be3f>] fget_light+0x13/0x85
Jul 29 02:56:38 rivendell kernel:  [<c048b73b>] sys_read+0x17/0x67
Jul 29 02:56:38 rivendell kernel:  [<c04051be>] syscall_call+0x7/0xb
Jul 29 02:56:38 rivendell kernel:  =======================
Jul 29 02:56:39 rivendell kernel: Pid: 847, comm: IRQ-21 Tainted: P         2.6.24.7-1.rt3.2.fc8.ccrmart #1
Jul 29 02:56:40 rivendell kernel:  [<c041ce3a>] smp_error_interrupt+0x67/0x72
Jul 29 02:56:40 rivendell kernel:  [<c040a912>] sched_clock+0x8/0x18
Jul 29 02:56:40 rivendell kernel:  [<c0405ca0>] error_interrupt+0x28/0x30
Jul 29 02:56:40 rivendell kernel:  [<f89973b6>] ohci_irq_handler+0x29/0x74e [ohci1394]
Jul 29 02:56:40 rivendell kernel:  [<c0434eb0>] trigger_softirqs+0x28/0x32
Jul 29 02:56:40 rivendell kernel:  [<c04641f2>] handle_IRQ_event+0x4a/0xd2
Jul 29 02:56:40 rivendell kernel:  [<c04646a7>] thread_simple_irq+0x3f/0x74
Jul 29 02:56:40 rivendell kernel:  [<c0464daa>] do_irqd+0xab/0x225
Jul 29 02:56:40 rivendell kernel:  [<c0464cff>] do_irqd+0x0/0x225
Jul 29 02:56:40 rivendell kernel:  [<c0442113>] kthread+0x38/0x5d
Jul 29 02:56:40 rivendell kernel:  [<c04420db>] kthread+0x0/0x5d
Jul 29 02:56:40 rivendell kernel:  [<c0405e0f>] kernel_thread_helper+0x7/0x10
Jul 29 02:56:40 rivendell kernel:  =======================
Jul 29 02:56:41 rivendell kernel: Pid: 847, comm: IRQ-21 Tainted: P         2.6.24.7-1.rt3.2.fc8.ccrmart #1
Jul 29 02:56:41 rivendell kernel:  [<c041ce3a>] smp_error_interrupt+0x67/0x72
Jul 29 02:56:41 rivendell kernel:  [<c040a912>] sched_clock+0x8/0x18
Jul 29 02:56:42 rivendell kernel:  [<c0405ca0>] error_interrupt+0x28/0x30
Jul 29 02:56:42 rivendell kernel:  [<f89973b6>] ohci_irq_handler+0x29/0x74e [ohci1394]
Jul 29 02:56:42 rivendell kernel:  [<c0435888>] irq_exit+0x6f/0x7a
Jul 29 02:56:42 rivendell kernel:  [<c041d2c9>] smp_apic_timer_interrupt+0x71/0x7d
Jul 29 02:56:42 rivendell kernel:  [<c04641f2>] handle_IRQ_event+0x4a/0xd2
Jul 29 02:56:42 rivendell kernel:  [<c04646a7>] thread_simple_irq+0x3f/0x74
Jul 29 02:56:42 rivendell kernel:  [<c0464daa>] do_irqd+0xab/0x225
Jul 29 02:56:42 rivendell kernel:  [<c0464cff>] do_irqd+0x0/0x225
Jul 29 02:56:42 rivendell kernel:  [<c0442113>] kthread+0x38/0x5d
Jul 29 02:56:42 rivendell kernel:  [<c04420db>] kthread+0x0/0x5d
Jul 29 02:56:42 rivendell kernel:  [<c0405e0f>] kernel_thread_helper+0x7/0x10
Jul 29 02:56:42 rivendell kernel:  =======================
Jul 29 02:56:49 rivendell kernel: Pid: 383, comm: IRQ-19 Tainted: P         2.6.24.7-1.rt3.2.fc8.ccrmart #1
Jul 29 02:56:49 rivendell kernel:  [<c041ce3a>] smp_error_interrupt+0x67/0x72
Jul 29 02:56:49 rivendell kernel:  [<c04041db>] __switch_to+0xa3/0x128
Jul 29 02:56:49 rivendell kernel:  [<c0405ca0>] error_interrupt+0x28/0x30
Jul 29 02:56:50 rivendell kernel:  [<c04641d3>] handle_IRQ_event+0x2b/0xd2
Jul 29 02:56:50 rivendell kernel:  [<c04646a7>] thread_simple_irq+0x3f/0x74
Jul 29 02:56:50 rivendell kernel:  [<c0464daa>] do_irqd+0xab/0x225
Jul 29 02:56:50 rivendell kernel:  [<c0464cff>] do_irqd+0x0/0x225
Jul 29 02:56:50 rivendell kernel:  [<c0442113>] kthread+0x38/0x5d
Jul 29 02:56:50 rivendell kernel:  [<c04420db>] kthread+0x0/0x5d
Jul 29 02:56:50 rivendell kernel:  [<c0405e0f>] kernel_thread_helper+0x7/0x10
Jul 29 02:56:50 rivendell kernel:  =======================


More information about the PlanetCCRMA mailing list