[X2Go-User] debug logs for "This can be due to the local X server refusing access to the client"

[Robert Kudyba]

I’ve restarted DBUS, systemd-logind, x2goserver, and deleted the user .x2go directory, X2Go just goes black and disappears. Here are debug logs from a Mac. Anything informative here?

using the nightly builds: x2goserver-4.1.0.0-0.0x2go1.0.git20171015.1421.heuler.fc26.x86_64

/Applications/x2goclient.app/Contents/MacOS/x2goclient --debug
x2go-INFO-1> "Starting X2Go Client..."
x2go-WARNING-1> "English language requested, not loading translator."
x2go-WARNING-1> "English language requested, not loading translator."
x2go-INFO-3> "Started X2Go Client."
x2go-DEBUG-../src/onmainwindow.cpp:518> "$HOME=/Users/ourschool"
x2go-DEBUG-../src/onmainwindow.cpp:2279> Reading 5 sessions from config file.
x2go-DEBUG-../src/sessionbutton.cpp:341> Creating QPixmap with session icon: ":/img/icons/128x128/x2gosession.png".
x2go-DEBUG-../src/sessionbutton.cpp:341> Creating QPixmap with session icon: ":/img/icons/128x128/x2gosession.png".
x2go-DEBUG-../src/sessionbutton.cpp:341> Creating QPixmap with session icon: ":/img/icons/128x128/x2gosession.png".
x2go-DEBUG-../src/sessionbutton.cpp:341> Creating QPixmap with session icon: ":/img/icons/128x128/x2gosession.png".
x2go-DEBUG-../src/sessionbutton.cpp:341> Creating QPixmap with session icon: ":/img/icons/128x128/x2gosession.png".
x2go-DEBUG-../src/x2goutils.cpp:219> path value at beginning: "/usr/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/opt/X11/bin"
x2go-DEBUG-../src/x2goutils.cpp:242> tmp_clean_add: ("/usr/local/bin") 
x2go-DEBUG-../src/x2goutils.cpp:270> clean_add: ("/usr/local/bin") 
x2go-DEBUG-../src/x2goutils.cpp:291> found entry i (0) in orig_path_list ("/usr/local/bin"): true
x2go-DEBUG-../src/x2goutils.cpp:309> return value at end: "/usr/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/opt/X11/bin"
x2go-DEBUG-../src/x2goutils.cpp:219> path value at beginning: "/usr/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/opt/X11/bin"
x2go-DEBUG-../src/x2goutils.cpp:242> tmp_clean_add: ("/opt/local/bin") 
x2go-DEBUG-../src/x2goutils.cpp:270> clean_add: ("/opt/local/bin") 
x2go-DEBUG-../src/x2goutils.cpp:291> found entry i (0) in orig_path_list ("/opt/local/bin"): false
x2go-DEBUG-../src/x2goutils.cpp:309> return value at end: "/usr/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/opt/X11/bin"
x2go-DEBUG-../src/pulsemanager.cpp:140> Found PA binary as "/Applications/x2goclient.app/Contents/exe/pulseaudio"
x2go-DEBUG-../src/pulsemanager.cpp:141> Corresponding working dir: "/Applications/x2goclient.app/Contents/exe"
x2go-DEBUG-../src/pulsemanager.cpp:232> pulse started with arguments("--exit-idle-time=-1", "-n", "-F", "/Users/ourschool/.x2go/pulse/config.pa", "-p", "/Applications/x2goclient.app/Contents/Frameworks/pulse-10.0/modules", "--high-priority", "--log-level=debug", "--verbose", "--log-target=file:/Users/ourschool/.x2go/pulse/pulse.log") ; waiting for finish... 
x2go-DEBUG-../src/onmainwindow.cpp:2759> Creating QPixmap with session icon: '":/img/icons/128x128/x2gosession.png"'.
x2go-DEBUG-../src/onmainwindow.cpp:6231> Setting focus.

x2go-INFO-8> "Starting connection to server: ourhost.dsm.ourschool.edu:22"
x2go-DEBUG-../src/onmainwindow.cpp:2860> Starting new ssh connection to server:"ourhost.dsm.ourschool.edu":"22" krbLogin: false
x2go-DEBUG-../src/sshmasterconnection.cpp:175> SshMasterConnection, host "ourhost.dsm.ourschool.edu"port 22user "me"useproxy falseproxyserver ""proxyport 22
x2go-DEBUG-../src/sshmasterconnection.cpp:212> Starting SSH connection without Kerberos authentication.
x2go-DEBUG-../src/sshmasterconnection.cpp:216> SshMasterConnection, instance SshMasterConnection(0x7f8e23a45920)  created. 
x2go-DEBUG-../src/sshmasterconnection.cpp:452> SshMasterConnection, instance SshMasterConnection(0x7f8e23a45920)  entering thread. 
x2go-DEBUG-../src/sshmasterconnection.cpp:488> libssh not initialized yet. Initializing.
x2go-DEBUG-../src/sshmasterconnection.cpp:799> cserverAuth
x2go-DEBUG-../src/sshmasterconnection.cpp:814> state: 1

x2go-DEBUG-../src/sshmasterconnection.cpp:996> Challenge authentication failed. Trying password mechanism if available.

x2go-DEBUG-../src/sshmasterconnection.cpp:1002> Password mechanism available. Continuing.

x2go-DEBUG-../src/sshmasterconnection.cpp:1006> Password authentication requested.

x2go-DEBUG-../src/sshmasterconnection.cpp:664> User authentication OK.
x2go-DEBUG-../src/onmainwindow.cpp:2957> SSH connection established.
x2go-DEBUG-../src/onmainwindow.cpp:3266> Continue normal X2Go session
x2go-DEBUG-../src/sshprocess.cpp:199> Executing remote command via SshProcess object 0: "export HOSTNAME && x2golistsessions"
x2go-DEBUG-../src/sshprocess.cpp:204> this=SshProcess(0x7f8e23831c90)  Running masterCon->addChannelConnection(this, ' "1f60ae6a-760c-486f-88d5-e921d852cf20" ', ' "bash -l -c 'echo "X2GODATABEGIN:1f60ae6a-760c-486f-88d5-e921d852cf20"; export PATH="/usr/local/bin:/usr/bin:/bin"; export TERM="dumb"; export HOSTNAME && x2golistsessions; echo "X2GODATAEND:1f60ae6a-7" '); 
x2go-DEBUG-../src/sshmasterconnection.cpp:1325> Locking SSH channel connection MUTEX.
x2go-DEBUG-../src/sshmasterconnection.cpp:1327> Passing new channel conenction object to channelConnections.
x2go-DEBUG-../src/sshmasterconnection.cpp:1329> Unlocking SSH channel connection MUTEX.
x2go-DEBUG-../src/sshmasterconnection.cpp:1517> Creating new channel.

x2go-DEBUG-../src/sshmasterconnection.cpp:1521> New channel:0x7f8e216a1540

x2go-DEBUG-../src/sshmasterconnection.cpp:1552> Executing remote: "bash -l -c 'echo "X2GODATABEGIN:1f60ae6a-760c-486f-88d5-e921d852cf20"; export PATH="/usr/local/bin:/usr/bin:/bin"; export TERM="dumb"; export HOSTNAME && x2golistsessions; echo "X2GODATAEND:1f60ae6a-760c-486f-88d5-e921d852cf20";'"

x2go-DEBUG-../src/sshmasterconnection.cpp:1575> New exec channel created.

x2go-DEBUG-../src/sshmasterconnection.cpp:1624> EOF on channel 0x7f8e216a1540; SshProcess object: 0
x2go-DEBUG-../src/sshmasterconnection.cpp:1747> EOF sent.
x2go-DEBUG-../src/sshmasterconnection.cpp:1751> Channel closed.
x2go-DEBUG-../src/sshprocess.cpp:517> SSH finished: raw output (stdout): "X2GODATABEGIN:1f60ae6a-760c-486f-88d5-e921d852cf20
X2GODATAEND:1f60ae6a-760c-486f-88d5-e921d852cf20
"
x2go-DEBUG-../src/sshprocess.cpp:528> SSH finished: true - "" (0).
x2go-DEBUG-../src/onmainwindow.cpp:3655> ""
x2go-DEBUG-../src/onmainwindow.cpp:4206> Executing remote command: "X2GODPI=90 x2gostartagent 800x600 adsl 16m-jpeg-9 unix-kde-depth_32 us query 0 D XFCE both"
x2go-DEBUG-../src/sshprocess.cpp:199> Executing remote command via SshProcess object 1: "X2GODPI=90 x2gostartagent 800x600 adsl 16m-jpeg-9 unix-kde-depth_32 us query 0 D XFCE both"
x2go-DEBUG-../src/sshprocess.cpp:204> this=SshProcess(0x7f8e2391b430)  Running masterCon->addChannelConnection(this, ' "f872d4a4-0f60-455b-a58b-7cea74023a32" ', ' "bash -l -c 'echo "X2GODATABEGIN:f872d4a4-0f60-455b-a58b-7cea74023a32"; export PATH="/usr/local/bin:/usr/bin:/bin"; export TERM="dumb"; X2GODPI=90 x2gostartagent 800x600 adsl 16m-jpeg-9 unix-kde-depth_" '); 
x2go-DEBUG-../src/sshmasterconnection.cpp:1325> Locking SSH channel connection MUTEX.
x2go-DEBUG-../src/sshmasterconnection.cpp:1327> Passing new channel conenction object to channelConnections.
x2go-DEBUG-../src/sshmasterconnection.cpp:1329> Unlocking SSH channel connection MUTEX.
x2go-DEBUG-../src/sshmasterconnection.cpp:1517> Creating new channel.

x2go-DEBUG-../src/sshmasterconnection.cpp:1521> New channel:0x7f8e216a1540

x2go-DEBUG-../src/sshmasterconnection.cpp:1552> Executing remote: "bash -l -c 'echo "X2GODATABEGIN:f872d4a4-0f60-455b-a58b-7cea74023a32"; export PATH="/usr/local/bin:/usr/bin:/bin"; export TERM="dumb"; X2GODPI=90 x2gostartagent 800x600 adsl 16m-jpeg-9 unix-kde-depth_32 us query 0 D XFCE both; echo "X2GODATAEND:f872d4a4-0f60-455b-a58b-7cea74023a32";'"

x2go-DEBUG-../src/sshmasterconnection.cpp:1575> New exec channel created.

x2go-DEBUG-../src/sshmasterconnection.cpp:1624> EOF on channel 0x7f8e216a1540; SshProcess object: 1
x2go-DEBUG-../src/sshmasterconnection.cpp:1747> EOF sent.
x2go-DEBUG-../src/sshmasterconnection.cpp:1751> Channel closed.
x2go-DEBUG-../src/sshprocess.cpp:517> SSH finished: raw output (stdout): "X2GODATABEGIN:f872d4a4-0f60-455b-a58b-7cea74023a32
100
01398c9600695417af13b522a54471de
16561
me-100-1508424308_stDXFCE_dp32
50625
50626
50627
X2GODATAEND:f872d4a4-0f60-455b-a58b-7cea74023a32
"
x2go-DEBUG-../src/sshprocess.cpp:528> SSH finished: true - "100
01398c9600695417af13b522a54471de
16561
me-100-1508424308_stDXFCE_dp32
50625
50626
50627
" (1).
x2go-DEBUG-../src/onmainwindow.cpp:5019> Agent output: "100
01398c9600695417af13b522a54471de
16561
me-100-1508424308_stDXFCE_dp32
50625
50626
50627
"
x2go-DEBUG-../src/sshprocess.cpp:372> Starting tunnel via SshProcess object 2: "localhost":50625 -> "localhost":51625

x2go-DEBUG-../src/onmainwindow.cpp:5612> "Starting NX proxy, command: "/Applications/x2goclient.app/Contents/exe/"nxproxy -S nx/nx,options=/Users/ourschool/.x2go/S-me-100-1508424308_stDXFCE_dp32/options:100"
x2go-DEBUG-../src/sshprocess.cpp:157> Direct tunnel: waiting for connections on "localhost":51625
x2go-DEBUG-../src/onmainwindow.cpp:6071> Proxy wrote on stderr: "
NXPROXY - Version 3.5.0

Copyright (C) 2001, 2010 NoMachine.
See http://www.nomachine.com/ for more information.

Info: Proxy running in client mode with pid '26232'.
Session: Starting session at '"
x2go-DEBUG-../src/onmainwindow.cpp:6071> Proxy wrote on stderr: "Thu Oct 19 10:45:11 2017'.
Info: Connecting to remote host 'localhost:51625'.
Info: Connection to remote proxy 'localhost:51625' established.
"
x2go-DEBUG-../src/sshprocess.cpp:109> New TCP connection.
x2go-DEBUG-../src/sshprocess.cpp:114> New socket: 29
x2go-DEBUG-../src/sshmasterconnection.cpp:1517> Creating new channel.

x2go-DEBUG-../src/sshmasterconnection.cpp:1521> New channel:0x7f8e2382b170

x2go-DEBUG-../src/sshmasterconnection.cpp:1527> Forwarding new channel, local port: 61509

x2go-DEBUG-../src/sshmasterconnection.cpp:1545> New channel forwarded.

x2go-DEBUG-../src/onmainwindow.cpp:6071> Proxy wrote on stderr: "Info: Connection with remote proxy completed.
Warning: Unrecognized session type 'unix-kde-depth_32'. Assuming agent session.
"
x2go-DEBUG-../src/onmainwindow.cpp:6071> Proxy wrote on stderr: "Warning: Failed to read data from the X auth command.
Warning: Generated a fake cookie for X authentication.
Info: Using ADSL link parameters 512/24/1/0.
Info: Using cache parameters 4/4096KB/8192KB/8192KB.
Info: Using pack method '16m-jpeg-9' with session 'unix-kde-depth_32'.
Info: Using ZLIB data compression 1"
x2go-DEBUG-../src/onmainwindow.cpp:6071> Proxy wrote on stderr: "/1/32.
Info: Using ZLIB stream compression 4/4.
Info: No suitable cache file found.
Info: Forwarding X11 connections to display '/private/tmp/com.apple.launchd.UQytuZiERB/org.macosforge.xquartz:0'.
Session: Session started at 'Thu Oct 19 10:45:13 2017'.
Warning: Protocol mismatch or no X authentication data.
"
x2go-DEBUG-../src/onmainwindow.cpp:6071> Proxy wrote on stderr: "Session: Terminating session at 'Thu Oct 19 10:45:15 2017'.
Info: Your session was closed before reaching a usable state.
Info: This can be due to the local X server refusing access to the client.
Info: Please check authorization provided by the remote X application.
Session: Session terminated at 'Thu Oct 19 10:45:15 2017'.
"
x2go-DEBUG-../src/sshmasterconnection.cpp:1728> Socket 29 closed.

x2go-DEBUG-../src/sshmasterconnection.cpp:1747> EOF sent.
x2go-DEBUG-../src/sshmasterconnection.cpp:1751> Channel closed.
x2go-DEBUG-../src/onmainwindow.cpp:5928> Deleting Proxy.
x2go-DEBUG-../src/onmainwindow.cpp:5977> Waiting for proxy to exit.
x2go-DEBUG-../src/onmainwindow.cpp:5997> Checking exit status.
x2go-DEBUG-../src/sshprocess.cpp:199> Executing remote command via SshProcess object 3: "x2gocmdexitmessage me-100-1508424308_stDXFCE_dp32"
x2go-DEBUG-../src/sshprocess.cpp:204> this=SshProcess(0x7f8e23924ac0)  Running masterCon->addChannelConnection(this, ' "fb299317-66e7-4f80-8491-7ef708e414bf" ', ' "bash -l -c 'echo "X2GODATABEGIN:fb299317-66e7-4f80-8491-7ef708e414bf"; export PATH="/usr/local/bin:/usr/bin:/bin"; export TERM="dumb"; x2gocmdexitmessage me-100-1508424308_stDXFCE_dp32; echo "X2GO" '); 
x2go-DEBUG-../src/sshmasterconnection.cpp:1325> Locking SSH channel connection MUTEX.
x2go-DEBUG-../src/sshmasterconnection.cpp:1327> Passing new channel conenction object to channelConnections.
x2go-DEBUG-../src/sshmasterconnection.cpp:1329> Unlocking SSH channel connection MUTEX.
x2go-DEBUG-../src/sshmasterconnection.cpp:1517> Creating new channel.

x2go-DEBUG-../src/sshmasterconnection.cpp:1521> New channel:0x7f8e216ae870

x2go-DEBUG-../src/sshmasterconnection.cpp:1552> Executing remote: "bash -l -c 'echo "X2GODATABEGIN:fb299317-66e7-4f80-8491-7ef708e414bf"; export PATH="/usr/local/bin:/usr/bin:/bin"; export TERM="dumb"; x2gocmdexitmessage me-100-1508424308_stDXFCE_dp32; echo "X2GODATAEND:fb299317-66e7-4f80-8491-7ef708e414bf";'"

x2go-DEBUG-../src/sshmasterconnection.cpp:1575> New exec channel created.

x2go-DEBUG-../src/sshmasterconnection.cpp:1624> EOF on channel 0x7f8e216ae870; SshProcess object: 3
x2go-DEBUG-../src/sshmasterconnection.cpp:1747> EOF sent.
x2go-DEBUG-../src/sshmasterconnection.cpp:1751> Channel closed.
x2go-DEBUG-../src/onmainwindow.cpp:6054> Finished proxy.
x2go-DEBUG-../src/sshprocess.cpp:517> SSH finished: raw output (stdout): "X2GODATABEGIN:fb299317-66e7-4f80-8491-7ef708e414bf
X2GODATAEND:fb299317-66e7-4f80-8491-7ef708e414bf
"
x2go-DEBUG-../src/sshprocess.cpp:528> SSH finished: true - "" (3).
x2go-DEBUG-../src/onmainwindow.cpp:9366> "Command message: "
x2go-DEBUG-../src/sshmasterconnection.cpp:718> SshMasterConnection, instance SshMasterConnection(0x7f8e23a45920)  waiting for thread to finish. 
x2go-DEBUG-../src/sshmasterconnection.cpp:1436> Disconnecting ...

x2go-DEBUG-../src/sshmasterconnection.cpp:1447> Deleting channel connections.

x2go-DEBUG-../src/sshmasterconnection.cpp:1455> Disconnecting session.

x2go-DEBUG-../src/sshmasterconnection.cpp:1461> Deleting sockets.

x2go-DEBUG-../src/sshmasterconnection.cpp:1468> All channels closed and session disconnected. Quiting session loop.

x2go-DEBUG-../src/sshmasterconnection.cpp:722> SshMasterConnection, instance SshMasterConnection(0x7f8e23a45920)  thread finished. 
x2go-DEBUG-../src/sshprocess.cpp:52> SshProcess destructor called.
x2go-DEBUG-../src/sshprocess.cpp:52> SshProcess destructor called.
x2go-DEBUG-../src/sshprocess.cpp:52> SshProcess destructor called.
x2go-DEBUG-../src/sshprocess.cpp:52> SshProcess destructor called.
x2go-DEBUG-../src/sshmasterconnection.cpp:729> SshMasterConnection, instance SshMasterConnection(0x7f8e23a45920)  finished destructor. 
x2go-DEBUG-../src/onmainwindow.cpp:6231> Setting focus.


—————
Oct 19 10:44:37 ourhost systemd-logind[7737]: New session 4075 of user me.
Oct 19 10:44:37 ourhost /usr/bin/x2gostartagent[14994]: x2gostartagent called with options: 800x600 adsl 16m-jpeg-9 unix-kde-depth_32 us query 0 D XFCE both
Oct 19 10:44:37 ourhost /usr/bin/x2gosessionlimit[15010]: x2gosessionlimit has been called
Oct 19 10:44:37 ourhost x2golistsessions[15011]: x2golistsessions has been called with options: --all-servers
Oct 19 10:45:10 ourhost /usr/bin/x2gofeature[16543]: x2gofeature called with options: X2GO_RUN_EXTENSIONS
Oct 19 10:45:10 ourhost /usr/share/x2go/x2gofeature.d/x2goserver-extensions.features[16548]: x2goserver-extensions.features called with options: X2GO_RUN_EXTENSIONS
Oct 19 10:45:10 ourhost /usr/bin/x2goserver-run-extensions[16553]: x2goserver-run-extensions called with options: me-100-1508424308_stDXFCE_dp32 pre-start
Oct 19 10:45:10 ourhost /usr/bin/x2gostartagent[16564]: creating new session: me-100-1508424308_stDXFCE_dp32 01398c9600695417af13b522a54471de 16561 150.108.68.33 50625 50626 50627 -1 -1
Oct 19 10:45:10 ourhost /usr/bin/x2gostartagent[16569]: blocking creation of agent's keyboard file /tmp/.x2go-me/C-me-100-1508424308_stDXFCE_dp32/keyboard as requested by session startup command
Oct 19 10:45:10 ourhost /usr/bin/x2gostartagent[16571]: successfully started X2Go agent session with ID me-100-1508424308_stDXFCE_dp32
Oct 19 10:45:10 ourhost /usr/bin/x2gofeature[16578]: x2gofeature called with options: X2GO_RUN_EXTENSIONS
Oct 19 10:45:10 ourhost /usr/share/x2go/x2gofeature.d/x2goserver-extensions.features[16583]: x2goserver-extensions.features called with options: X2GO_RUN_EXTENSIONS
Oct 19 10:45:10 ourhost /usr/bin/x2goserver-run-extensions[16588]: x2goserver-run-extensions called with options: me-100-1508424308_stDXFCE_dp32 post-start
Oct 19 10:45:15 ourhost /usr/bin/x2gocmdexitmessage[16667]: x2gocmdexitmessage called with options: me-100-1508424308_stDXFCE_dp32
Oct 19 10:45:16 ourhost systemd-logind[7737]: Removed session 4075.

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.x2go.org/pipermail/x2go-user/attachments/20171019/c7c773bf/attachment-0001.html>