[CLE266] Hardy freezes on EPIA Via when switching screens

[Brian Candler]

System description: Epia M10000 motherboard, VIA chipset (Nehemiah processor, 1GHz), 1GB RAM, firewire harddrive. Fully updated Hardy, kernel 2.6.24-19-386.

This system ran reliably under Dapper for over a year.

The normal usage pattern of this system is for my wife and I to have simultaneous X logins, and we switch between them using Ctrl-Alt-F7 / Ctrl-Alt-F8 or F9. This worked fine under Dapper.

After upgrading to Hardy (using update-manager -d), frequently when switching screens the machine locks up hard. By this I mean:
* the screen remains on but is completely static
* moving the mouse has no effect
* ctrl-alt-Fn and ctrl-alt-Backspace have no effect
* the machine is no longer pingable from another machine on the same LAN

The only solution is a hard reset.

I can't be 100% sure that *only* swapping screens is causing the problem, because normally when we approach the console, the first thing we do is to swap to the other screen using Ctrl-Alt-Fn; it's conceivable the machine had already frozen before pressing this.

However, I *can* replicate the problem by switching screens with Ctrl-Alt-Fn a few tens of times, so this does seem to be the culprit.

Having searched forums, I have found a number of reports about Hardy lockups, but these seem to occur after some minutes of use, or are X lockups which can be fixed by Ctrl-Alt-Backspace. Hence I'm reporting this as a separate problem.

As far as I know, I'm not using any accelerated video driver. In fact, the gdm login screen paints the background embarrassingly slowly, taking nearly a second. But then, this isn't exactly a speed daemon system :-) After logging in, the desktop background is displayed quickly.

Note: after upgrading to Hardy, I also reset xorg.conf to defaults (by using the recovery mode).

$ lsb_release -rd
Description: Ubuntu 8.04.1
Release: 8.04

$ lspci
00:00.0 Host bridge: VIA Technologies, Inc. VT8623 [Apollo CLE266]
00:01.0 PCI bridge: VIA Technologies, Inc. VT8633 [Apollo Pro266 AGP]
00:0d.0 FireWire (IEEE 1394): VIA Technologies, Inc. IEEE 1394 Host Controller (rev 80)
00:10.0 USB Controller: VIA Technologies, Inc. VT82xxxxx UHCI USB 1.1 Controller (rev 80)
00:10.1 USB Controller: VIA Technologies, Inc. VT82xxxxx UHCI USB 1.1 Controller (rev 80)
00:10.2 USB Controller: VIA Technologies, Inc. VT82xxxxx UHCI USB 1.1 Controller (rev 80)
00:10.3 USB Controller: VIA Technologies, Inc. USB 2.0 (rev 82)
00:11.0 ISA bridge: VIA Technologies, Inc. VT8235 ISA Bridge
00:11.1 IDE interface: VIA Technologies, Inc. VT82C586A/B/VT82C686/A/B/VT823x/A/C PIPC Bus Master IDE (rev 06)
00:11.5 Multimedia audio controller: VIA Technologies, Inc. VT8233/A/8235/8237 AC97 Audio Controller (rev 50)
00:12.0 Ethernet controller: VIA Technologies, Inc. VT6102 [Rhine-II] (rev 74)
01:00.0 VGA compatible controller: VIA Technologies, Inc. VT8623 [Apollo CLE266] integrated CastleRock graphics (rev 03)

$ lsmod | sort
ac 6020 0
ac97_bus 2176 1 snd_ac97_codec
af_packet 21636 0
agpgart 33328 2 drm,via_agp
async_memcpy 2816 1 raid456
async_tx 7496 3 raid456,async_xor,async_memcpy
async_xor 4096 1 raid456
ata_generic 7428 0
battery 13316 0
bitblit 5888 1 fbcon
button 8336 0
cdrom 36512 1 sr_mod
container 4736 0
cpufreq_conservative 7200 0
cpufreq_ondemand 8084 1
cpufreq_powersave 1792 0
cpufreq_stats 5124 0
cpufreq_userspace 4120 0
crc_ccitt 2176 1 irda
dm_mirror 22912 0
dm_mod 60484 2 dm_mirror,dm_snapshot
dm_snapshot 18592 0
dock 10124 0
drm 80660 3 via
ehci_hcd 36748 0
evdev 11776 3
ext3 132872 4
fan 4740 0
fbcon 41888 72
floppy 58116 0
font 8576 1 fbcon
freq_table 4484 3 longhaul,cpufreq_stats,cpufreq_ondemand
fuse 48404 1
gameport 14472 1 snd_via82xx
i2c_core 23696 1 i2c_viapro
i2c_viapro 8852 0
ieee1394 92216 2 sbp2,ohci1394
iptable_filter 2944 0
ip_tables 13000 1 iptable_filter
ipv6 255172 18
irda 193852 1 via_ircc
jbd 43028 1 ext3
libata 159728 3 pata_via,pata_acpi,ata_generic
libusual 18208 1 usb_storage
linear 6272 0
longhaul 10600 0
lp 11332 0
mbcache 8192 1 ext3
md_mod 79508 6 raid10,raid456,raid1,raid0,multipath,linear
mii 5504 1 via_rhine
Module Size Used by
multipath 8448 0
ohci1394 32688 1
output 3712 1 video
parport 35912 3 ppdev,lp,parport_pc
parport_pc 35108 1
pata_acpi 7424 0
pata_via 12420 0
pci_hotplug 29728 1 shpchp
pcspkr 3072 0
ppdev 9348 0
processor 28080 2 thermal
psmouse 39056 0
raid0 8320 0
raid10 24192 0
raid1 24192 0
raid456 125712 0
rtc 13212 0
sbp2 22920 5
sbs 14216 0
sbshc 6784 1 sbs
scsi_mod 151180 6 sd_mod,sbp2,usb_storage,sg,sr_mod,libata
sd_mod 29584 6
serio_raw 7044 0
sg 36256 0
shpchp 33428 0
snd 54692 12 snd_via82xx,snd_ac97_codec,snd_mpu401_uart,snd_pcm_oss,snd_pcm,snd_mixer_oss,snd_seq_dummy,snd_seq_oss,snd_rawmidi,snd_seq,snd_timer,snd_seq_device
snd_ac97_codec 99876 1 snd_via82xx
snd_mixer_oss 16896 1 snd_pcm_oss
snd_mpu401_uart 8832 1 snd_via82xx
snd_page_alloc 10504 2 snd_via82xx,snd_pcm
snd_pcm 75400 3 snd_via82xx,snd_ac97_codec,snd_pcm_oss
snd_pcm_oss 40736 0
snd_rawmidi 24608 2 snd_mpu401_uart,snd_seq_midi
snd_seq 51152 6 snd_seq_dummy,snd_seq_oss,snd_seq_midi,snd_seq_midi_event
snd_seq_device 8588 5 snd_seq_dummy,snd_seq_oss,snd_seq_midi,snd_rawmidi,snd_seq
snd_seq_dummy 3972 0
snd_seq_midi 8480 0
snd_seq_midi_event 7552 2 snd_seq_oss,snd_seq_midi
snd_seq_oss 34048 0
snd_timer 23556 2 snd_pcm,snd_seq
snd_via82xx 27928 0
softcursor 2176 1 bitblit
soundcore 7520 1 snd
sr_mod 16804 0
svgalib 9472 1 vt8623fb
thermal 15772 0
tileblit 2560 1 fbcon
uhci_hcd 25616 0
usbcore 143724 5 usb_storage,libusual,ehci_hcd,uhci_hcd
usb_storage 72512 0
vgastate 9600 1 vt8623fb
via 42496 2
via_agp 10240 1
via_ircc 26900 0
via_rhine 24840 0
video 18832 0
vt8623fb 17280 1
xor 15240 2 raid456,async_xor
x_tables 14852 1 ip_tables

$ dmesg
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Linux version 2.6.24-19-386 (buildd@palmer) (gcc version 4.2.3 (Ubuntu 4.2.3-2ubuntu7)) #1 Wed Jun 18 14:09:56 UTC 2008 (Ubuntu 2.6.24-19.34-386)
[ 0.000000] BIOS-provided physical RAM map:
[ 0.000000] BIOS-e820: 0000000000000000 - 000000000009fc00 (usable)
[ 0.000000] BIOS-e820: 000000000009fc00 - 00000000000a0000 (reserved)
[ 0.000000] BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved)
[ 0.000000] BIOS-e820: 0000000000100000 - 000000003dff0000 (usable)
[ 0.000000] BIOS-e820: 000000003dff0000 - 000000003dff3000 (ACPI NVS)
[ 0.000000] BIOS-e820: 000000003dff3000 - 000000003e000000 (ACPI data)
[ 0.000000] BIOS-e820: 00000000ffff0000 - 0000000100000000 (reserved)
[ 0.000000] 95MB HIGHMEM available.
[ 0.000000] 896MB LOWMEM available.
[ 0.000000] Entering add_active_range(0, 0, 253936) 0 entries of 256 used
[ 0.000000] Zone PFN ranges:
[ 0.000000] DMA 0 -> 4096
[ 0.000000] Normal 4096 -> 229376
[ 0.000000] HighMem 229376 -> 253936
[ 0.000000] Movable zone start PFN for each node
[ 0.000000] early_node_map[1] active PFN ranges
[ 0.000000] 0: 0 -> 253936
[ 0.000000] On node 0 totalpages: 253936
[ 0.000000] DMA zone: 32 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 4064 pages, LIFO batch:0
[ 0.000000] Normal zone: 1760 pages used for memmap
[ 0.000000] Normal zone: 223520 pages, LIFO batch:31
[ 0.000000] HighMem zone: 191 pages used for memmap
[ 0.000000] HighMem zone: 24369 pages, LIFO batch:3
[ 0.000000] Movable zone: 0 pages used for memmap
[ 0.000000] DMI 2.2 present.
[ 0.000000] ACPI: RSDP signature @ 0xC00F6620 checksum 0
[ 0.000000] ACPI: RSDP 000F6620, 0014 (r0 VT9174)
[ 0.000000] ACPI: RSDT 3DFF3000, 0028 (r1 VT9174 AWRDACPI 42302E31 AWRD 0)
[ 0.000000] ACPI: FACP 3DFF3040, 0074 (r1 VT9174 AWRDACPI 42302E31 AWRD 0)
[ 0.000000] ACPI: DSDT 3DFF30C0, 2FDD (r1 VT9174 AWRDACPI 1000 MSFT 100000C)
[ 0.000000] ACPI: FACS 3DFF0000, 0040
[ 0.000000] ACPI: PM-Timer IO Port: 0x408
[ 0.000000] Allocating PCI resources starting at 40000000 (gap: 3e000000:c1ff0000)
[ 0.000000] swsusp: Registered nosave memory region: 000000000009f000 - 00000000000a0000
[ 0.000000] swsusp: Registered nosave memory region: 00000000000a0000 - 00000000000f0000
[ 0.000000] swsusp: Registered nosave memory region: 00000000000f0000 - 0000000000100000
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 251953
[ 0.000000] Kernel command line: root=UUID=804188ab-4568-484f-9ed7-674ff45985c8 ro quiet splash nohz=off
[ 0.000000] No local APIC present or hardware disabled
[ 0.000000] mapped APIC to ffffb000 (017c4000)
[ 0.000000] Enabling fast FPU save and restore... done.
[ 0.000000] Enabling unmasked SIMD FPU exception support... done.
[ 0.000000] Initializing CPU#0
[ 0.000000] PID hash table entries: 4096 (order: 12, 16384 bytes)
[ 0.000000] Detected 999.856 MHz processor.
[ 211.110257] Console: colour VGA+ 80x25
[ 211.110268] console [tty0] enabled
[ 211.112795] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[ 211.116945] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 211.291478] Memory: 994424k/1015744k available (2079k kernel code, 20716k reserved, 973k data, 364k init, 98240k highmem)
[ 211.291513] virtual kernel memory layout:
[ 211.291517] fixmap : 0xfffa6000 - 0xfffff000 ( 356 kB)
[ 211.291522] pkmap : 0xff800000 - 0xffc00000 (4096 kB)
[ 211.291527] vmalloc : 0xf8800000 - 0xff7fe000 ( 111 MB)
[ 211.291532] lowmem : 0xc0000000 - 0xf8000000 ( 896 MB)
[ 211.291536] .init : 0xc03fe000 - 0xc0459000 ( 364 kB)
[ 211.291541] .data : 0xc0307d54 - 0xc03fb3a4 ( 973 kB)
[ 211.291546] .text : 0xc0100000 - 0xc0307d54 (2079 kB)
[ 211.291558] Checking if this processor honours the WP bit even in supervisor mode... Ok.
[ 211.291722] SLUB: Genslabs=11, HWalign=32, Order=0-1, MinObjects=4, CPUs=1, Nodes=1
[ 211.371750] Calibrating delay using timer specific routine.. 2001.72 BogoMIPS (lpj=4003459)
[ 211.371839] Security Framework initialized
[ 211.371864] SELinux: Disabled at boot.
[ 211.371915] AppArmor: AppArmor initialized
[ 211.371930] Failure registering capabilities with primary security module.
[ 211.371950] Mount-cache hash table entries: 512
[ 211.372263] Initializing cgroup subsys ns
[ 211.372275] Initializing cgroup subsys cpuacct
[ 211.372299] CPU: After generic identify, caps: 0381b83f 00000000 00000000 00000000 00000000 00000000 00000000 00000000
[ 211.372325] CPU: L1 I Cache: 64K (32 bytes/line), D cache 64K (32 bytes/line)
[ 211.372334] CPU: L2 Cache: 64K (32 bytes/line)
[ 211.372341] CPU: After all inits, caps: 0381b93f 00000000 00000000 00000000 00000000 000000dc 00000000 00000000
[ 211.372372] Compat vDSO mapped to ffffe000.
[ 211.372406] CPU: Centaur VIA Nehemiah stepping 0a
[ 211.372421] Checking 'hlt' instruction... OK.
[ 211.391326] Freeing SMP alternatives: 0k freed
[ 211.391693] Early unpacking initramfs... done
[ 212.808739] ACPI: Core revision 20070126
[ 212.808983] ACPI: Looking for DSDT in initramfs... error, file /DSDT.aml not found.
[ 212.812970] ACPI: setting ELCR to 0200 (from 0e20)
[ 212.816006] net_namespace: 64 bytes
[ 212.816028] Booting paravirtualized kernel on bare hardware
[ 212.817325] Time: 20:11:00 Date: 07/09/08
[ 212.817411] NET: Registered protocol family 16
[ 212.817904] EISA bus registered
[ 212.817927] ACPI: bus type pci registered
[ 212.847799] PCI: PCI BIOS revision 2.10 entry at 0xfb260, last bus=1
[ 212.847807] PCI: Using configuration type 1
[ 212.847838] Setting up standard PCI resources
[ 212.857429] ACPI: EC: Look up EC in DSDT
[ 212.866324] ACPI: Interpreter enabled
[ 212.866336] ACPI: (supports S0 S1 S4 S5)
[ 212.866371] ACPI: Using PIC for interrupt routing
[ 212.876672] ACPI: PCI Root Bridge [PCI0] (0000:00)
[ 212.877268] PCI quirk: region 0400-047f claimed by vt8235 PM
[ 212.877278] PCI quirk: region 0500-050f claimed by vt8235 SMB
[ 212.877693] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[ 212.913422] ACPI: PCI Interrupt Link [LNKA] (IRQs 1 3 4 5 6 7 10 *11 12 14 15)
[ 212.913852] ACPI: PCI Interrupt Link [LNKB] (IRQs 1 3 4 *5 6 7 10 11 12 14 15)
[ 212.914282] ACPI: PCI Interrupt Link [LNKC] (IRQs 1 3 4 5 6 7 *10 11 12 14 15)
[ 212.914711] ACPI: PCI Interrupt Link [LNKD] (IRQs 1 3 4 5 6 7 10 *11 12 14 15)
[ 212.915059] Linux Plug and Play Support v0.97 (c) Adam Belay
[ 212.915138] pnp: PnP ACPI init
[ 212.915162] ACPI: bus type pnp registered
[ 212.922511] pnp: PnP ACPI: found 14 devices
[ 212.922523] ACPI: ACPI bus type pnp unregistered
[ 212.922536] PnPBIOS: Disabled by ACPI PNP
[ 212.923102] PCI: Using ACPI for IRQ routing
[ 212.923113] PCI: If a device doesn't work, try "pci=routeirq". If it helps, post a report
[ 212.991571] NET: Registered protocol family 8
[ 212.991579] NET: Registered protocol family 20
[ 212.991759] AppArmor: AppArmor Filesystem Enabled
[ 212.995556] Time: tsc clocksource has been installed.
[ 213.003663] system 00:00: iomem range 0xf0000-0xf3fff could not be reserved
[ 213.003675] system 00:00: iomem range 0xf4000-0xf7fff could not be reserved
[ 213.003686] system 00:00: iomem range 0xf8000-0xfbfff could not be reserved
[ 213.003696] system 00:00: iomem range 0xfc000-0xfffff could not be reserved
[ 213.003708] system 00:00: iomem range 0x3dff0000-0x3dffffff could not be reserved
[ 213.003720] system 00:00: iomem range 0xffff0000-0xffffffff could not be reserved
[ 213.003731] system 00:00: iomem range 0x0-0x9ffff could not be reserved
[ 213.003742] system 00:00: iomem range 0x100000-0x3dfeffff could not be reserved
[ 213.003753] system 00:00: iomem range 0xfee00000-0xfee00fff has been reserved
[ 213.003765] system 00:00: iomem range 0xfff80000-0xfffeffff has been reserved
[ 213.003788] system 00:02: ioport range 0x400-0x47f has been reserved
[ 213.003798] system 00:02: ioport range 0x500-0x50f has been reserved
[ 213.003824] system 00:03: ioport range 0x4d0-0x4d1 has been reserved
[ 213.034874] PCI: Bridge: 0000:00:01.0
[ 213.034882] IO window: disabled.
[ 213.034895] MEM window: dc000000-ddffffff
[ 213.034904] PREFETCH window: d8000000-dbffffff
[ 213.034934] PCI: Setting latency timer of device 0000:00:01.0 to 64
[ 213.034972] NET: Registered protocol family 2
[ 213.071732] IP route cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 213.072891] TCP established hash table entries: 131072 (order: 8, 1048576 bytes)
[ 213.078481] TCP bind hash table entries: 65536 (order: 6, 262144 bytes)
[ 213.079869] TCP: Hash tables configured (established 131072 bind 65536)
[ 213.079879] TCP reno registered
[ 213.091987] checking if image is initramfs...<7>Switched to high resolution mode on CPU 0
[ 214.358730] it is
[ 215.824064] Freeing initrd memory: 8124k freed
[ 215.825171] audit: initializing netlink socket (disabled)
[ 215.825204] audit(1215634263.532:1): initialized
[ 215.825626] highmem bounce pool size: 64 pages
[ 215.830766] VFS: Disk quotas dquot_6.5.1
[ 215.830864] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 215.831313] io scheduler noop registered
[ 215.831323] io scheduler anticipatory registered
[ 215.831330] io scheduler deadline registered
[ 215.831367] io scheduler cfq registered (default)
[ 215.831392] PCI: VIA PCI bridge detected. Disabling DAC.
[ 215.831481] Boot video device is 0000:01:00.0
[ 215.832110] isapnp: Scanning for PnP cards...
[ 216.186026] isapnp: No Plug & Play device found
[ 216.274450] Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing enabled
[ 216.274658] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[ 216.275303] serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
[ 216.276606] 00:09: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[ 216.277294] 00:0a: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
[ 216.279210] RAMDISK driver initialized: 16 RAM disks of 65536K size 1024 blocksize
[ 216.279426] input: Macintosh mouse button emulation as /devices/virtual/input/input0
[ 216.279684] PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:PS2M] at 0x60,0x64 irq 1,12
[ 216.280105] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 216.280119] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 216.287106] mice: PS/2 mouse device common for all mice
[ 216.287384] EISA: Probing bus 0 at eisa.0
[ 216.287444] EISA: Detected 0 cards.
[ 216.287453] cpuidle: using governor ladder
[ 216.287901] NET: Registered protocol family 1
[ 216.287978] Using IPI Shortcut mode
[ 216.288071] registered taskstats version 1
[ 216.288332] Magic number: 0:420:194
[ 216.288441] hash matches device ttys6
[ 216.288662] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found
[ 216.288670] EDD information not available.
[ 216.290327] Freeing unused kernel memory: 364k freed
[ 216.309612] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[ 218.238302] fuse init (API version 7.9)
[ 218.336572] ACPI: CPU0 (power states: C1[C1] C2[C2])
[ 218.336588] ACPI: Processor [CPU0] (supports 2 throttling states)
[ 218.413059] device-mapper: uevent: version 1.0.3
[ 218.413182] device-mapper: ioctl: 4.12.0-ioctl (2007-10-02) initialised: <email address hidden>
[ 218.490255] md: linear personality registered for level -1
[ 218.511606] md: multipath personality registered for level -4
[ 218.533444] md: raid0 personality registered for level 0
[ 218.556678] md: raid1 personality registered for level 1
[ 218.578441] xor: automatically using best checksumming function: pIII_sse
[ 218.598350] pIII_sse : 2166.000 MB/sec
[ 218.598358] xor: using function: pIII_sse (2166.000 MB/sec)
[ 218.600735] async_tx: api initialized (async)
[ 218.678480] raid6: int32x1 118 MB/s
[ 218.746665] raid6: int32x2 164 MB/s
[ 218.814511] raid6: int32x4 166 MB/s
[ 218.882762] raid6: int32x8 125 MB/s
[ 218.950430] raid6: mmxx1 355 MB/s
[ 219.018324] raid6: mmxx2 493 MB/s
[ 219.086389] raid6: sse1x1 306 MB/s
[ 219.154242] raid6: sse1x2 473 MB/s
[ 219.154249] raid6: using algorithm sse1x2 (473 MB/s)
[ 219.154259] md: raid6 personality registered for level 6
[ 219.154267] md: raid5 personality registered for level 5
[ 219.154274] md: raid4 personality registered for level 4
[ 219.285980] md: raid10 personality registered for level 10
[ 220.662175] usbcore: registered new interface driver usbfs
[ 220.662232] usbcore: registered new interface driver hub
[ 220.704294] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 5
[ 220.704307] PCI: setting IRQ 5 as level-triggered
[ 220.704316] ACPI: PCI Interrupt 0000:00:0d.0[A] -> Link [LNKB] -> GSI 5 (level, low) -> IRQ 5
[ 220.757272] ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[5] MMIO=[de000000-de0007ff] Max Packet=[2048] IR/IT contexts=[4/8]
[ 220.810014] usbcore: registered new device driver usb
[ 220.814408] USB Universal Host Controller Interface driver v3.0
[ 221.336703] via-rhine.c:v1.10-LK1.4.3 2007-03-06 Written by Donald Becker
[ 221.336721] via-rhine: Broken BIOS detected, avoid_D3 enabled.
[ 221.337261] SCSI subsystem initialized
[ 221.494936] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 11
[ 221.494949] PCI: setting IRQ 11 as level-triggered
[ 221.494959] ACPI: PCI Interrupt 0000:00:10.0[A] -> Link [LNKA] -> GSI 11 (level, low) -> IRQ 11
[ 221.494987] uhci_hcd 0000:00:10.0: UHCI Host Controller
[ 221.495711] uhci_hcd 0000:00:10.0: new USB bus registered, assigned bus number 1
[ 221.495759] uhci_hcd 0000:00:10.0: irq 11, io base 0x0000d400
[ 221.496162] usb usb1: configuration #1 chosen from 1 choice
[ 221.496241] hub 1-0:1.0: USB hub found
[ 221.496256] hub 1-0:1.0: 2 ports detected
[ 221.598094] ACPI: PCI Interrupt 0000:00:10.1[B] -> Link [LNKB] -> GSI 5 (level, low) -> IRQ 5
[ 221.598127] uhci_hcd 0000:00:10.1: UHCI Host Controller
[ 221.598200] uhci_hcd 0000:00:10.1: new USB bus registered, assigned bus number 2
[ 221.598241] uhci_hcd 0000:00:10.1: irq 5, io base 0x0000d800
[ 221.598583] usb usb2: configuration #1 chosen from 1 choice
[ 221.598656] hub 2-0:1.0: USB hub found
[ 221.598671] hub 2-0:1.0: 2 ports detected
[ 221.702983] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10
[ 221.702997] PCI: setting IRQ 10 as level-triggered
[ 221.703006] ACPI: PCI Interrupt 0000:00:10.2[C] -> Link [LNKC] -> GSI 10 (level, low) -> IRQ 10
[ 221.703033] uhci_hcd 0000:00:10.2: UHCI Host Controller
[ 221.703111] uhci_hcd 0000:00:10.2: new USB bus registered, assigned bus number 3
[ 221.703157] uhci_hcd 0000:00:10.2: irq 10, io base 0x0000dc00
[ 221.703502] usb usb3: configuration #1 chosen from 1 choice
[ 221.703566] hub 3-0:1.0: USB hub found
[ 221.703581] hub 3-0:1.0: 2 ports detected
[ 221.757774] libata version 3.00 loaded.
[ 221.807315] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
[ 221.807329] ACPI: PCI Interrupt 0000:00:10.3[D] -> Link [LNKD] -> GSI 11 (level, low) -> IRQ 11
[ 221.807363] ehci_hcd 0000:00:10.3: EHCI Host Controller
[ 221.807453] ehci_hcd 0000:00:10.3: new USB bus registered, assigned bus number 4
[ 221.807549] ehci_hcd 0000:00:10.3: irq 11, io mem 0xde001000
[ 221.817731] ehci_hcd 0000:00:10.3: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
[ 221.818084] usb usb4: configuration #1 chosen from 1 choice
[ 221.818151] hub 4-0:1.0: USB hub found
[ 221.818169] hub 4-0:1.0: 6 ports detected
[ 221.922275] ACPI: PCI Interrupt 0000:00:12.0[A] -> Link [LNKA] -> GSI 11 (level, low) -> IRQ 11
[ 221.926936] eth0: VIA Rhine II at 0xde002000, 00:40:63:e8:97:83, IRQ 11.
[ 221.927655] eth0: MII PHY found at address 1, status 0x7869 advertising 05e1 Link 45e1.
[ 221.940702] ACPI: PCI Interrupt 0000:00:11.1[A] -> Link [LNKA] -> GSI 11 (level, low) -> IRQ 11
[ 221.940723] PCI: VIA VLink IRQ fixup for 0000:00:11.1, from 255 to 11
[ 221.940851] ACPI: PCI interrupt for device 0000:00:11.1 disabled
[ 221.993931] pata_via 0000:00:11.1: version 0.3.3
[ 221.993983] ACPI: PCI Interrupt 0000:00:11.1[A] -> Link [LNKA] -> GSI 11 (level, low) -> IRQ 11
[ 221.994000] PCI: VIA VLink IRQ fixup for 0000:00:11.1, from 255 to 11
[ 222.044702] scsi0 : pata_via
[ 222.085037] scsi1 : pata_via
[ 222.089334] ata1: PATA max UDMA/133 cmd 0x1f0 ctl 0x3f6 bmdma 0xe000 irq 14
[ 222.089347] ata2: PATA max UDMA/133 cmd 0x170 ctl 0x376 bmdma 0xe008 irq 15
[ 222.569329] FDC 0 is a post-1991 82077
[ 222.574139] ata2.00: ATAPI: MATSHITADVD-RAM UJ-845S, D100, max UDMA/33
[ 222.605598] usb 4-4: new high speed USB device using ehci_hcd and address 2
[ 222.746036] ata2.00: configured for UDMA/33
[ 222.747842] scsi 1:0:0:0: CD-ROM MATSHITA DVD-RAM UJ-845S D100 PQ: 0 ANSI: 5
[ 222.749206] usb 4-4: configuration #1 chosen from 1 choice
[ 222.749773] hub 4-0:1.0: over-current change on port 5
[ 222.771997] ieee1394: Node added: ID:BUS[0-00:1023] GUID[0030e002e0718793]
[ 222.772196] ieee1394: Host added: ID:BUS[0-01:1023] GUID[0040635000083473]
[ 224.838842] Driver 'sr' needs updating - please use bus_type methods
[ 224.856936] sr0: scsi3-mmc drive: 24x/24x writer dvd-ram cd/rw xa/form2 cdda caddy
[ 224.856954] Uniform CD-ROM driver Revision: 3.20
[ 224.857171] sr 1:0:0:0: Attached scsi CD-ROM sr0
[ 224.881415] sr 1:0:0:0: Attached scsi generic sg0 type 5
[ 224.990105] usbcore: registered new interface driver libusual
[ 225.008173] Initializing USB Mass Storage driver...
[ 225.035245] scsi2 : SCSI emulation for USB Mass Storage devices
[ 225.037207] usbcore: registered new interface driver usb-storage
[ 225.037226] USB Mass Storage support registered.
[ 225.037539] usb-storage: device found at 2
[ 225.037546] usb-storage: waiting for device to settle before scanning
[ 225.090323] scsi3 : SBP-2 IEEE-1394
[ 226.471922] ieee1394: sbp2: Logged into SBP-2 device
[ 226.473535] ieee1394: sbp2: Node 0-00:1023: Max speed [S400] - Max payload [2048]
[ 226.479418] scsi 3:0:0:0: Direct-Access Ext Hard Disk PQ: 0 ANSI: 4
[ 226.479634] scsi 3:0:0:0: Attached scsi generic sg1 type 0
[ 226.500997] Driver 'sd' needs updating - please use bus_type methods
[ 226.505790] sd 3:0:0:0: [sda] 234441648 512-byte hardware sectors (120034 MB)
[ 226.509505] sd 3:0:0:0: [sda] Write Protect is off
[ 226.509522] sd 3:0:0:0: [sda] Mode Sense: 10 00 00 00
[ 226.511818] sd 3:0:0:0: [sda] Cache data unavailable
[ 226.511831] sd 3:0:0:0: [sda] Assuming drive cache: write through
[ 226.516660] sd 3:0:0:0: [sda] 234441648 512-byte hardware sectors (120034 MB)
[ 226.519607] sd 3:0:0:0: [sda] Write Protect is off
[ 226.519617] sd 3:0:0:0: [sda] Mode Sense: 10 00 00 00
[ 226.521946] sd 3:0:0:0: [sda] Cache data unavailable
[ 226.521954] sd 3:0:0:0: [sda] Assuming drive cache: write through
[ 226.521968] sda: sda1 sda2 sda3 sda4 < sda5 sda6 sda7 >
[ 226.967281] sd 3:0:0:0: [sda] Attached SCSI disk
[ 227.552849] EXT3-fs: INFO: recovery required on readonly filesystem.
[ 227.552864] EXT3-fs: write access will be enabled during recovery.
[ 228.215978] kjournald starting. Commit interval 5 seconds
[ 228.216026] EXT3-fs: sda3: orphan cleanup on readonly fs
[ 228.216044] ext3_orphan_cleanup: deleting unreferenced inode 753687
[ 228.216111] EXT3-fs: sda3: 1 orphan inode deleted
[ 228.216117] EXT3-fs: recovery complete.
[ 228.225297] EXT3-fs: mounted filesystem with ordered data mode.
[ 230.036424] usb-storage: device scan complete
[ 230.037553] scsi 2:0:0:0: Direct-Access BLANK Patriot Memory PMAP PQ: 0 ANSI: 0 CCS
[ 230.039733] sd 2:0:0:0: [sdb] 2015232 512-byte hardware sectors (1032 MB)
[ 230.040355] sd 2:0:0:0: [sdb] Write Protect is off
[ 230.040364] sd 2:0:0:0: [sdb] Mode Sense: 23 00 00 00
[ 230.040372] sd 2:0:0:0: [sdb] Assuming drive cache: write through
[ 230.043998] sd 2:0:0:0: [sdb] 2015232 512-byte hardware sectors (1032 MB)
[ 230.044606] sd 2:0:0:0: [sdb] Write Protect is off
[ 230.044616] sd 2:0:0:0: [sdb] Mode Sense: 23 00 00 00
[ 230.044624] sd 2:0:0:0: [sdb] Assuming drive cache: write through
[ 230.044637] sdb: sdb1 sdb2
[ 230.045580] sd 2:0:0:0: [sdb] Attached SCSI removable disk
[ 230.045688] sd 2:0:0:0: Attached scsi generic sg2 type 0
[ 246.559758] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[ 246.603668] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[ 247.027559] Linux agpgart interface v0.102
[ 247.107082] agpgart: Detected VIA CLE266 chipset
[ 247.256856] agpgart: AGP aperture is 128M @ 0xd0000000
[ 247.318842] irda_init()
[ 247.318885] NET: Registered protocol family 23
[ 247.737852] input: PC Speaker as /devices/platform/pcspkr/input/input2
[ 250.066278] eth0: link up, 100Mbps, full-duplex, lpa 0x45E1
[ 250.543336] ACPI: PCI Interrupt 0000:01:00.0[A] -> Link [LNKA] -> GSI 11 (level, low) -> IRQ 11
[ 250.546576] input: Power Button (FF) as /devices/virtual/input/input3
[ 250.563946] ACPI: Power Button (FF) [PWRF]
[ 250.564269] input: Power Button (CM) as /devices/virtual/input/input4
[ 250.647744] ACPI: Power Button (CM) [PWRB]
[ 251.924298] Console: switching to colour frame buffer device 80x30
[ 251.924329] fb0: VIA VT8623 on 0000:01:00.0, 32 MB RAM
[ 253.177038] input: PS/2 Generic Mouse as /devices/platform/i8042/serio1/input/input5
[ 256.210981] NET: Registered protocol family 10
[ 256.211580] lo: Disabled Privacy Extensions
[ 257.418638] Real Time Clock Driver v1.12ac
[ 257.886554] ACPI: PCI Interrupt 0000:00:11.5[C] -> Link [LNKC] -> GSI 10 (level, low) -> IRQ 10
[ 257.886718] PCI: Setting latency timer of device 0000:00:11.5 to 64
[ 259.636811] parport_pc 00:0b: reported by Plug and Play ACPI
[ 259.636851] parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE,EPP]
[ 266.717063] eth0: no IPv6 routers present
[ 267.277849] lp0: using parport0 (interrupt-driven).
[ 267.769567] Adding 1558264k swap on /dev/sda1. Priority:-1 extents:1 across:1558264k
[ 268.500873] EXT3 FS on sda3, internal journal
[ 271.362423] kjournald starting. Commit interval 5 seconds
[ 271.362838] EXT3 FS on sda5, internal journal
[ 271.362851] EXT3-fs: mounted filesystem with ordered data mode.
[ 271.387749] kjournald starting. Commit interval 5 seconds
[ 271.388189] EXT3 FS on sda6, internal journal
[ 271.388202] EXT3-fs: mounted filesystem with ordered data mode.
[ 271.410252] kjournald starting. Commit interval 5 seconds
[ 271.410710] EXT3 FS on sda7, internal journal
[ 271.410723] EXT3-fs: mounted filesystem with ordered data mode.
[ 272.768678] ip_tables: (C) 2000-2006 Netfilter Core Team
[ 275.131646] NET: Registered protocol family 17
[ 282.297153] No dock devices found.
[ 283.801045] longhaul: VIA C3 'Nehemiah C' [C5P] CPU detected. Powersaver supported.
[ 283.801084] longhaul: ACPI I/O at 0x400
[ 283.801124] longhaul: Using northbridge support.
[ 283.801130] longhaul: Using ACPI support.
[ 288.545618] ppdev: user-space parallel port driver
[ 288.840852] audit(1215634336.888:2): type=1503 operation="inode_permission" requested_mask="a::" denied_mask="a::" name="/dev/tty" pid=5311 profile="/usr/sbin/cupsd" namespace="default"
[ 289.048729] [drm] Initialized drm 1.1.0 20060810
[ 289.067561] [drm] Initialized via 2.11.1 20070202 on minor 0
[ 289.099322] agpgart: Found an AGP 2.0 compliant device at 0000:00:00.0.
[ 289.099363] agpgart: Putting AGP V2 device at 0000:00:00.0 into 4x mode
[ 289.099432] agpgart: Putting AGP V2 device at 0000:01:00.0 into 4x mode
[ 289.162942] apm: BIOS version 1.2 Flags 0x07 (Driver version 1.16ac)
[ 289.162958] apm: overridden by ACPI.
[ 552.647708] Marking TSC unstable due to: cpufreq changes.
[ 552.650949] Time: acpi_pm clocksource has been installed.
[ 295.236596] Clocksource tsc unstable (delta = -226039516 ns)

[Brian Candler (b-candler)]

Digging around some more, it seems I *do* have acceleration enabled.

$ glxinfo | grep render
direct rendering: Yes
OpenGL renderer string: Mesa DRI CastleRock (CLE266) 20060710 x86/MMX/SSE

$ dpkg-query -l | egrep -i '(chrome|via display)'
ii libchromexvmc1 1:0.2.901-0ubuntu4 XvMC Libraries used by the Openchrome VIA dr
ii libchromexvmcpro1 1:0.2.901-0ubuntu4 XvMC Pro Libraries used by the Openchrome VI
ii xserver-xorg-video-openchrome 1:0.2.901-0ubuntu4 X.Org X server -- VIA display driver
ii xserver-xorg-video-via 1:0.2.2-5 X.Org X server -- VIA display driver

I've also attached Xorg.0.log, there are a number of CHROME(0) messages in there.

I can't see any hints relating to the crashes though:

# tail /var/log/Xorg.*
==> /var/log/Xorg.0.log <==
(II) CHROME(0): VIALoadPalette
(II) CHROME(0): VIALoadRgbLut
(II) CHROME(0): VIALoadPalette
(II) CHROME(0): VIALoadRgbLut
SetGrabKeysState - disabled
(II) CHROME(0): VIALoadPalette
(II) CHROME(0): VIALoadRgbLut
(II) CHROME(0): VIALoadPalette
(II) CHROME(0): VIALoadRgbLut
SetGrabKeysState - enabled

==> /var/log/Xorg.0.log.old <==
(II) CHROME(0): [drm] Releasing agp module
(II) CHROME(0): [drm] removed 1 reserved context for kernel
(II) CHROME(0): [drm] unmapping 8192 bytes of SAREA 0xfdd55000 at 0xb5a5b000
(II) CHROME(0): [drm] Closed DRM master.
Freed 19266560 (pool 1)
(II) CHROME(0): [drm] Irq handler uninstalled.
(II) CHROME(0): VIARestore
(II) CHROME(0): VT162xRestore
(II) CHROME(0): ViaDisablePrimaryFIFO
(II) CHROME(0): VIAUnmapMem

==> /var/log/Xorg.20.log <==
(II) CHROME(0): VIALoadRgbLut
(II) CHROME(0): VIALoadPalette
(II) CHROME(0): VIALoadRgbLut
SetGrabKeysState - enabled
(II) CHROME(0): VIALeaveVT
(II) CHROME(0): ViaCursorStore
(II) CHROME(0): VIARestore
(II) CHROME(0): VT162xRestore
(II) CHROME(0): ViaDisablePrimaryFIFO
SetGrabKeysState - disabled

==> /var/log/Xorg.20.log.old <==
(II) CHROME(0): VIALoadRgbLut
(II) CHROME(0): VIALoadPalette
(II) CHROME(0): VIALoadRgbLut
SetGrabKeysState - enabled
(II) CHROME(0): VIALeaveVT
(II) CHROME(0): ViaCursorStore
(II) CHROME(0): VIARestore
(II) CHROME(0): VT162xRestore
(II) CHROME(0): ViaDisablePrimaryFIFO
SetGrabKeysState - disabled

[Brian Candler (b-candler)]

Set package to "xserver-xorg-video-openchrome"

[Brian Candler (b-candler)]

Based on an old posting I found I added the following to /etc/X11/xorg.conf and have been unable to reproduce the crash. Presumably my graphics performance is reduced though.

Section "Module"
    Disable "glx"
    Disable "xtrap"
    Disable "record"
    Disable "GLcore"
    Disable "dri"
EndSection

[Bryce Harrington (bryce)]

Hi b-candler,

Thank you for taking the time to report this bug and helping to make Ubuntu better. You reported this bug a while ago and there hasn't been any activity in it recently. We were wondering is this still an issue for you? Can you try with the latest development release of Ubuntu? (ISOs are available from cdimage.ubuntu.com)

If it remains an issue, could you also attach a new /var/log/Xorg.0.log?
Thanks in advance.

The output of lspci -vvnn would also be worth having.

[Brian Candler (b-candler)]

Last night I tried booting from an Intrepid CD, and switching consoles a few times I wasn't able to replicate the problem. lsmod and X.org.log suggested that the via, openchrome and DRI stuff was in use.

However I don't suppose I'll know for sure unless I actually perform an upgrade to Intrepid, which would take me off the LTS track. I'll have to think about this :-)

The lspci -vvnn output is attached.

[Bryce Harrington (bryce)]

Okay, from that testing it sounds like maybe the issue is gone. I'll go ahead and close the development task; you can reopen if you test Jaunty and find the problem is still there.

Unfortunately, I don't think the fix is something we could backport, but I'll set up a hardy task anyway, in case someone would like to investigate doing that.

[Rolf Leggewie (r0lf)]

Hardy has seen the end of its life and is no longer receiving any updates. Marking the Hardy task for this ticket as "Won't Fix".