Thanks for that.
On Fri, 27 Jun 2014, Jesse Osiecki wrote:
> Finally got the trace off. See attached.
The log reveals a problem that I've not seen before. (I was expecting to
> I have no idea what the kernel message is saying, but I am going to do
> some digging this weekend.
>
> It should also be noted that I am using TG's initramfs (3.14) with a
> 3.15 kernel I compiled earlier this month (as per instruction on here to
> use the basic mac config). I am also going to review the defconfig
> flags.
see the same issue that sometimes shows up on my PowerBook 520, but this
is different.)
Can you confirm that the network card works in MacOS? Does the actual card
have a SONIC chip fitted to it? While you have the logic board out, you
might want to check that the 68LC040 CPU has a known-good revision code
stamped on it (and/or take photos).
>
> Linux version 3.15.0-mac-178577-g2d893a5 (jesse@jesse-Peppy) (gcc version 4.6.3 (GCC) ) #1 Tue Jun 17 21:39:47 EDT 2014
Building kernels using debian/m68k on aranym might give different
results... when all else fails, blame the compiler ;-)
> Saving 414 bytes of bootinfo
> Detected Macintosh model: 98
> Penguin bootinfo data:
> Video: addr 0xf9001000 row 0x280 depth 8 dimensions 640 x 480
> Videological 0xf0001000 phys. 0xf9001000, SCC at 0x50f0c020
> Boottime: 0xe6ef9c97 GMTBias: 0x0
> Machine ID: 98 CPUid: 0x2 memory size: 0x84
> VIA1 at 50f00000 is a 6522 or clone
> VIA2 at 50f02000 is a 6522 or clone
> Apple Macintosh Quadra 630
> On node 0 totalpages: 33792
> free_area_init_node: node 0, pgdat 0037b21c, node_mem_map 00408000
> DMA zone: 297 pages used for memmap
> DMA zone: 0 pages reserved
> DMA zone: 33792 pages, LIFO batch:7
> initrd: 08010000 - 08400000
> pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
> pcpu-alloc: [0] 0
> Built 1 zonelists in Zone order, mobility grouping on. Total pages: 33495
> Kernel command line: root=/dev/hda7 devtmpfs.mount=1
> PID hash table entries: 1024 (order: 0, 4096 bytes)
> Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
> Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
> Sorting __ex_table...
> Memory: 125588K/135168K available (2786K kernel code, 303K rwdata, 636K rodata, 148K init, 179K bss, 9580K reserved)
> Virtual kernel memory layout:
> vector : 0x0037ad0c - 0x0037b10c ( 1 KiB)
> kmap : 0xd0000000 - 0xf0000000 ( 512 MiB)
> vmalloc : 0x08800000 - 0xd0000000 (3192 MiB)
> lowmem : 0x00000000 - 0x08400000 ( 132 MiB)
> .init : 0x003a8000 - 0x003cd000 ( 148 KiB)
> .text : 0x00001000 - 0x002b9844 (2787 KiB)
> .data : 0x002bcb30 - 0x003a79cc ( 940 KiB)
> .bss : 0x0037ac20 - 0x003a79cc ( 180 KiB)
> NR_IRQS:72
> Killing onboard sonic... Done.
> WARNING: Persistent clock returned invalid value!
> Check your CMOS/BIOS settings.
This warning can be ignored (RTC is not available before the CUDA driver
starts). You can turn off CONFIG_RTC_HCTOSYS to get rid of it.
> Console: colour dummy device 80x25
> console [tty0] enabled
> Calibrating delay loop... 21.55 BogoMIPS (lpj=107776)
> pid_max: default: 32768 minimum: 301
> Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
> Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
> devtmpfs: initialized
> NET: Registered protocol family 16
> NuBus: Scanning NuBus slots.
> SCSI subsystem initialized
> NET: Registered protocol family 2
> TCP established hash table entries: 2048 (order: 1, 8192 bytes)
> TCP bind hash table entries: 2048 (order: 1, 8192 bytes)
> TCP: Hash tables configured (established 2048 bind 2048)
> TCP: reno registered
> UDP hash table entries: 256 (order: 0, 4096 bytes)
> UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
> NET: Registered protocol family 1
> RPC: Registered named UNIX socket transport module.
> RPC: Registered udp transport module.
> RPC: Registered tcp transport module.
> RPC: Registered tcp NFSv4.1 backchannel transport module.
> Trying to unpack rootfs image as initramfs...
> Freeing initrd memory: 4032K (08010000 - 08400000)
> futex hash table entries: 256 (order: -1, 3072 bytes)
> VFS: Disk quotas dquot_6.5.2
> Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
> msgmni has been set to 253
> Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
> io scheduler noop registered
> io scheduler cfq registered (default)
> Monitor sense value = 0x603
> using video mode 13 and color mode 0.
> Console: switching to colour frame buffer device 104x39
> fb0: valkyrie frame buffer device
> pmac_zilog: 0.6 (Benjamin Herrenschmidt <benh@kernel.crashing.org>)
> scc.0: ttyS0 at MMIO 0x50f0c022 (irq = 4, base_baud = 230400) is a Z85c30 ESCC - Serial port
> scc.1: ttyS1 at MMIO 0x50f0c020 (irq = 4, base_baud = 230400) is a Z85c30 ESCC - Serial port
> brd: module loaded
> loop: module loaded
> Macintosh CUDA driver v0.5 for Unified ADB.
> Uniform Multi-Platform E-IDE driver
> ide: Macintosh Quadra IDE controller
> Probing IDE interface ide0...
> adb: starting probe task...
> adb devices: [2]: 2 8 [3]: 3 1
> ADB keyboard at 2, handler 1
> Detected ADB keyboard, type ANSI.
> input: ADB keyboard as /devices/virtual/input/input0
> ADB mouse at 3, handler set to 2
> input: ADB mouse as /devices/virtual/input/input1
> adb: finished probe task...
> hda: WDC WD600BB-75CAA0, ATA DISK drive
> ide0 at 0x50f1a000 on irq 62
> ide-gd driver 1.18
> hda: max request size: 128KiB
> hda: Host Protected Area detected.
> ^Icurrent capacity is 117187500 sectors (60000 MB)
> ^Inative capacity is 117231408 sectors (60022 MB)
> hda: 117187500 sectors (60000 MB) w/2048KiB Cache, CHS=65535/16/63
> hda: cache flushes not supported
> hda: [mac] hda1 hda2 hda3 hda4 hda5 hda6 hda7 hda8 hda9 hda10 hda11 hda12 hda13 hda14
> ide-cd driver 5.00
> mac_esp: using PDMA for controller 0
> esp: esp0, regs[50f10000:(null)] irq[19]
> esp: esp0 is a ESP236, 16 MHz (ccf=4), SCSI ID 7
> scsi0 : esp
> scsi 0:0:3:0: CD-ROM MATSHITA CD-ROM CR-8004 1.1f PQ: 0 ANSI: 2
> scsi target0:0:3: Beginning Domain Validation
> scsi target0:0:3: FAST-5 SCSI 2.1 MB/s ST (472 ns, offset 8)
> scsi target0:0:3: Domain Validation skipping write tests
> scsi target0:0:3: Ending Domain Validation
> sr0: scsi-1 drive
> cdrom: Uniform CD-ROM driver Revision: 3.20
> sr 0:0:3:0: Attached scsi CD-ROM sr0
Looks good so far.
> Checking for internal Macintosh ethernet (SONIC).. yes
> sonic.c:v0.92 20.9.98 tsbogend@alpha.franken.de
> macsonic: onboard / comm-slot SONIC at 0x50f0a000
> macsonic: revision 0x0000, using 16 bit DMA and register offset 0
This is suspicious. I can't get a google hit for "macsonic: revision
0x0000" and every log file I have (various models) says revision 0x0004.
> macsonic: MAC address in PROM seems to be invalid, trying CAM
> macsonic: MAC address in CAM entry 15 seems invalid, will use a random MAC
The random MAC should not happen except on PowerBook 520. So the card PROM
and chip registers don't seem to work. Does this card have a large DP83932
or DP83934 "SONIC" chip? What make and model is the card itself?
> eth0: MAC c2:5c:c7:a8:00:28 IRQ 3
> mousedev: PS/2 mouse device common for all mice
> TCP: cubic registered
> NET: Registered protocol family 17
> NET: Registered protocol family 15
> Key type dns_resolver registered
> drivers/rtc/hctosys.c: unable to open rtc device (rtc0)
> Freeing unused kernel memory: 148K (003a8000 - 003cd000)
> <30>systemd-udevd[49]: starting version 204
> random: nonblocking pool is initialized
> EXT4-fs (hda7): mounted filesystem with ordered data mode. Opts: (null)
> Adding 1073148k swap on /dev/hda9. Priority:-1 extents:1 across:1073148k
> EXT4-fs (hda7): re-mounted. Opts: (null)
> sonic_init: failed, status=0
> sonic_init: failed, status=0
> sonic_init: failed, status=0
> ------------[ cut here ]------------
> WARNING: CPU: 0 PID: 0 at net/sched/sch_generic.c:264 dev_watchdog+0x1a8/0x1c8()
> NETDEV WATCHDOG: eth0 (macsonic): transmit queue 0 timed out
> Modules linked in:
> CPU: 0 PID: 0 Comm: swapper Not tainted 3.15.0-mac-178577-g2d893a5 #1
> Stack from 0035de3c:
> 0035de3c 00324242 00019ffc 00000000 00000003 00382874 00382a74 07333000
> 0000012c 0001a08c 0033a7fa 00000108 00238d7e 00000009 0035de78 0033a7c1
> 0035de94 0035df04 00238d7e 0033a7fa 00000108 0033a7c1 07333000 0037548c
> 00000000 07333000 00000100 00382674 0035c000 00238bd6 00382474 00021966
> 07333000 0035df04 00381c60 0002194a 00021b00 00238bd6 07333000 00000002
> 00000002 00000100 0000000a 00019fa2 0035c000 00381b24 0035c000 000432de
> Call Trace: [<00019ffc>] warn_slowpath_common+0x5c/0x74
> [<0001a08c>] warn_slowpath_fmt+0x2a/0x32
> [<00238d7e>] dev_watchdog+0x1a8/0x1c8
> [<00238d7e>] dev_watchdog+0x1a8/0x1c8
> [<00238bd6>] dev_watchdog+0x0/0x1c8
> [<00021966>] call_timer_fn.isra.43+0x1c/0x7c
> [<0002194a>] call_timer_fn.isra.43+0x0/0x7c
> [<00021b00>] run_timer_softirq+0x13a/0x230
> [<00238bd6>] dev_watchdog+0x0/0x1c8
> [<00019fa2>] warn_slowpath_common+0x2/0x74
> [<000432de>] rcu_bh_qs+0x0/0x36
> [<0001d164>] __do_softirq+0xa6/0x1c4
> [<0003ab5c>] arch_cpu_idle_enter+0x0/0x2
> [<00002f76>] arch_cpu_idle+0x0/0x6
> [<0003ab5e>] arch_cpu_idle_exit+0x0/0x2
> [<00043010>] rcu_idle_exit+0x0/0xae
> [<00200000>] sonic_interrupt+0x230/0x768
> [<0001d468>] irq_exit+0x36/0x3c
> [<00002c5a>] do_IRQ+0x26/0x32
> [<00043226>] rcu_idle_enter+0x0/0xb8
> [<00002b54>] auto_irqhandler_fixup+0x4/0xc
> [<00043226>] rcu_idle_enter+0x0/0xb8
> [<0003ab5c>] arch_cpu_idle_enter+0x0/0x2
> [<00002f76>] arch_cpu_idle+0x0/0x6
> [<00002f76>] arch_cpu_idle+0x0/0x6
> [<0003ac1a>] cpu_startup_entry+0x94/0xee
> [<00001000>] kernel_pg_dir+0x0/0x1000
> [<00019836>] kernel_thread+0x0/0x24
> [<0017f39e>] strlen+0x0/0x1c
> [<002b3f98>] printk+0x0/0x24
> [<002b28ce>] rest_init+0x5e/0x66
> [<0017f206>] strcpy+0x0/0x18
> [<003a9f28>] start_kernel+0x3a6/0x3b2
> [<00007aa5>] mac_nmi_handler+0xad/0xb4
> [<00007aa5>] mac_nmi_handler+0xad/0xb4
> [<00002000>] _start+0x0/0x8
> [<003a8410>] _sinittext+0x410/0xadc
>
> ---[ end trace c3fa2b970e0d3cdc ]---
> sonic_init: failed, status=0
> sonic_init: failed, status=0
>
The other driver errors above are to be expected if the driver can't talk
to a suitable chip.
For comparison, here is the log of my most recent test involving the SONIC
driver on my Mac LC 630.
Linux version 3.1.0-rc5-mac-00457-gb36953a-dirty (fthain@nippy) (gcc version 4.4.6 (GCC) ) #77 Sat Oct 22 23:24:49 EST 2011
bootconsole [early0] enabled
Detected Macintosh model: 98
Penguin bootinfo data:
Video: addr 0xf9001000 row 0x68 depth 1 dimensions 832 x 624
Videological 0xf0001000 phys. 0xf9001000, SCC at 0x50f0c020
Boottime: 0x4ea464ef GMTBias: 0x0
Machine ID: 98 CPUid: 0x2 memory size: 0x84
VIA1 at 50f00000 is a 6522 or clone
VIA2 at 50f02000 is a 6522 or clone
VIA2 vPCR is 0x26
Apple Macintosh Quadra 630
On node 0 totalpages: 33792
free_area_init_node: node 0, pgdat 0026f858, node_mem_map 002e1000
DMA zone: 297 pages used for memmap
DMA zone: 0 pages reserved
DMA zone: 33495 pages, LIFO batch:7
pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
pcpu-alloc: [0] 0
Built 1 zonelists in Zone order, mobility grouping on. Total pages: 33495
Kernel command line: root=/dev/sda6
PID hash table entries: 1024 (order: 0, 4096 bytes)
Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
Memory: 130800k/130800k available (1848k kernel code, 2412k data, 108k init)
SLUB: Genslabs=14, HWalign=16, Order=0-3, MinObjects=0, CPUs=1, Nodes=8
NR_IRQS:72
Killing onboard sonic... Done.
Console: colour dummy device 80x25
console [tty0] enabled, bootconsole disabled
Calibrating delay loop... 21.70 BogoMIPS (lpj=108544)
pid_max: default: 32768 minimum: 301
Mount-cache hash table entries: 512
devtmpfs: initialized
NET: Registered protocol family 16
bio: create slab <bio-0> at 0
VIA2 vDirA is 0x00
NuBus: Scanning NuBus slots.
SCSI subsystem initialized
NET: Registered protocol family 2
IP route cache hash table entries: 2048 (order: 1, 8192 bytes)
TCP established hash table entries: 8192 (order: 4, 65536 bytes)
TCP bind hash table entries: 8192 (order: 3, 32768 bytes)
TCP: Hash tables configured (established 8192 bind 8192)
TCP reno registered
UDP hash table entries: 256 (order: 0, 4096 bytes)
UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
NET: Registered protocol family 1
RPC: Registered named UNIX socket transport module.
RPC: Registered udp transport module.
RPC: Registered tcp transport module.
RPC: Registered tcp NFSv4.1 backchannel transport module.
msgmni has been set to 255
Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
io scheduler noop registered
io scheduler deadline registered (default)
Monitor sense value = 0x60b
using video mode 6 and color mode 0.
Console: switching to colour frame buffer device 80x30
fb0: valkyrie frame buffer device
pmac_zilog: 0.6 (Benjamin Herrenschmidt <benh@kernel.crashing.org>)
ttyS0 at MMIO 0x50f0c022 (irq = 4) is a Z85c30 ESCC - Serial port
ttyS1 at MMIO 0x50f0c020 (irq = 4) is a Z85c30 ESCC - Serial port
Macintosh CUDA driver v0.5 for Unified ADB.
Uniform Multi-Platform E-IDE driver
ide: Macintosh Quadra IDE controller
Probing IDE interface ide0...
adb: starting probe task...
adb devices: [2]: 2 2 [3]: 3 1
ADB keyboard at 2, handler set to 3
Detected ADB keyboard, type ANSI.
input: ADB keyboard as /devices/virtual/input/input0
ADB mouse at 3, handler set to 2
hda: DSAA-3360, ATA DISK drive
input: ADB mouse as /devices/virtual/input/input1
adb: finished probe task...
ide0 at 0x50f1a000 on irq 62
ide-gd driver 1.18
hda: max request size: 128KiB
hda: 713472 sectors (365 MB) w/96KiB Cache, CHS=929/16/48
hda: cache flushes not supported
hda: [mac] hda1 hda2 hda3 hda4 hda5 hda6 hda7 hda8
mac_esp: using PDMA for controller 0
esp: esp0, regs[50f10000:(null)] irq[19]
esp: esp0 is a ESP236, 16 MHz (ccf=4), SCSI ID 7
scsi0 : esp
scsi 0:0:3:0: CD-ROM MATSHITA CD-ROM CR-8004 1.1f PQ: 0 ANSI: 2
scsi target0:0:3: Beginning Domain Validation
scsi target0:0:3: FAST-5 SCSI 2.1 MB/s ST (472 ns, offset 8)
scsi target0:0:3: Domain Validation skipping write tests
scsi target0:0:3: Ending Domain Validation
scsi 0:0:6:0: Direct-Access QUANTUM LPS540S 590S PQ: 0 ANSI: 2 CCS
scsi target0:0:6: Beginning Domain Validation
scsi target0:0:6: FAST-5 SCSI 3.3 MB/s ST (304 ns, offset 8)
scsi target0:0:6: Domain Validation skipping write tests
scsi target0:0:6: Ending Domain Validation
sd 0:0:6:0: [sda] 1057616 512-byte logical blocks: (541 MB/516 MiB)
sd 0:0:6:0: [sda] Write Protect is off
sd 0:0:6:0: [sda] Mode Sense: 93 00 00 08
sd 0:0:6:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
sr0: scsi-1 drive
cdrom: Uniform CD-ROM driver Revision: 3.20
sr 0:0:3:0: Attached scsi CD-ROM sr0
Checking for internal Macintosh ethernet (SONIC).. yes
sonic.c:v0.92 20.9.98 tsbogend@alpha.franken.de
macsonic: onboard / comm-slot SONIC at 0x50f0a000
macsonic: revision 0x0004, using 16 bit DMA and register offset 0
eth0: MAC 00:a0:40:28:41:a9 IRQ 56
sda: [mac] sda1 sda2 sda3 sda4 sda5 sda6
aoe: AoE v47 initialised.
mousedev: PS/2 mouse device common for all mice
rtc-generic rtc-generic: rtc core: registered rtc-generic as rtc0
TCP cubic registered
NET: Registered protocol family 17
Registering the dns_resolver key type
sd 0:0:6:0: [sda] Attached SCSI disk
VFS: Mounted root (ext2 filesystem) readonly on device 8:6.
Adding 64996k swap on /dev/sda5. Priority:-1 extents:1 across:64996k
# cat /proc/interrupts
CPU0
3: 227329 auto SONIC
4: 116220 auto
7: 0 auto NMI
10: 103111 mac ADB
14: 127237 mac timer
19: 103972 mac Mac ESP
56: 21 mac SONIC
62: 36732 mac ide0
ERR: 0
--