More problems with xorg

[Paul Schmehl]

--On Wednesday, March 29, 2006 16:54:21 -0600 Paul Schmehl 
<pauls at utdallas.edu> wrote:

> Now that I finally got xinerama working again (by using MergeFB as an
> Option for my Radeon card), another problem has cropped up.  The
> screensaver isn't running, and when I lock the workstation, I can't get a
> prompt to unlock.  The screen goes to the unlock screen with no prompt.
>
I should have included this:
 uname -a
FreeBSD hostname.utdallas.edu 6.0-SECURITY FreeBSD 6.0-SECURITY #0: Tue Feb 
28 22:53:43 UTC 2006 
root at builder.daemonology.net:/usr/obj/usr/src/sys/GENERIC i386

Xorg -version

X Window System Version 6.9.0
Release Date: 21 December 2005
X Protocol Version 11, Revision 0, Release 6.9
Build Operating System: FreeBSD 6.0 i386 [ELF]

I enabled debug.  Here's the output of a restart (Ctrl-Alt-Backspace):
Mar 29 17:03:12 utd59514 gdm[673]: Got XPID == 0
Mar 29 17:03:12 utd59514 gdm[1619]: gdm_server_start: After mainloop 
waiting for server
Mar 29 17:03:12 utd59514 gdm[1619]: Error reinitilizing server
Mar 29 17:03:12 utd59514 gdm[1619]: gdm_slave_quick_exit: Will kill 
everything from the display
Mar 29 17:03:12 utd59514 gdm[1619]: gdm_slave_quick_exit: Killed everything 
from the display
Mar 29 17:03:12 utd59514 gdm[673]: mainloop_sig_callback: Got signal 20
Mar 29 17:03:12 utd59514 gdm[673]: gdm_cleanup_children: child 1619 
returned 2
Mar 29 17:03:12 utd59514 gdm[673]: gdm_child_action: In remanage
Mar 29 17:03:12 utd59514 gdm[673]: gdm_display_manage: Managing :0
Mar 29 17:03:12 utd59514 gdm[673]: loop check: last_start 1143673293, 
last_loop
1143673293, now: 1143673392, retry_count: 1
Mar 29 17:03:12 utd59514 gdm[673]: Resetting counts for loop of death 
detection, 90 seconds elapsed since loop started or session lasted more 
then 30 seconds.
Mar 29 17:03:12 utd59514 gdm[673]: gdm_display_manage: Forked slave: 1707
Mar 29 17:03:12 utd59514 gdm[1707]: gdm_slave_start: Starting slave process 
for
:0
Mar 29 17:03:12 utd59514 gdm[1707]: gdm_slave_start: Loop Thingie
Mar 29 17:03:12 utd59514 gdm[1707]: gdm_slave_run: Sleeping 1 seconds 
before server start
Mar 29 17:03:13 utd59514 gdm[1707]: Sending VT_NUM == -1 for slave 1707
Mar 29 17:03:13 utd59514 gdm[673]: Handling message: 'VT_NUM 1707 -1'
Mar 29 17:03:13 utd59514 gdm[673]: Got VT_NUM == -1
Mar 29 17:03:13 utd59514 gdm[1707]: gdm_server_start: :0
Mar 29 17:03:13 utd59514 gdm[1707]: gdm_auth_secure_display: Setting up 
access for :0
Mar 29 17:03:13 utd59514 gdm[1707]: gdm_auth_secure_display: Setting up 
access
Mar 29 17:03:13 utd59514 gdm[1707]: gdm_auth_secure_display: Setting up 
access for :0 - 1 entries
Mar 29 17:03:13 utd59514 gdm[1707]: Sending COOKIE == <secret> for slave 
1707
Mar 29 17:03:13 utd59514 gdm[673]: Handling message: 'COOKIE 1707 fc...'
Mar 29 17:03:13 utd59514 gdm[673]: Got COOKIE == <secret>
Mar 29 17:03:13 utd59514 gdm[1707]: Sending AUTHFILE == <secret> for slave 
1707
Mar 29 17:03:13 utd59514 gdm[673]: Handling message: 'AUTHFILE 1707 
/var/gdm/:0.Xauth'
Mar 29 17:03:13 utd59514 gdm[673]: Got AUTHFILE == /var/gdm/:0.Xauth
Mar 29 17:03:13 utd59514 gdm[1707]: gdm_server_spawn: Forked server on pid 
1708
Mar 29 17:03:13 utd59514 gdm[1708]: gdm_server_spawn: '/usr/X11R6/bin/X :0 
-audit 0 -auth /var/gdm/:0.Xauth -nolisten tcp vt9'
Mar 29 17:03:13 utd59514 gdm[1707]: do_server_wait: Before mainloop waiting 
for
server
Mar 29 17:03:13 utd59514 gdm[1707]: gdm_server_start: After mainloop 
waiting for server
Mar 29 17:03:13 utd59514 gdm[1707]: gdm_server_start: Completed :0!
Mar 29 17:03:13 utd59514 gdm[1707]: Sending VT_NUM == 9 for slave 1707
Mar 29 17:03:13 utd59514 gdm[673]: Handling message: 'VT_NUM 1707 9'
Mar 29 17:03:13 utd59514 gdm[673]: Got VT_NUM == 9
Mar 29 17:03:13 utd59514 gdm[1707]: Sending XPID == 1708 for slave 1707
Mar 29 17:03:13 utd59514 gdm[673]: Handling message: 'XPID 1707 1708'
Mar 29 17:03:13 utd59514 gdm[673]: Got XPID == 1708
Mar 29 17:03:13 utd59514 gdm[1707]: gdm_slave_run: Opening display :0
Mar 29 17:03:15 utd59514 gdm[673]: Handling message: 'START_NEXT_LOCAL'
Mar 29 17:03:15 utd59514 gdm[1707]: gdm_slave_greeter: Running greeter on :0
Mar 29 17:03:15 utd59514 gdm[1707]: gdm_slave_greeter: Greeter on pid 1716
Mar 29 17:03:15 utd59514 gdm[1707]: Sending GREETPID == 1716 for slave 1707
Mar 29 17:03:15 utd59514 gdm[673]: Handling message: 'GREETPID 1707 1716'
Mar 29 17:03:15 utd59514 gdm[673]: Got GREETPID == 1716
Mar 29 17:03:15 utd59514 gdm[673]: gdm_socket_handler: Accepting new 
connection
fd 7
Mar 29 17:03:15 utd59514 gdm[673]: Handling user message: 'VERSION'
Mar 29 17:03:15 utd59514 gdm[673]: Handling user message: 'GET_CONFIG_FILE'
Mar 29 17:03:15 utd59514 gdm[673]: Handling user message: 'CLOSE'
Mar 29 17:03:15 utd59514 gdm[1707]: gdm_slave_wait_for_login: In loop
Mar 29 17:03:24 utd59514 gdm[1707]: Sending QUERYLOGIN == <secret> for 
slave 1707
Mar 29 17:03:24 utd59514 gdm[673]: Handling message: 'QUERYLOGIN 1707 pauls'
Mar 29 17:03:24 utd59514 gdm[673]: Got QUERYLOGIN pauls
Mar 29 17:03:24 utd59514 gdm[1707]: gdm_slave_wait_for_login: end verify 
for 'pauls'
Mar 29 17:03:24 utd59514 gdm[1707]: gdm_slave_wait_for_login: got_login for 
'pauls'
Mar 29 17:03:24 utd59514 gdm[1707]: Sending LOGGED_IN == 1 for slave 1707
Mar 29 17:03:24 utd59514 gdm[673]: Handling message: 'LOGGED_IN 1707 1'
Mar 29 17:03:24 utd59514 gdm[673]: Got logged in == TRUE
Mar 29 17:03:24 utd59514 gdm[1707]: Sending LOGIN == <secret> for slave 1707
Mar 29 17:03:24 utd59514 gdm[673]: Handling message: 'LOGIN 1707 pauls'
Mar 29 17:03:24 utd59514 gdm[673]: Got LOGIN == pauls
Mar 29 17:03:24 utd59514 gdm[1707]: gdm_slave_session_start: Attempting 
session
for user 'pauls'
Mar 29 17:03:24 utd59514 gdm[1707]: Initial setting: session: 'gdm' 
language: ''Mar 29 17:03:24 utd59514 gdm[1707]: gdm_slave_session_start: 
Authentication completed. Whacking greeter
Mar 29 17:03:24 utd59514 gdm[1707]: slave_waitpid: waiting on 1716
Mar 29 17:03:24 utd59514 gdm[1707]: slave_waitpid: done_waiting
Mar 29 17:03:24 utd59514 gdm[1707]: Sending GREETPID == 0 for slave 1707
Mar 29 17:03:24 utd59514 gdm[673]: Handling message: 'GREETPID 1707 0'
Mar 29 17:03:24 utd59514 gdm[673]: Got GREETPID == 0
Mar 29 17:03:24 utd59514 gdm[1707]: gdm_auth_user_add: Adding cookie for 
1001
Mar 29 17:03:24 utd59514 gdm[1707]: get_local_auths: Setting up socket 
access
Mar 29 17:03:24 utd59514 gdm[1707]: get_local_auths: Setting up network 
access
Mar 29 17:03:24 utd59514 gdm[1707]: get_local_auths: Setting up access for 
:0 -
2 entries
Mar 29 17:03:24 utd59514 gdm[1707]: gdm_auth_user_add: Using 
/home/pauls/.Xauthority for cookies
Mar 29 17:03:24 utd59514 gdm[1707]: gdm_auth_purge: :0
Mar 29 17:03:24 utd59514 gdm[1707]: gdm_auth_user_add: Done
Mar 29 17:03:24 utd59514 gdm[1707]: Sending WRITE_X_SERVERS == 0 for slave 
1707
Mar 29 17:03:24 utd59514 gdm[673]: Handling message: 'WRITE_X_SERVERS 1707 
0'
Mar 29 17:03:24 utd59514 gdm[1707]: Sending SESSPID == 1717 for slave 1707
Mar 29 17:03:24 utd59514 gdm[673]: Handling message: 'SESSPID 1707 1717'
Mar 29 17:03:24 utd59514 gdm[673]: Got SESSPID == 1717
Mar 29 17:03:24 utd59514 gdm[1707]: slave_waitpid: waiting on 1717
Mar 29 17:03:24 utd59514 gdm[1717]: Running /usr/X11R6/etc/gdm/Xsession 
/usr/local/bin/dbus-launch --exit-with-session /usr/X11R6/bin/gnome-session 
for pauls on :0

Paul Schmehl (pauls at utdallas.edu)
Adjunct Information Security Officer
The University of Texas at Dallas
http://www.utdallas.edu/ir/security/