[prev in list] [next in list] [prev in thread] [next in thread] 

List:       linux-smp
Subject:    unexpected IO-APIC
From:       Alessandro Tarchi <a.tarchi () inwind ! it>
Date:       2001-06-28 9:16:47
[Download RAW message or body]

Hello,
I get this error on bi-processor (Intel Coppermine III 933 Mhz) 
with Linux RedHat 7.1 and kernel 2.4.5smp
Motherboard Asus CUV4X-D, 133Mhz FSB AGP Pro/4x, Dual Socket 370.
3 hard disk Ibm 75 GB.
There is an Hyperdisk ata66 pci ide raid controller (hde, hdg) 
the ide controller on board with cdrom (hdb) and hard-disk (hdc),
and a controller scsi adaptec2910 for the tape (st0).
I use a raid 1 software configuration (hde, hdg)and boot from that.
The other disk is for backup.
I disabled parallel port and usb by bios (Award Bios 4/3/2001-VT694X-CUV4X-D)
I enabled tty00 and tty01.

Perhaps is an irq error ?

When I connect the hdc and boot the system hang here:

*********************************************************************
CPU: Before vendor init, caps: 0383fbff 00000000 00000000, vendor = 0
CPU: L1 I cache: 16K, L1 D cache: 16K
CPU: L2 cache: 256K
Intel machine check reporting enabled on CPU#1.
CPU: After vendor init, caps: 0383fbff 00000000 00000000 00000000
CPU:     After generic, caps: 0383fbff 00000000 00000000 00000000
CPU:             Common caps: 0383fbff 00000000 00000000 00000000
OK.
CPU1: Intel Pentium III (Coppermine) stepping 06
CPU has booted.
Before bogomips.
Total of 2 processors activated (3742.10 BogoMIPS).
Before bogocount - setting activated=1.
Boot done.
ENABLING IO-APIC IRQs
...changing IO-APIC physical APIC ID to 2 ... ok.
Synchronizing Arb IDs.
init IO_APIC IRQs
 IO-APIC (apicid-pin) 2-5, 2-7, 2-10, 2-11, 2-13, 2-20, 2-21, 2-22, 2-23
not connected.
..TIMER: vector=49 pin1=2 pin2=0

*********************************************************************

then pressing reset the system boot and then works well.

I attach you the result of dmesg command after this successfull boot
because is requested into that.

Thank you very much,
Alessandro

***************************************
Alessandro Tarchi
e-mail: a.tarchi@inwind.it
***************************************


["dmesg" (text/plain)]

e enabling vector: 00000000
ESR value after enabling vector: 00000000
CPU present map: 9
Booting processor 1/0 eip 2000
Setting warm reset code and vector.
1.
2.
3.
Asserting INIT.
Waiting for send to finish...
+Deasserting INIT.
Waiting for send to finish...
+#startup loops: 2.
Sending STARTUP #1.
After apic_write.
Initializing CPU#1
CPU#1 (phys ID: 0) waiting for CALLOUT
Startup point 1.
Waiting for send to finish...
+Sending STARTUP #2.
After apic_write.
Startup point 1.
Waiting for send to finish...
+After Startup.
Before Callout 1.
After Callout 1.
CALLIN, before setup_local_APIC().
masked ExtINT on CPU#1
ESR value before enabling vector: 00000000
ESR value after enabling vector: 00000000
Calibrating delay loop... 1874.32 BogoMIPS
Stack at about dfff3fb8
CPU: Before vendor init, caps: 0383fbff 00000000 00000000, vendor = 0
CPU: L1 I cache: 16K, L1 D cache: 16K
CPU: L2 cache: 256K
Intel machine check reporting enabled on CPU#1.
CPU: After vendor init, caps: 0383fbff 00000000 00000000 00000000
CPU:     After generic, caps: 0383fbff 00000000 00000000 00000000
CPU:             Common caps: 0383fbff 00000000 00000000 00000000
OK.
CPU1: Intel Pentium III (Coppermine) stepping 06
CPU has booted.
Before bogomips.
Total of 2 processors activated (3742.10 BogoMIPS).
Before bogocount - setting activated=1.
Boot done.
ENABLING IO-APIC IRQs
...changing IO-APIC physical APIC ID to 2 ... ok.
Synchronizing Arb IDs.
init IO_APIC IRQs
 IO-APIC (apicid-pin) 2-5, 2-7, 2-10, 2-11, 2-13, 2-20, 2-21, 2-22, 2-23 not connected.
..TIMER: vector=49 pin1=2 pin2=0
number of MP IRQ sources: 16.
number of IO-APIC #2 registers: 24.
testing the IO APIC.......................

IO APIC #2......
.... register #00: 02000000
.......    : physical APIC id: 02
.... register #01: 00178011
.......     : max redirection entries: 0017
.......     : IO APIC version: 0011
 WARNING: unexpected IO-APIC, please mail
          to linux-smp@vger.kernel.org
.... register #02: 00000000
.......     : arbitration: 00
.... IRQ redirection table:
 NR Log Phy Mask Trig IRR Pol Stat Dest Deli Vect:   
 00 003 03  0    1    1   1   1    1    1    31
 01 003 03  0    0    0   0   0    1    1    39
 02 003 03  0    0    0   0   0    1    1    31
 03 003 03  0    0    0   0   0    1    1    41
 04 003 03  0    0    0   0   0    1    1    49
 05 000 00  1    0    0   0   0    0    0    00
 06 003 03  0    0    0   0   0    1    1    51
 07 000 00  1    0    0   0   0    0    0    00
 08 003 03  0    0    0   0   0    1    1    59
 09 003 03  0    0    0   0   0    1    1    61
 0a 000 00  1    0    0   0   0    0    0    00
 0b 000 00  1    0    0   0   0    0    0    00
 0c 003 03  0    0    0   0   0    1    1    69
 0d 000 00  1    0    0   0   0    0    0    00
 0e 003 03  0    0    0   0   0    1    1    71
 0f 003 03  0    0    0   0   0    1    1    79
 10 003 03  1    1    0   1   0    1    1    81
 11 003 03  1    1    0   1   0    1    1    89
 12 003 03  1    1    0   1   0    1    1    91
 13 003 03  1    1    0   1   0    1    1    99
 14 000 00  1    0    0   0   0    0    0    00
 15 000 00  1    0    0   0   0    0    0    00
 16 000 00  1    0    0   0   0    0    0    00
 17 000 00  1    0    0   0   0    0    0    00
IRQ to pin mappings:
IRQ0 -> 0-> 2
IRQ1 -> 1
IRQ3 -> 3
IRQ4 -> 4
IRQ6 -> 6
IRQ8 -> 8
IRQ9 -> 9
IRQ12 -> 12
IRQ14 -> 14
IRQ15 -> 15
IRQ16 -> 16
IRQ17 -> 17
IRQ18 -> 18
IRQ19 -> 19
.................................... done.
calibrating APIC timer ...
..... CPU clock speed is 937.6884 MHz.
..... host bus clock speed is 133.9552 MHz.
cpu: 0, clocks: 1339552, slice: 446517
CPU0<T0:1339552,T1:893024,D:11,S:446517,C:1339552>
cpu: 1, clocks: 1339552, slice: 446517
CPU1<T0:1339552,T1:446512,D:6,S:446517,C:1339552>
checking TSC synchronization across CPUs: passed.
Setting commenced=1, go go go
PCI: PCI BIOS revision 2.10 entry at 0xf0cc0, last bus=1
PCI: Using configuration type 1
PCI: Probing PCI hardware
PCI: Disabled enhanced CPU to PCI posting
PCI: Disabled enhanced CPU to PCI posting #2
Unknown bridge resource 0: assuming transparent
PCI: Using IRQ router VIA [1106/0686] at 00:04.0
PCI->APIC IRQ transform: (B0,I9,P0) -> 19
PCI->APIC IRQ transform: (B0,I10,P0) -> 18
PCI->APIC IRQ transform: (B0,I11,P0) -> 17
PCI->APIC IRQ transform: (B1,I0,P0) -> 16
Linux NET4.0 for Linux 2.4
Based upon Swansea University Computer Society NET3.039
Initializing RT netlink socket
Starting kswapd v1.8
VFS: Diskquotas version dquot_6.4.0 initialized
NTFS version 010116
udf: registering filesystem
pty: 256 Unix98 ptys configured
Serial driver version 5.05a (2001-03-20) with MANY_PORTS SHARE_IRQ SERIAL_PCI enabled
ttyS00 at 0x03f8 (irq = 4) is a 16550A
ttyS01 at 0x02f8 (irq = 3) is a 16550A
block: queued sectors max/low 340389kB/209317kB, 1024 slots per queue
Uniform Multi-Platform E-IDE driver Revision: 6.31
ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx
VP_IDE: IDE controller on PCI bus 00 dev 21
VP_IDE: chipset revision 6
VP_IDE: not 100% native mode: will probe irqs later
    ide0: BM-DMA at 0xd800-0xd807, BIOS settings: hda:pio, hdb:DMA
    ide1: BM-DMA at 0xd808-0xd80f, BIOS settings: hdc:pio, hdd:pio
CMD648: IDE controller on PCI bus 00 dev 58
CMD648: chipset revision 1
CMD648: not 100% native mode: will probe irqs later
    ide2: BM-DMA at 0x9800-0x9807, BIOS settings: hde:DMA, hdf:pio
    ide3: BM-DMA at 0x9808-0x980f, BIOS settings: hdg:DMA, hdh:pio
hdb: SAMSUNG CD-ROM SC-152C, ATAPI CD/DVD-ROM drive
hde: IBM-DTLA-307075, ATA DISK drive
ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx
hdg: IBM-DTLA-307075, ATA DISK drive
ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
ide2 at 0xb000-0xb007,0xa802 on irq 17
ide3 at 0xa400-0xa407,0xa002 on irq 17
hde: 150136560 sectors (76870 MB) w/1916KiB Cache, CHS=148945/16/63, UDMA(66)
hdg: 150136560 sectors (76870 MB) w/1916KiB Cache, CHS=148945/16/63, UDMA(66)
hdb: ATAPI 52X CD-ROM drive, 128kB Cache, DMA
Uniform CD-ROM driver Revision: 3.12
Partition check:
 hde: hde1 hde2 < hde5 hde6 hde7 hde8 hde9 hde10 hde11 hde12 hde13 hde14 >
 hdg: hdg1 hdg2 < hdg5 hdg6 hdg7 hdg8 hdg9 hdg10 hdg11 hdg12 hdg13 hdg14 >
Floppy drive(s): fd0 is 1.44M
FDC 0 is a post-1991 82077
8139too Fast Ethernet driver 0.9.17
eth0: RealTek RTL8139 Fast Ethernet at 0xe0800000, 00:e0:7d:a1:39:c4, IRQ 19
eth0:  Identified 8139 chip type 'RTL-8139C'
Linux agpgart interface v0.99 (c) Jeff Hartmann
agpgart: Maximum main memory to use for agp memory: 439M
agpgart: Detected Via Apollo Pro chipset
agpgart: AGP aperture is 64M @ 0xf8000000
[drm] AGP 0.99 on VIA Apollo Pro @ 0xf8000000 64MB
[drm] Initialized tdfx 1.0.0 20000928 on minor 63
[drm] AGP 0.99 on VIA Apollo Pro @ 0xf8000000 64MB
[drm] Initialized radeon 1.0.0 20010105 on minor 62
SCSI subsystem driver Revision: 1.00
scsi0 : Adaptec AIC7XXX EISA/VLB/PCI SCSI HBA DRIVER, Rev 6.1.13
        <Adaptec 2902/04/10/15/20/30C SCSI adapter>
        aic7850: Single Channel A, SCSI Id=7, 3/255 SCBs

  Vendor: SONY      Model: SDT-9000          Rev: 0600
  Type:   Sequential-Access                  ANSI SCSI revision: 02
(scsi0:A:4): 10.000MB/s transfers (10.000MHz, offset 15)
scsi1 : SCSI host adapter emulation for IDE ATAPI devices
Detected scsi tape st0 at scsi0, channel 0, id 4, lun 0
st: bufsize 32768, wrt 30720, max init. buffers 4, s/g segs 16.
osst: bufsize 32768, wrt 30720, max buffers 4, s/g segs 9.
Linux PCMCIA Card Services 3.1.22
  options:  [pci] [cardbus] [pm]
Linux telephony interface: v1.00
raid0 personality registered
raid1 personality registered
md driver 0.90.0 MAX_MD_DEVS=256, MD_SB_DISKS=27
md.c: sizeof(mdp_super_t) = 4096
autodetecting RAID arrays
(read) hde1's sb offset: 20544 [events: 00000077]
(read) hde5's sb offset: 20479936 [events: 00000077]
(read) hde6's sb offset: 20479936 [events: 0000007b]
(read) hde7's sb offset: 9216000 [events: 00000077]
(read) hde8's sb offset: 5120000 [events: 00000077]
(read) hde9's sb offset: 4095872 [events: 0000007c]
(read) hde10's sb offset: 3072256 [events: 00000077]
(read) hde11's sb offset: 3072256 [events: 00000077]
(read) hde13's sb offset: 2048128 [events: 00000077]
(read) hde14's sb offset: 5413824 [events: 0000007e]
(read) hdg1's sb offset: 20544 [events: 00000077]
(read) hdg5's sb offset: 20479936 [events: 00000077]
(read) hdg6's sb offset: 20479936 [events: 0000007b]
(read) hdg7's sb offset: 9216000 [events: 00000077]
(read) hdg8's sb offset: 5120000 [events: 00000077]
(read) hdg9's sb offset: 4095872 [events: 0000007c]
(read) hdg10's sb offset: 3072256 [events: 00000077]
(read) hdg11's sb offset: 3072256 [events: 00000077]
(read) hdg13's sb offset: 2048128 [events: 00000077]
(read) hdg14's sb offset: 5413824 [events: 0000007e]
autorun ...
considering hdg14 ...
  adding hdg14 ...
  adding hde14 ...
created md9
bind<hde14,1>
bind<hdg14,2>
running: <hdg14><hde14>
now!
hdg14's event counter: 0000007e
hde14's event counter: 0000007e
md9: max total readahead window set to 124k
md9: 1 data-disks, max readahead per data-disk: 124k
raid1: device hdg14 operational as mirror 1
raid1: device hde14 operational as mirror 0
raid1: raid set md9 active with 2 out of 2 mirrors
md: updating md9 RAID superblock on device
hdg14 [events: 0000007f](write) hdg14's sb offset: 5413824
hde14 [events: 0000007f](write) hde14's sb offset: 5413824
.
considering hdg13 ...
  adding hdg13 ...
  adding hde13 ...
created md4
bind<hde13,1>
bind<hdg13,2>
running: <hdg13><hde13>
now!
hdg13's event counter: 00000077
hde13's event counter: 00000077
md4: max total readahead window set to 124k
md4: 1 data-disks, max readahead per data-disk: 124k
raid1: device hdg13 operational as mirror 1
raid1: device hde13 operational as mirror 0
raid1: raid set md4 active with 2 out of 2 mirrors
md: updating md4 RAID superblock on device
hdg13 [events: 00000078](write) hdg13's sb offset: 2048128
hde13 [events: 00000078](write) hde13's sb offset: 2048128
.
considering hdg11 ...
  adding hdg11 ...
  adding hde11 ...
created md8
bind<hde11,1>
bind<hdg11,2>
running: <hdg11><hde11>
now!
hdg11's event counter: 00000077
hde11's event counter: 00000077
md8: max total readahead window set to 124k
md8: 1 data-disks, max readahead per data-disk: 124k
raid1: device hdg11 operational as mirror 1
raid1: device hde11 operational as mirror 0
raid1: raid set md8 active with 2 out of 2 mirrors
md: updating md8 RAID superblock on device
hdg11 [events: 00000078](write) hdg11's sb offset: 3072256
hde11 [events: 00000078](write) hde11's sb offset: 3072256
.
considering hdg10 ...
  adding hdg10 ...
  adding hde10 ...
created md2
bind<hde10,1>
bind<hdg10,2>
running: <hdg10><hde10>
now!
hdg10's event counter: 00000077
hde10's event counter: 00000077
md2: max total readahead window set to 124k
md2: 1 data-disks, max readahead per data-disk: 124k
raid1: device hdg10 operational as mirror 1
raid1: device hde10 operational as mirror 0
raid1: raid set md2 active with 2 out of 2 mirrors
md: updating md2 RAID superblock on device
hdg10 [events: 00000078](write) hdg10's sb offset: 3072256
hde10 [events: 00000078](write) hde10's sb offset: 3072256
.
considering hdg9 ...
  adding hdg9 ...
  adding hde9 ...
created md7
bind<hde9,1>
bind<hdg9,2>
running: <hdg9><hde9>
now!
hdg9's event counter: 0000007c
hde9's event counter: 0000007c
md7: max total readahead window set to 124k
md7: 1 data-disks, max readahead per data-disk: 124k
raid1: device hdg9 operational as mirror 1
raid1: device hde9 operational as mirror 0
raid1: raid set md7 active with 2 out of 2 mirrors
md: updating md7 RAID superblock on device
hdg9 [events: 0000007d](write) hdg9's sb offset: 4095872
hde9 [events: 0000007d](write) hde9's sb offset: 4095872
.
considering hdg8 ...
  adding hdg8 ...
  adding hde8 ...
created md1
bind<hde8,1>
bind<hdg8,2>
running: <hdg8><hde8>
now!
hdg8's event counter: 00000077
hde8's event counter: 00000077
md1: max total readahead window set to 124k
md1: 1 data-disks, max readahead per data-disk: 124k
raid1: device hdg8 operational as mirror 1
raid1: device hde8 operational as mirror 0
raid1: raid set md1 active with 2 out of 2 mirrors
md: updating md1 RAID superblock on device
hdg8 [events: 00000078](write) hdg8's sb offset: 5120000
hde8 [events: 00000078](write) hde8's sb offset: 5120000
.
considering hdg7 ...
  adding hdg7 ...
  adding hde7 ...
created md3
bind<hde7,1>
bind<hdg7,2>
running: <hdg7><hde7>
now!
hdg7's event counter: 00000077
hde7's event counter: 00000077
md3: max total readahead window set to 124k
md3: 1 data-disks, max readahead per data-disk: 124k
raid1: device hdg7 operational as mirror 1
raid1: device hde7 operational as mirror 0
raid1: raid set md3 active with 2 out of 2 mirrors
md: updating md3 RAID superblock on device
hdg7 [events: 00000078](write) hdg7's sb offset: 9216000
hde7 [events: 00000078](write) hde7's sb offset: 9216000
.
considering hdg6 ...
  adding hdg6 ...
  adding hde6 ...
created md6
bind<hde6,1>
bind<hdg6,2>
running: <hdg6><hde6>
now!
hdg6's event counter: 0000007b
hde6's event counter: 0000007b
md6: max total readahead window set to 124k
md6: 1 data-disks, max readahead per data-disk: 124k
raid1: device hdg6 operational as mirror 1
raid1: device hde6 operational as mirror 0
raid1: raid set md6 active with 2 out of 2 mirrors
md: updating md6 RAID superblock on device
hdg6 [events: 0000007c](write) hdg6's sb offset: 20479936
hde6 [events: 0000007c](write) hde6's sb offset: 20479936
.
considering hdg5 ...
  adding hdg5 ...
  adding hde5 ...
created md5
bind<hde5,1>
bind<hdg5,2>
running: <hdg5><hde5>
now!
hdg5's event counter: 00000077
hde5's event counter: 00000077
md5: max total readahead window set to 124k
md5: 1 data-disks, max readahead per data-disk: 124k
raid1: device hdg5 operational as mirror 1
raid1: device hde5 operational as mirror 0
raid1: raid set md5 active with 2 out of 2 mirrors
md: updating md5 RAID superblock on device
hdg5 [events: 00000078](write) hdg5's sb offset: 20479936
hde5 [events: 00000078](write) hde5's sb offset: 20479936
.
considering hdg1 ...
  adding hdg1 ...
  adding hde1 ...
created md0
bind<hde1,1>
bind<hdg1,2>
running: <hdg1><hde1>
now!
hdg1's event counter: 00000077
hde1's event counter: 00000077
md0: max total readahead window set to 124k
md0: 1 data-disks, max readahead per data-disk: 124k
raid1: device hdg1 operational as mirror 1
raid1: device hde1 operational as mirror 0
raid1: raid set md0 active with 2 out of 2 mirrors
md: updating md0 RAID superblock on device
hdg1 [events: 00000078](write) hdg1's sb offset: 20544
hde1 [events: 00000078](write) hde1's sb offset: 20544
.
... autorun DONE.
NET4: Linux TCP/IP 1.0 for NET4.0
IP Protocols: ICMP, UDP, TCP, IGMP
IP: routing cache hash table of 4096 buckets, 32Kbytes
TCP: Hash tables configured (established 32768 bind 32768)
ip_tables: (c)2000 Netfilter core team
NET4: Unix domain sockets 1.0/SMP for Linux NET4.0.
ds: no socket drivers loaded!
VFS: Mounted root (ext2 filesystem) readonly.
Freeing unused kernel memory: 240k freed
Adding Swap: 2048216k swap-space (priority -1)
Adding Swap: 2048216k swap-space (priority -2)
eth0: media is unconnected, link down, or incompatible connection


***************************************
Ing. Alessandro Tarchi
Via Turchia, 5 - 50126 Firenze
Tel. 055.6532256 - 328.5723994
e-mail: a.tarchi@inwind.it
***************************************
-
To unsubscribe from this list: send the line "unsubscribe linux-smp" in
the body of a message to majordomo@vger.kernel.org


[prev in list] [next in list] [prev in thread] [next in thread] 

Configure | About | News | Add a list | Sponsored by KoreLogic