Bug#689748: More info, lock-ups sometimes not as severe
Hello again,
Something has changed after the latest upgrade of the nouveau driver.
Whereas before the machine wouldn't even turn off unless the power button
was held for about 10 seconds, it is now the case that (sometimes) a quick
press of the off button is caught and the machine shuts down cleanly.
This is a message that briefly flashed on the screen at shutdown:
Feb 21 17:48:57 tashi kernel: [ 9047.464022] [drm] nouveau 0000:01:00.0: Failed to idle channel 1.
The GPU lock up is now detected at some point, but the keyboard remains
locked. It is not possible to switch to text consoles (<CTL><ALT><Fn>).
Feb 21 17:47:58 tashi kernel: [ 9000.959527] [drm] nouveau 0000:01:00.0: GPU lockup - switching to software fbcon
These messages are also recorded in the syslog file, whose nouveau outout
is appended below.
I have also noticed that every time I've done the following, the system has
locked up:
o open a pdf document with evince (I've only tried it with one document).
o hit the down arrow to scroll down a few times in quick succession
o immediate lock up
Clicking on the scroll bar down arrow slowly doesn't cause a lock up.
I have also noticed that lock ups are more frequent now. Whereas before they
happened mostly when moving large windows, now they also happen when
uncovering windows, switching desktops and doing other operations, like
clicking on a pull-down menu.
The illegible font issue has now also been detected in evince while trying
to read a pdf file generated by a major institution. This could be an issue
with evince and not recognizing some not-quite-standard encoding, but since
that issue has also appeared in other software (gbuffy and xtide that I can
remember - see the previous emails in this bug report) I wonder if this is
not related to the nouveau driver issue or other X/font lib.
Regarding the requested tests: I now have a new HD on which I intend to do
a clean installation (I don't want to risk making this one unusable) and try
the 3.7 kernel as well as simple Xorg config files, but I haven't been able
to do so yet because the bios screen doesn't display. The first messages I
see are generated by the kernel after (presumably) the nouveau driver has
done something to the nvidia hardware. Using a secondary screen on the vga
port, I can see the bios screen, but this means I need to also carry around
a secondary screen. <Fn><F8> (CRT/LCD switchover key) does nothing.
Furthermore, the wireless card needs a proprietary binary blob and the
install image I have on a flash drive can't seem to find it (I've copied
it to another flash drive). At the moment I don't have access to a
hard-wired network that would use ethernet drivers available in the
distribution. So, long-winded explanation to basically say that
I'll keep at it and eventually do those tests, but under the present
circumstances it might take a while.
This is the syslog section that contains the nouveau messages generated during
the power-off shutdown:
Feb 21 17:47:58 tashi kernel: [ 9000.068504] [drm] nouveau 0000:01:00.0: Calling LVDS script 6:
Feb 21 17:47:58 tashi kernel: [ 9000.068516] [drm] nouveau 0000:01:00.0: 0xDACF: Parsing digital output script table
Feb 21 17:47:58 tashi kernel: [ 9000.654479] [drm] nouveau 0000:01:00.0: Calling LVDS script 2:
Feb 21 17:47:58 tashi kernel: [ 9000.654489] [drm] nouveau 0000:01:00.0: 0xDAFE: Parsing digital output script table
Feb 21 17:47:58 tashi kernel: [ 9000.670382] [drm] nouveau 0000:01:00.0: Calling LVDS script 5:
Feb 21 17:47:58 tashi kernel: [ 9000.670390] [drm] nouveau 0000:01:00.0: 0xDA48: Parsing digital output script table
Feb 21 17:47:58 tashi kernel: [ 9000.959527] [drm] nouveau 0000:01:00.0: GPU lockup - switching to software fbcon
Feb 21 17:48:02 tashi kernel: [ 9004.064024] [drm] nouveau 0000:01:00.0: Failed to idle channel 1.
Feb 21 17:48:02 tashi kernel: [ 9004.068011] [drm] nouveau 0000:01:00.0: PGRAPH idle timed out with status 0x00021001
Feb 21 17:48:02 tashi kernel: [ 9005.107534] sched: RT throttling activated
Feb 21 17:48:02 tashi kdm[2241]: X server for display :0 terminated unexpectedly
Feb 21 17:48:04 tashi shutdown[9681]: shutting down for system halt
Feb 21 17:48:09 tashi init: Switching to runlevel: 0
Feb 21 17:48:09 tashi acpid: client 2267[0:0] has disconnected
Feb 21 17:48:09 tashi acpid: client connected from 9700[0:0]
Feb 21 17:48:09 tashi acpid: 1 client rule loaded
Feb 21 17:48:10 tashi kernel: [ 9012.484022] [drm] nouveau 0000:01:00.0: PGRAPH idle timed out with status 0x00021001
Feb 21 17:48:12 tashi kernel: [ 9014.072026] [drm] nouveau 0000:01:00.0: PGRAPH idle timed out with status 0x00021001
Feb 21 17:48:13 tashi kernel: [ 9015.207825] [drm] nouveau 0000:01:00.0: Calling LVDS script 6:
Feb 21 17:48:13 tashi kernel: [ 9015.207834] [drm] nouveau 0000:01:00.0: 0xDACF: Parsing digital output script table
Feb 21 17:48:13 tashi kernel: [ 9015.793662] [drm] nouveau 0000:01:00.0: Calling LVDS script 2:
Feb 21 17:48:13 tashi kernel: [ 9015.793667] [drm] nouveau 0000:01:00.0: 0xDAFE: Parsing digital output script table
Feb 21 17:48:13 tashi kernel: [ 9015.809551] [drm] nouveau 0000:01:00.0: Calling LVDS script 5:
Feb 21 17:48:13 tashi kernel: [ 9015.809556] [drm] nouveau 0000:01:00.0: 0xDA48: Parsing digital output script table
Feb 21 17:48:20 tashi kernel: [ 9020.356023] [drm] nouveau 0000:01:00.0: Failed to idle channel 1.
Feb 21 17:48:20 tashi kernel: [ 9023.356022] [drm] nouveau 0000:01:00.0: Failed to idle channel 1.
Feb 21 17:48:26 tashi kernel: [ 9026.356021] [drm] nouveau 0000:01:00.0: Failed to idle channel 1.
Feb 21 17:48:26 tashi kernel: [ 9029.356022] [drm] nouveau 0000:01:00.0: Failed to idle channel 1.
Feb 21 17:48:29 tashi kernel: [ 9032.360022] [drm] nouveau 0000:01:00.0: Failed to idle channel 1.
Feb 21 17:48:35 tashi kernel: [ 9035.464021] [drm] nouveau 0000:01:00.0: Failed to idle channel 1.
Feb 21 17:48:35 tashi kernel: [ 9038.464022] [drm] nouveau 0000:01:00.0: Failed to idle channel 1.
Feb 21 17:48:38 tashi kernel: [ 9038.464692] ata2.00: qc timeout (cmd 0xa0)
Feb 21 17:48:53 tashi sensord: Chip: acpitz-virtual-0
Feb 21 17:48:57 tashi sensord: Adapter: Virtual device
Feb 21 17:48:57 tashi sensord: temp1: 56.5 C
Feb 21 17:48:57 tashi smartd[3756]: Device: /dev/sda [SAT], SMART Usage Attribute: 194 Temperature_Celsius changed from 98 to 99
Feb 21 17:48:57 tashi kernel: [ 9038.464714] ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
Feb 21 17:48:57 tashi kernel: [ 9038.464721] sr 1:0:0:0: CDB: Test Unit Ready: 00 00 00 00 00 00
Feb 21 17:48:57 tashi kernel: [ 9038.464738] ata2.00: cmd a0/00:00:00:00:00/00:00:00:00:00/a0 tag 0
Feb 21 17:48:57 tashi kernel: [ 9038.464740] res 51/20:03:00:00:00/00:00:00:00:00/a0 Emask 0x5 (timeout)
Feb 21 17:48:57 tashi kernel: [ 9038.464745] ata2.00: status: { DRDY ERR }
Feb 21 17:48:57 tashi kernel: [ 9038.464782] ata2: soft resetting link
Feb 21 17:48:57 tashi kernel: [ 9041.464020] [drm] nouveau 0000:01:00.0: Failed to idle channel 1.
Feb 21 17:48:57 tashi kernel: [ 9044.464022] [drm] nouveau 0000:01:00.0: Failed to idle channel 1.
Feb 21 17:48:57 tashi kernel: [ 9047.464022] [drm] nouveau 0000:01:00.0: Failed to idle channel 1.
Feb 21 17:48:57 tashi kernel: [ 9047.464554] ata2.00: qc timeout (cmd 0xa1)
Feb 21 17:48:57 tashi kernel: [ 9047.464561] ata2.00: failed to IDENTIFY (I/O error, err_mask=0x4)
Feb 21 17:48:57 tashi kernel: [ 9047.464566] ata2.00: revalidation failed (errno=-5)
Feb 21 17:48:57 tashi kernel: [ 9047.464596] ata2: soft resetting link
Feb 21 17:48:57 tashi kernel: [ 9050.472021] [drm] nouveau 0000:01:00.0: Failed to idle channel 1.
Feb 21 17:48:57 tashi kernel: [ 9053.472020] [drm] nouveau 0000:01:00.0: Failed to idle channel 1.
Feb 21 17:48:57 tashi kernel: [ 9056.476022] [drm] nouveau 0000:01:00.0: Failed to idle channel 1.
Feb 21 17:48:57 tashi kernel: [ 9059.476021] [drm] nouveau 0000:01:00.0: Failed to idle channel 1.
Feb 21 17:48:57 tashi kernel: [ 9059.478057] ata2.00: configured for UDMA/33
Feb 21 17:48:57 tashi kernel: [ 9059.616671] [drm] nouveau 0000:01:00.0: Calling LVDS script 6:
Feb 21 17:48:57 tashi kernel: [ 9059.616678] [drm] nouveau 0000:01:00.0: 0xDACF: Parsing digital output script table
Feb 21 17:48:57 tashi kernel: [ 9060.202496] [drm] nouveau 0000:01:00.0: Calling LVDS script 2:
Feb 21 17:48:57 tashi kernel: [ 9060.202501] [drm] nouveau 0000:01:00.0: 0xDAFE: Parsing digital output script table
Feb 21 17:48:57 tashi kernel: [ 9060.218385] [drm] nouveau 0000:01:00.0: Calling LVDS script 5:
Feb 21 17:48:57 tashi kernel: [ 9060.218389] [drm] nouveau 0000:01:00.0: 0xDA48: Parsing digital output script table
Feb 21 17:48:57 tashi kernel: [ 9060.437059] ata2: EH complete
Feb 21 17:49:00 tashi kernel: [ 9062.867779] Bluetooth: RFCOMM TTY layer initialized
Reply to: