xpra icon
Bug tracker and wiki

This bug tracker and wiki are being discontinued
please use https://github.com/Xpra-org/xpra instead.


Opened 10 months ago

Closed 10 months ago

Last modified 8 months ago

#2964 closed defect (fixed)

Abnormal closure 1006 after python 3.9 update

Reported by: goekce Owned by: goekce
Priority: major Milestone:
Component: server Version: trunk
Keywords: Cc:

Description

I am on Archlinux and recently I got Python 3.9 update. The user logins per ldap-pam via xpra proxy. The user server is started, but I get ECONNREFUSED errors.

Does someone have an idea where the problem could be?

Dec 02 23:49:28 joan xpra[54227]: 2020-12-02 23:49:28,439 ChildReaper(None)
Dec 02 23:49:28 joan xpra[54227]: 2020-12-02 23:49:28,459 poll() procinfo list: []
Dec 02 23:49:28 joan xpra[54227]: 2020-12-02 23:49:28,459 check() alive=(), quit callback=None
Dec 02 23:49:28 joan xpra[54227]: 2020-12-02 23:49:28,460 xpra is ready.
Dec 02 23:49:28 joan xpra[54227]: 2020-12-02 23:49:28,460 Worker_Thread.run() starting
Dec 02 23:49:28 joan xpra[54227]: 2020-12-02 23:49:28,460 add_work_item(<bound method ServerCore.do_print_run_info of <xpra.server.proxy.proxy_server.ProxyServer object at 0x7f5f18242730>>, True) worker=Worker_Thread(items=0, exit=False)
Dec 02 23:49:28 joan xpra[54227]: 2020-12-02 23:49:28,461 Worker_Thread.run() calling <bound method ServerCore.do_print_run_info of <xpra.server.proxy.proxy_server.ProxyServer object at 0x7f5f18242730>> (queue size=0)
Dec 02 23:49:28 joan xpra[54227]: 2020-12-02 23:49:28,461 xpra proxy version 4.1-r27685 64-bit
Dec 02 23:49:28 joan xpra[54227]: 2020-12-02 23:49:28,461  uid=0 (root), gid=0 (root)
Dec 02 23:49:28 joan xpra[54227]: 2020-12-02 23:49:28,461  running with pid 54227 on Linux unknown unknown unknown
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,087 identical remote version: 4.1
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,088 Authentication required by PAM authenticator module 1
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,088  sending challenge for username 'gaydos' using xor digest
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,100 identical remote version: 4.1
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,108 pam_start: SUCCESS
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,109 authenticate()
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,132 pam_authenticate: SUCCESS
Dec 02 23:50:06 joan python[54227]: pam_unix(login:session): session closed for user gaydos
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,133 pam_close_session: SUCCESS
Dec 02 23:50:06 joan python[54227]: pam_mail(login:session): pam_putenv: delete non-existent entry; MAIL
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,134 pam_end: SUCCESS
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,137 socket_details(35801, None, None) sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,137 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,138 get_server_state: connect(/home/gaydos/.xpra/joan-1)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,138 ECONNREFUSED
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,146 socket_details(35801, 'LIVE', None) sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,146 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,147 get_server_state: connect(/home/gaydos/.xpra/joan-1)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,147 ECONNREFUSED
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,147 socket_details: '/home/gaydos/.xpra/joan-1' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:06 joan xpra[54227]: 2020-12-02 23:50:06,159 read_displayfd(12, 20, None)
Dec 02 23:50:06 joan python[54352]: PAM _pam_load_conf_file: unable to open config for postlogin
Dec 02 23:50:06 joan xpra[54352]: 2020-12-02 23:50:06,340 pam_start: SUCCESS
Dec 02 23:50:06 joan xpra[54352]: 2020-12-02 23:50:06,341 pam_putenv: XDG_SESSION_TYPE=x11
Dec 02 23:50:06 joan xpra[54352]: 2020-12-02 23:50:06,341 pam_putenv: XDG_SESSION_DESKTOP=xpra
Dec 02 23:50:06 joan xpra[54352]: 2020-12-02 23:50:06,341 item_type(XAUTHDATA)=12
Dec 02 23:50:06 joan xpra[54352]: 2020-12-02 23:50:06,341 pam_set_item: XAUTHDATA=b'a9b2b821e121467eaffc807417e7bc40'
Dec 02 23:50:06 joan xpra[54352]: 2020-12-02 23:50:06,481 pam_open_session: SUCCESS
Dec 02 23:50:06 joan xpra[54352]: 2020-12-02 23:50:06,481 pam_getenvlist: 0x558eb7caf440
Dec 02 23:50:06 joan xpra[54352]: 2020-12-02 23:50:06,481 get_envlist()={'XDG_SESSION_TYPE': 'x11', 'XDG_SESSION_DESKTOP': 'xpra', 'XDG_SESSION_ID': '13', 'XDG_RUNTIME_DIR': '/run/user/35801', 'DBUS_SESSION_BUS_ADDRESS': 'unix:path=/run/user/35801/bus', 'XDG_SESSION_CLASS': 'background'}
Dec 02 23:50:06 joan xpra[54352]: Entering daemon mode; any further errors will be reported to:
Dec 02 23:50:06 joan xpra[54352]:   /run/user/35801/xpra/S54349.log
Dec 02 23:50:07 joan xpra[54227]: 2020-12-02 23:50:07,823 readable=[12]
Dec 02 23:50:07 joan xpra[54227]: 2020-12-02 23:50:07,823 read=b'0\n'
Dec 02 23:50:07 joan xpra[54227]: 2020-12-02 23:50:07,824 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:07 joan xpra[54227]: 2020-12-02 23:50:07,824 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:07 joan xpra[54227]: 2020-12-02 23:50:07,925 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:07 joan xpra[54227]: 2020-12-02 23:50:07,925 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,026 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,027 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,128 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,128 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,229 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,229 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,330 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,330 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,431 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,431 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,532 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,533 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,634 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,634 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,735 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,735 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,836 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,836 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,937 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:08 joan xpra[54227]: 2020-12-02 23:50:08,937 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,038 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,038 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,039 get_server_state: connect(/run/user/35801/xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,039 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,039 socket_details: '/run/user/35801/xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,040 get_server_state: connect(/home/gaydos/.xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,040 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,040 socket_details: '/home/gaydos/.xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,141 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,141 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,141 get_server_state: connect(/run/user/35801/xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,142 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,142 socket_details: '/run/user/35801/xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,142 get_server_state: connect(/home/gaydos/.xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,142 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,143 socket_details: '/home/gaydos/.xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,243 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,243 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,244 get_server_state: connect(/run/user/35801/xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,244 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,244 socket_details: '/run/user/35801/xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,245 get_server_state: connect(/home/gaydos/.xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,245 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,245 socket_details: '/home/gaydos/.xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,345 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,346 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,346 get_server_state: connect(/run/user/35801/xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,346 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,347 socket_details: '/run/user/35801/xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,347 get_server_state: connect(/home/gaydos/.xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,347 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,347 socket_details: '/home/gaydos/.xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,448 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,448 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,449 get_server_state: connect(/run/user/35801/xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,449 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,449 socket_details: '/run/user/35801/xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,449 get_server_state: connect(/home/gaydos/.xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,450 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,450 socket_details: '/home/gaydos/.xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,550 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,550 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,551 get_server_state: connect(/run/user/35801/xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,551 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,551 socket_details: '/run/user/35801/xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,552 get_server_state: connect(/home/gaydos/.xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,552 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,552 socket_details: '/home/gaydos/.xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,652 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,653 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,653 get_server_state: connect(/run/user/35801/xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,653 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,654 socket_details: '/run/user/35801/xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,654 get_server_state: connect(/home/gaydos/.xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,654 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,654 socket_details: '/home/gaydos/.xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,755 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,755 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,756 get_server_state: connect(/run/user/35801/xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,756 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,756 socket_details: '/run/user/35801/xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,756 get_server_state: connect(/home/gaydos/.xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,757 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,757 socket_details: '/home/gaydos/.xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,857 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,857 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,858 get_server_state: connect(/run/user/35801/xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,858 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,858 socket_details: '/run/user/35801/xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,859 get_server_state: connect(/home/gaydos/.xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,859 ECONNREFUSED
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,859 socket_details: '/home/gaydos/.xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:09 joan xpra[54227]: 2020-12-02 23:50:09,959 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:09,960 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:09,960 get_server_state: connect(/run/user/35801/xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:09,960 ECONNREFUSED
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:09,961 socket_details: '/run/user/35801/xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:09,961 get_server_state: connect(/home/gaydos/.xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:09,961 ECONNREFUSED
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:09,961 socket_details: '/home/gaydos/.xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:10,062 socket_details(35801, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:10,062 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:10,389 add_process(<Popen: returncode: 0 args: ['/usr/bin/xpra', 'start', '--attach=no', '--deb...>, server-:0, xpra start, True, True) pid=54349
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:10,389 add_dead_process(ProcInfo({'pid': 54349, 'name': 'server-:0', 'command': 'xpra start', 'ignore': True, 'forget': True, 'callback': None, 'process': <Popen: returncode: 0 args: ['/usr/bin/xpra', 'start', '--attach=no', '--deb...>, 'returncode': 0, 'dead': True}))
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:10,401 socket_details(0, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/root/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/root/.xpra']
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:10,401 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:10,402 socket_details: '/root/.xpra' path does not exist
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:10,405 sigchld(17, <frame at 0x557345999330, file '/usr/lib/python3.9/site-packages/xpra/platform/displayfd.py', line 62, code read_displayfd>)
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:10,405 poll() procinfo list: [ProcInfo({'pid': 54349, 'name': 'server-:0', 'command': 'xpra start', 'ignore': True, 'forget': True, 'callback': None, 'process': <Popen: returncode: 0 args: ['/usr/bin/xpra', 'start', '--attach=no', '--deb...>, 'returncode': 0, 'dead': True})]
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:10,406 reap() calling os.waitpid(-1, 'WNOHANG')
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:10,406 sigchld(17, <frame at 0x7f5f184a4840, file '/usr/lib/python3.9/selectors.py', line 422, code select>)
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:10,406 poll() procinfo list: [ProcInfo({'pid': 54349, 'name': 'server-:0', 'command': 'xpra start', 'ignore': True, 'forget': True, 'callback': None, 'process': <Popen: returncode: 0 args: ['/usr/bin/xpra', 'start', '--attach=no', '--deb...>, 'returncode': 0, 'dead': True})]
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:10,407 reap() calling os.waitpid(-1, 'WNOHANG')
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:10,411 Error starting proxy instance process:
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:10,411  'Thread' object has no attribute 'isAlive'
Dec 02 23:50:10 joan xpra[54227]: 2020-12-02 23:50:10,415 get_send_buffer_status(<socket.socket fd=10, family=AddressFamily.AF_INET6, type=SocketKind.SOCK_STREAM, proto=0, laddr=('::ffff:127.0.0.1', 14500, 0, 0), raddr=('::ffff:127.0.0.1', 38478, 0, 0)>)={'sndbuf_size': 2626560, 'sndbuf_unacked': 0, 'sndbuf_bytes': 0}
Dec 02 23:50:10 joan xpra[54227]: Traceback (most recent call last):
Dec 02 23:50:10 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/queues.py", line 251, in _feed
Dec 02 23:50:10 joan xpra[54227]:     send_bytes(obj)
Dec 02 23:50:10 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 205, in send_bytes
Dec 02 23:50:10 joan xpra[54227]:     self._send_bytes(m[offset:offset + size])
Dec 02 23:50:10 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 416, in _send_bytes
Dec 02 23:50:10 joan xpra[54227]:     self._send(header + buf)
Dec 02 23:50:10 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 373, in _send
Dec 02 23:50:10 joan xpra[54227]:     n = write(self._handle, buf)
Dec 02 23:50:10 joan xpra[54227]: BrokenPipeError: [Errno 32] Broken pipe
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,222 identical remote version: 4.1
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,223 Authentication required by PAM authenticator module 1
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,223  sending challenge for username 'gaydos' using xor digest
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,233 identical remote version: 4.1
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,239 pam_start: SUCCESS
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,239 authenticate()
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,251 pam_authenticate: SUCCESS
Dec 02 23:50:12 joan python[54227]: pam_unix(login:session): session closed for user gaydos
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,252 pam_close_session: SUCCESS
Dec 02 23:50:12 joan python[54227]: pam_mail(login:session): pam_putenv: delete non-existent entry; MAIL
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,253 pam_end: SUCCESS
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,254 socket_details(35801, None, None) sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,254 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,254 get_server_state: connect(/home/gaydos/.xpra/joan-1)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,255 ECONNREFUSED
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,261 socket_details(0, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/root/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/root/.xpra']
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,261 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,261 socket_details: '/root/.xpra' path does not exist
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,263 Error starting proxy instance process:
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,263  'Thread' object has no attribute 'isAlive'
Dec 02 23:50:12 joan xpra[54227]: 2020-12-02 23:50:12,264 get_send_buffer_status(<socket.socket fd=10, family=AddressFamily.AF_INET6, type=SocketKind.SOCK_STREAM, proto=0, laddr=('::ffff:127.0.0.1', 14500, 0, 0), raddr=('::ffff:127.0.0.1', 38502, 0, 0)>)={'sndbuf_size': 2626560, 'sndbuf_unacked': 0, 'sndbuf_bytes': 0}
Dec 02 23:50:12 joan xpra[54227]: Traceback (most recent call last):
Dec 02 23:50:12 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/queues.py", line 251, in _feed
Dec 02 23:50:12 joan xpra[54227]:     send_bytes(obj)
Dec 02 23:50:12 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 205, in send_bytes
Dec 02 23:50:12 joan xpra[54227]:     self._send_bytes(m[offset:offset + size])
Dec 02 23:50:12 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 416, in _send_bytes
Dec 02 23:50:12 joan xpra[54227]:     self._send(header + buf)
Dec 02 23:50:12 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 373, in _send
Dec 02 23:50:12 joan xpra[54227]:     n = write(self._handle, buf)
Dec 02 23:50:12 joan xpra[54227]: BrokenPipeError: [Errno 32] Broken pipe
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,343 identical remote version: 4.1
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,343 Authentication required by PAM authenticator module 1
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,343  sending challenge for username 'gaydos' using xor digest
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,352 identical remote version: 4.1
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,361 pam_start: SUCCESS
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,361 authenticate()
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,373 pam_authenticate: SUCCESS
Dec 02 23:50:14 joan python[54227]: pam_unix(login:session): session closed for user gaydos
Dec 02 23:50:14 joan python[54227]: pam_mail(login:session): pam_putenv: delete non-existent entry; MAIL
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,373 pam_close_session: SUCCESS
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,374 pam_end: SUCCESS
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,375 socket_details(35801, None, None) sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,376 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,376 get_server_state: connect(/home/gaydos/.xpra/joan-1)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,376 ECONNREFUSED
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,385 socket_details(0, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/root/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/root/.xpra']
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,385 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,386 socket_details: '/root/.xpra' path does not exist
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,388 Error starting proxy instance process:
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,388  'Thread' object has no attribute 'isAlive'
Dec 02 23:50:14 joan xpra[54227]: 2020-12-02 23:50:14,389 get_send_buffer_status(<socket.socket fd=10, family=AddressFamily.AF_INET6, type=SocketKind.SOCK_STREAM, proto=0, laddr=('::ffff:127.0.0.1', 14500, 0, 0), raddr=('::ffff:127.0.0.1', 38524, 0, 0)>)={'sndbuf_size': 2626560, 'sndbuf_unacked': 0, 'sndbuf_bytes': 0}
Dec 02 23:50:14 joan xpra[54227]: Traceback (most recent call last):
Dec 02 23:50:14 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/queues.py", line 251, in _feed
Dec 02 23:50:14 joan xpra[54227]:     send_bytes(obj)
Dec 02 23:50:14 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 205, in send_bytes
Dec 02 23:50:14 joan xpra[54227]:     self._send_bytes(m[offset:offset + size])
Dec 02 23:50:14 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 416, in _send_bytes
Dec 02 23:50:14 joan xpra[54227]:     self._send(header + buf)
Dec 02 23:50:14 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 373, in _send
Dec 02 23:50:14 joan xpra[54227]:     n = write(self._handle, buf)
Dec 02 23:50:14 joan xpra[54227]: BrokenPipeError: [Errno 32] Broken pipe
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,473 identical remote version: 4.1
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,474 Authentication required by PAM authenticator module 1
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,474  sending challenge for username 'gaydos' using xor digest
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,485 identical remote version: 4.1
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,493 pam_start: SUCCESS
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,493 authenticate()
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,517 pam_authenticate: SUCCESS
Dec 02 23:50:16 joan python[54227]: pam_unix(login:session): session closed for user gaydos
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,518 pam_close_session: SUCCESS
Dec 02 23:50:16 joan python[54227]: pam_mail(login:session): pam_putenv: delete non-existent entry; MAIL
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,519 pam_end: SUCCESS
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,520 socket_details(35801, None, None) sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,521 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,522 get_server_state: connect(/home/gaydos/.xpra/joan-1)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,522 ECONNREFUSED
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,533 socket_details(0, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/root/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/root/.xpra']
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,533 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,534 socket_details: '/root/.xpra' path does not exist
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,536 Error starting proxy instance process:
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,536  'Thread' object has no attribute 'isAlive'
Dec 02 23:50:16 joan xpra[54227]: 2020-12-02 23:50:16,538 get_send_buffer_status(<socket.socket fd=10, family=AddressFamily.AF_INET6, type=SocketKind.SOCK_STREAM, proto=0, laddr=('::ffff:127.0.0.1', 14500, 0, 0), raddr=('::ffff:127.0.0.1', 38546, 0, 0)>)={'sndbuf_size': 2626560, 'sndbuf_unacked': 0, 'sndbuf_bytes': 0}
Dec 02 23:50:16 joan xpra[54227]: Traceback (most recent call last):
Dec 02 23:50:16 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/queues.py", line 251, in _feed
Dec 02 23:50:16 joan xpra[54227]:     send_bytes(obj)
Dec 02 23:50:16 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 205, in send_bytes
Dec 02 23:50:16 joan xpra[54227]:     self._send_bytes(m[offset:offset + size])
Dec 02 23:50:16 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 416, in _send_bytes
Dec 02 23:50:16 joan xpra[54227]:     self._send(header + buf)
Dec 02 23:50:16 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 373, in _send
Dec 02 23:50:16 joan xpra[54227]:     n = write(self._handle, buf)
Dec 02 23:50:16 joan xpra[54227]: BrokenPipeError: [Errno 32] Broken pipe
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,599 identical remote version: 4.1
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,600 Authentication required by PAM authenticator module 1
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,601  sending challenge for username 'gaydos' using xor digest
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,610 identical remote version: 4.1
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,618 pam_start: SUCCESS
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,618 authenticate()
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,632 pam_authenticate: SUCCESS
Dec 02 23:50:18 joan python[54227]: pam_unix(login:session): session closed for user gaydos
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,633 pam_close_session: SUCCESS
Dec 02 23:50:18 joan python[54227]: pam_mail(login:session): pam_putenv: delete non-existent entry; MAIL
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,633 pam_end: SUCCESS
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,635 socket_details(35801, None, None) sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/xpra', '/home/gaydos/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/xpra', '/home/gaydos/.xpra']
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,635 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,636 get_server_state: connect(/home/gaydos/.xpra/joan-1)=[Errno 111] Connection refused (timeout=5)
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,637 ECONNREFUSED
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,647 socket_details(0, 'LIVE', ':0') sockdir=$XDG_RUNTIME_DIR/xpra, sockdirs=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/root/.xpra'], testing=['$XDG_RUNTIME_DIR/xpra', '/run/user/35801/xpra', '/run/xpra', '/root/.xpra']
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,647 socket_details: '$XDG_RUNTIME_DIR/xpra' path does not exist
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,648 socket_details: '/root/.xpra' path does not exist
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,650 Error starting proxy instance process:
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,650  'Thread' object has no attribute 'isAlive'
Dec 02 23:50:18 joan xpra[54227]: 2020-12-02 23:50:18,651 get_send_buffer_status(<socket.socket fd=10, family=AddressFamily.AF_INET6, type=SocketKind.SOCK_STREAM, proto=0, laddr=('::ffff:127.0.0.1', 14500, 0, 0), raddr=('::ffff:127.0.0.1', 38570, 0, 0)>)={'sndbuf_size': 2626560, 'sndbuf_unacked': 0, 'sndbuf_bytes': 0}
Dec 02 23:50:18 joan xpra[54227]: Traceback (most recent call last):
Dec 02 23:50:18 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/queues.py", line 251, in _feed
Dec 02 23:50:18 joan xpra[54227]:     send_bytes(obj)
Dec 02 23:50:18 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 205, in send_bytes
Dec 02 23:50:18 joan xpra[54227]:     self._send_bytes(m[offset:offset + size])
Dec 02 23:50:18 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 416, in _send_bytes
Dec 02 23:50:18 joan xpra[54227]:     self._send(header + buf)
Dec 02 23:50:18 joan xpra[54227]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 373, in _send
Dec 02 23:50:18 joan xpra[54227]:     n = write(self._handle, buf)
Dec 02 23:50:18 joan xpra[54227]: BrokenPipeError: [Errno 32] Broken pipe
Dec 02 23:50:20 joan xpra[54227]: 2020-12-02 23:50:20,828 identical remote version: 4.1
Dec 02 23:50:20 joan xpra[54227]: 2020-12-02 23:50:20,829 Authentication required by PAM authenticator module 1
Dec 02 23:50:20 joan xpra[54227]: 2020-12-02 23:50:20,829  sending challenge for username 'gaydos' using xor digest
Dec 02 23:50:20 joan xpra[54227]: 2020-12-02 23:50:20,840 identical remote version: 4.1
Dec 02 23:50:20 joan xpra[54227]: 2020-12-02 23:50:20,847 pam_start: SUCCESS
Dec 02 23:50:20 joan xpra[54227]: 2020-12-02 23:50:20,847 authenticate()
Dec 02 23:50:20 joan xpra[54227]: 2020-12-02 23:50:20,861 pam_authenticate: SUCCESS
Dec 02 23:50:20 joan python[54227]: pam_unix(login:session): session closed for user gaydos
Dec 02 23:50:20 joan xpra[54227]: 2020-12-02 23:50:20,862 pam_close_session: SUCCESS

Change History (10)

comment:1 Changed 10 months ago by goekce

After deactivating socket directories I do not need, I narrowed down the logs a bit. Probably the user server starts in /run/user/35801/xpra, but the proxy does not have the permissions to access it

get_server_state: connect(/run/user/35801/xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 03 09:15:44 joan xpra[72366]: 2020-12-03 09:15:44,751 ECONNREFUSED
Dec 03 09:15:44 joan xpra[72366]: 2020-12-03 09:15:44,751 socket_details: '/run/user/35801/xpra/joan-0' state does not match (UNKNOWN vs LIVE)

Here is the narrowed down excerpt:

get_envlist()={'XDG_SESSION_TYPE': 'x11', 'XDG_SESSION_DESKTOP': 'xpra', 'XDG_SESSION_ID': '16', 'XDG_RUNTIME_DIR': '/run/user/35801', 'DBUS_SESSION_BUS_ADDRESS': 'unix:path=/run/user/35801/bus', 'XDG_SESSION_CLASS': 'background'}
Dec 03 09:15:42 joan xpra[72487]: Entering daemon mode; any further errors will be reported to:
Dec 03 09:15:42 joan xpra[72487]:   /run/user/35801/xpra/S72484.log
Dec 03 09:15:43 joan xpra[72366]: 2020-12-03 09:15:43,540 readable=[12]
Dec 03 09:15:43 joan xpra[72366]: 2020-12-03 09:15:43,541 read=b'0\n'
Dec 03 09:15:43 joan xpra[72366]: 2020-12-03 09:15:43,542 socket_details(35801, 'LIVE', ':0') sockdir=/run/user/35801/xpra, sockdirs=['/run/user/35801/xpra'], testing=['/run/user/35801/xpra']
Dec 03 09:15:43 joan xpra[72366]: 2020-12-03 09:15:43,642 socket_details(35801, 'LIVE', ':0') sockdir=/run/user/35801/xpra, sockdirs=['/run/user/35801/xpra'], testing=['/run/user/35801/xpra']
Dec 03 09:15:43 joan xpra[72366]: 2020-12-03 09:15:43,743 socket_details(35801, 'LIVE', ':0') sockdir=/run/user/35801/xpra, sockdirs=['/run/user/35801/xpra'], testing=['/run/user/35801/xpra']
Dec 03 09:15:43 joan xpra[72366]: 2020-12-03 09:15:43,844 socket_details(35801, 'LIVE', ':0') sockdir=/run/user/35801/xpra, sockdirs=['/run/user/35801/xpra'], testing=['/run/user/35801/xpra']
Dec 03 09:15:43 joan xpra[72366]: 2020-12-03 09:15:43,945 socket_details(35801, 'LIVE', ':0') sockdir=/run/user/35801/xpra, sockdirs=['/run/user/35801/xpra'], testing=['/run/user/35801/xpra']
Dec 03 09:15:44 joan xpra[72366]: 2020-12-03 09:15:44,045 socket_details(35801, 'LIVE', ':0') sockdir=/run/user/35801/xpra, sockdirs=['/run/user/35801/xpra'], testing=['/run/user/35801/xpra']
Dec 03 09:15:44 joan xpra[72366]: 2020-12-03 09:15:44,146 socket_details(35801, 'LIVE', ':0') sockdir=/run/user/35801/xpra, sockdirs=['/run/user/35801/xpra'], testing=['/run/user/35801/xpra']
Dec 03 09:15:44 joan xpra[72366]: 2020-12-03 09:15:44,247 socket_details(35801, 'LIVE', ':0') sockdir=/run/user/35801/xpra, sockdirs=['/run/user/35801/xpra'], testing=['/run/user/35801/xpra']
Dec 03 09:15:44 joan xpra[72366]: 2020-12-03 09:15:44,348 socket_details(35801, 'LIVE', ':0') sockdir=/run/user/35801/xpra, sockdirs=['/run/user/35801/xpra'], testing=['/run/user/35801/xpra']
Dec 03 09:15:44 joan xpra[72366]: 2020-12-03 09:15:44,448 socket_details(35801, 'LIVE', ':0') sockdir=/run/user/35801/xpra, sockdirs=['/run/user/35801/xpra'], testing=['/run/user/35801/xpra']
Dec 03 09:15:44 joan xpra[72366]: 2020-12-03 09:15:44,549 socket_details(35801, 'LIVE', ':0') sockdir=/run/user/35801/xpra, sockdirs=['/run/user/35801/xpra'], testing=['/run/user/35801/xpra']
Dec 03 09:15:44 joan xpra[72366]: 2020-12-03 09:15:44,650 socket_details(35801, 'LIVE', ':0') sockdir=/run/user/35801/xpra, sockdirs=['/run/user/35801/xpra'], testing=['/run/user/35801/xpra']
Dec 03 09:15:44 joan xpra[72366]: 2020-12-03 09:15:44,750 socket_details(35801, 'LIVE', ':0') sockdir=/run/user/35801/xpra, sockdirs=['/run/user/35801/xpra'], testing=['/run/user/35801/xpra']
Dec 03 09:15:44 joan xpra[72366]: 2020-12-03 09:15:44,751 get_server_state: connect(/run/user/35801/xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 03 09:15:44 joan xpra[72366]: 2020-12-03 09:15:44,751 ECONNREFUSED
Dec 03 09:15:44 joan xpra[72366]: 2020-12-03 09:15:44,751 socket_details: '/run/user/35801/xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 03 09:15:44 joan xpra[72366]: 2020-12-03 09:15:44,851 socket_details(35801, 'LIVE', ':0') sockdir=/run/user/35801/xpra, sockdirs=['/run/user/35801/xpra'], testing=['/run/user/35801/xpra']
Dec 03 09:15:44 joan xpra[72366]: 2020-12-03 09:15:44,852 get_server_state: connect(/run/user/35801/xpra/joan-0)=[Errno 111] Connection refused (timeout=5)
Dec 03 09:15:44 joan xpra[72366]: 2020-12-03 09:15:44,852 ECONNREFUSED

comment:2 Changed 10 months ago by goekce

According to #2859 logs [1] the ECONNREFUSED messages are normal. The actual problem could be that Python 3.9 renamed isAlive attribute for threads to is_alive

[1] https://www.xpra.org/trac/attachment/ticket/2859/1001.log

comment:3 Changed 10 months ago by goekce

I renamed two instances of isAlive to is_alive in net/protocol.py, which should probably be fixed, but did not fix the error.

I removed /run/xpra and then recreated it:

$ sudo systemd-tmpfiles --create --remove
$ ls -al /run/xpra
drwxrwxr-x  2 root students  40 Dec  3 10:31 .
drwxr-xr-x 28 root root     720 Dec  3 10:31 ..

When I start xpra, then the directory permissions are changed (Probably due to the fixes for #2907).

$ sudo systemctl start xpra
$ ls -al /run/xpra
total 4
drwxrwxr-x  2  973 root  80 Dec  3 10:32 .
drwxr-xr-x 28 root root 720 Dec  3 10:31 ..
-rw-------  1 root root   7 Dec  3 10:32 proxy.pid
srw-rw-rw-  1 root xpra   0 Dec  3 10:32 system

973 is the group id of xpra. Could it be that xpra sets the permissions in a wrong way?

When I connected via connect.html again:

Dec 03 10:34:59 joan xpra[106831]: 2020-12-03 10:34:59,179 ECONNREFUSED
Dec 03 10:34:59 joan xpra[106831]: 2020-12-03 10:34:59,179 socket_details: '/run/user/35801/xpra/joan-0' state does not match (UNKNOWN vs LIVE)
Dec 03 10:34:59 joan xpra[106831]: 2020-12-03 10:34:59,279 socket_details(35801, 'LIVE', ':0') sockdir=/run/user/35801/xpra, sockdirs=['/run/user/35801/xpra'], testing=['/run/user/35801/xpra']
Dec 03 10:34:59 joan xpra[106831]: 2020-12-03 10:34:59,370 get_send_buffer_status(<socket.socket fd=10, family=AddressFamily.AF_INET6, type=SocketKind.SOCK_STREAM, proto=0, laddr=('::ffff:127.0.0.1', 14500, 0, 0), raddr=('::ffff:127.0.0.1', 40720, 0, 0)>)={'sndbuf_size': 2626560, 'sndbuf_unacked': 0, 'sndbuf_bytes': 0}
Dec 03 10:34:59 joan xpra[106831]: 2020-12-03 10:34:59,610 add_process(<Popen: returncode: 0 args: ['/usr/bin/xpra', 'start', '--attach=no', '--deb...>, server-:0, xpra start, True, True) pid=106982
Dec 03 10:34:59 joan xpra[106831]: 2020-12-03 10:34:59,610 add_dead_process(ProcInfo({'pid': 106982, 'name': 'server-:0', 'command': 'xpra start', 'ignore': True, 'forget': True, 'callback': None, 'process': <Popen: returncode: 0 args: ['/usr/bin/xpra', 'start', '--attach=no', '--deb...>, 'returncode': 0, 'dead': True}))
Dec 03 10:34:59 joan xpra[106831]: 2020-12-03 10:34:59,616 socket_details(0, 'LIVE', ':0') sockdir=/run/user/35801/xpra, sockdirs=['/run/user/35801/xpra'], testing=['/run/user/35801/xpra']
Dec 03 10:34:59 joan xpra[106831]: 2020-12-03 10:34:59,618 sigchld(17, <frame at 0x563256812b70, file '/usr/lib/python3.9/site-packages/xpra/platform/displayfd.py', line 62, code read_displayfd>)
Dec 03 10:34:59 joan xpra[106831]: 2020-12-03 10:34:59,619 poll() procinfo list: [ProcInfo({'pid': 106982, 'name': 'server-:0', 'command': 'xpra start', 'ignore': True, 'forget': True, 'callback': None, 'process': <Popen: returncode: 0 args: ['/usr/bin/xpra', 'start', '--attach=no', '--deb...>, 'returncode': 0, 'dead': True})]
Dec 03 10:34:59 joan xpra[106831]: 2020-12-03 10:34:59,619 reap() calling os.waitpid(-1, 'WNOHANG')
Dec 03 10:34:59 joan xpra[106831]: 2020-12-03 10:34:59,619 sigchld(17, <frame at 0x5632564dee00, file '/usr/lib/python3.9/subprocess.py', line 1997, code _communicate>)
Dec 03 10:34:59 joan xpra[106831]: 2020-12-03 10:34:59,620 poll() procinfo list: [ProcInfo({'pid': 106982, 'name': 'server-:0', 'command': 'xpra start', 'ignore': True, 'forget': True, 'callback': None, 'process': <Popen: returncode: 0 args: ['/usr/bin/xpra', 'start', '--attach=no', '--deb...>, 'returncode': 0, 'dead': True})]
Dec 03 10:34:59 joan xpra[106831]: 2020-12-03 10:34:59,620 reap() calling os.waitpid(-1, 'WNOHANG')
Dec 03 10:34:59 joan xpra[106831]: 2020-12-03 10:34:59,625 Error starting proxy instance process:
Dec 03 10:34:59 joan xpra[106831]: 2020-12-03 10:34:59,625  cannot steal a closed connection
Dec 03 10:34:59 joan xpra[106831]: Traceback (most recent call last):
Dec 03 10:34:59 joan xpra[106831]:   File "/usr/lib/python3.9/multiprocessing/queues.py", line 251, in _feed
Dec 03 10:34:59 joan xpra[106831]:     send_bytes(obj)
Dec 03 10:34:59 joan xpra[106831]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 205, in send_bytes
Dec 03 10:34:59 joan xpra[106831]:     self._send_bytes(m[offset:offset + size])
Dec 03 10:34:59 joan xpra[106831]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 416, in _send_bytes
Dec 03 10:34:59 joan xpra[106831]:     self._send(header + buf)
Dec 03 10:34:59 joan xpra[106831]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 373, in _send
Dec 03 10:34:59 joan xpra[106831]:     n = write(self._handle, buf)
Dec 03 10:34:59 joan xpra[106831]: BrokenPipeError: [Errno 32] Broken pipe

After fixing the permissions of /run/xpra manually:

$ sudo chmod o+w /run/xpra
$ ls -al /run/xpra
total 4
drwxrwxrwx  2  973 root  80 Dec  3 10:32 .
drwxr-xr-x 28 root root 720 Dec  3 10:31 ..
-rw-------  1 root root   7 Dec  3 10:32 proxy.pid
srw-rw-rw-  1 root xpra   0 Dec  3 10:38 system

I could connect using connect.html.

Then I appended the newly introduced environment variable in the fixes for #2907 to the systemd service:

...
Environment="XPRA_SOCKET_GROUP=students"
...

After init and restart:

$ sudo systemctl stop xpra
$ sudo rm -r /run/xpra
$ sudo systemd-tmpfiles --create --remove
$ ls -al /run/xpra
total 0
drwxrwxr-x  2 root students  40 Dec  3 10:51 .
drwxr-xr-x 28 root root     720 Dec  3 10:51 ..
$ sudo systemctl start xpra
$ ls -al /run/xpra
total 4
drwxrwxr-x  2 root students  80 Dec  3 10:48 .
drwxr-xr-x 28 root root     720 Dec  3 10:47 ..
-rw-------  1 root root       7 Dec  3 10:48 proxy.pid
srw-rw-rw-  1 root xpra       0 Dec  3 10:48 system

Now it works.

My tmpfiles.d config for completeness:

$ cat /etc/tmpfiles.d/xpra.conf               
# This is the shared directory where users of the xpra group
# can place sockets if they want to be able to share them.
d /run/xpra 0775 - students

comment:4 Changed 10 months ago by Antoine Martin

Owner: changed from Antoine Martin to goekce

I renamed two instances of isAlive to is_alive in net/protocol.py, which should probably be fixed, but did not fix the error.

Thanks, applied in r28079.

When I start xpra, then the directory permissions are changed

There should have been a message in your proxy server log.
r28082 fixes some inconsistencies.
Note: this means that XPRA_SOCKET_GROUP no longer works, use XPRA_GROUP (or now you can override XPRA_SOCKET_DIR_GROUP)
And r28083 adds examples to the service EnvironmentFile=-/etc/sysconfig/xpra.

When I connected via connect.html again:
Error starting proxy instance process:
cannot steal a closed connection
(..)
BrokenPipeError: [Errno 32] Broken pipe

This error message could be improved, it's really not obvious at all what the real cause is.

After init and restart:
(..)
Now it works.

So, if I may recap, to tweak the system for your needs - which is to use the students group instead of xpra:

  • change it in /etc/sysconfig/xpra
  • change it in /etc/tmpfiles.d/xpra

Unfortunately, that's 2 places with the same information. Not much we can do about that.

Can we close this ticket?

comment:5 Changed 10 months ago by goekce

There should have been a message in your proxy server log.

You are right! Now I can confirm.


There are two minor mistakes in r28083 : XPRA_ is missing in front of the env. variables. Then we can close it :)


Thank you for pointing out /etc/sysconfig. I noticed now that on Archlinux it is /etc/default (setup.py:1590), and now I am using it without polluting the systemd service file.

What do you think about replacing sysconfig with default in xpra.service if os.path.exists("/etc/default")? Or adding a comment to xpra.service?

Last edited 10 months ago by goekce (previous) (diff)

comment:6 Changed 10 months ago by Antoine Martin

Resolution: fixed
Status: newclosed

XPRA_ is missing in front of the env. variables. Then we can close it :)

Oops. Thanks, fixed in r28084.

What do you think about replacing sysconfig with default in xpra.service if os.path.exists("/etc/default")?
Or adding a comment to xpra.service?

Do you mean that the service file does not point to the correct location on your system? This should be fixed in r28086.

comment:7 in reply to:  6 Changed 10 months ago by goekce

Resolution: fixed
Status: closedreopened

Replying to Antoine Martin:

XPRA_ is missing in front of the env. variables. Then we can close it :)

Oops. Thanks, fixed in r28084.

LGTM!

What do you think about replacing sysconfig with default in xpra.service if os.path.exists("/etc/default")?
Or adding a comment to xpra.service?

Do you mean that the service file does not point to the correct location on your system? This should be fixed in r28086.

Yeah, that was indeed what I wanted to tell, thanks and it works!

But the directory permission problem still exists. You remember:

973 is the group id of xpra. Could it be that xpra sets the permissions in a wrong way?

Steps:

$ rm -rf /run/xpra
$ sudo systemd-tmpfiles --create --remove
$ ls -al /run/xpra
total 0
drwxrwxr-x  2 root students  40 Dec  4 20:06 .
drwxr-xr-x 28 root root     720 Dec  4 20:06 ..

Then I wrongly start xpra with the default /etc/default/xpra file with XPRA_SOCKET_DIR_GROUP=xpra:

$ journalctl -fu xpra
...
Warning: invalid group on '/run/xpra': students
Dec 04 20:08:14 joan xpra[669726]:  changing to 'xpra'
...

but:

$ ls -al /run/xpra
total 4
drwxrwxr-x  2  973 root  80 Dec  4 20:08 .
drwxr-xr-x 28 root root 720 Dec  4 20:06 ..
-rw-------  1 root root   7 Dec  4 20:08 proxy.pid
srw-rw-rw-  1 root xpra   0 Dec  4 20:08 system

After I set XPRA_SOCKET_DIR_GROUP=students and restart:

$ journalctl -fu xpra
Warning: invalid group on '/run/xpra': root
changing to 'students'

$ ls -al /run/xpra
total 4
drwxrwxr-x  2 10001 xpra  80 Dec  4 20:10 .
drwxr-xr-x 28 root  root 720 Dec  4 20:06 ..
-rw-------  1 root  root   7 Dec  4 20:10 proxy.pid
srw-rw-rw-  1 root  xpra   0 Dec  4 20:11 system

Xpra seems to change the owner but not the group.

browser/xpra/trunk/src/xpra/server/proxy/proxy_server.py and probably
browser/xpra/trunk/src/xpra/server/proxy/proxy_server.py should be changed to the right format: os.lchown(path, uid, gid)

Last edited 10 months ago by Antoine Martin (previous) (diff)

comment:8 Changed 10 months ago by Antoine Martin

Xpra seems to change the owner but not the group.

Yup. I had completely messed that up!
How about r28088?

comment:9 in reply to:  8 Changed 10 months ago by goekce

Resolution: fixed
Status: reopenedclosed

LGTM!

I tested it with:

$ sudo systemctl stop xpra
$ sudo rm -rf /run/xpra
$ sudo systemctl start xpra

Xpra even creates /run/xpra by itself. Maybe there is no need for systemd-tmpfiles anymore.

Here are the logs for completeness:

Dec 05 20:51:34 joan xpra[669931]: Proxy Server got signal SIGTERM
Dec 05 20:51:34 joan xpra[669931]: Proxy Server process ended
Dec 05 20:51:34 joan systemd[1]: Stopping Xpra System Server...
Dec 05 20:51:34 joan xpra[669931]: Traceback (most recent call last):
Dec 05 20:51:34 joan xpra[669931]:   File "/usr/lib/python3.9/multiprocessing/queues.py", line 251, in _feed
Dec 05 20:51:34 joan xpra[669931]:     send_bytes(obj)
Dec 05 20:51:34 joan xpra[669931]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 205, in send_bytes
Dec 05 20:51:34 joan xpra[669931]:     self._send_bytes(m[offset:offset + size])
Dec 05 20:51:34 joan xpra[669931]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 416, in _send_byt>
Dec 05 20:51:34 joan xpra[669931]:     self._send(header + buf)
Dec 05 20:51:34 joan xpra[669931]:   File "/usr/lib/python3.9/multiprocessing/connection.py", line 373, in _send
Dec 05 20:51:34 joan xpra[669931]:     n = write(self._handle, buf)
Dec 05 20:51:34 joan xpra[669931]: BrokenPipeError: [Errno 32] Broken pipe
Dec 05 20:51:34 joan xpra[669931]: closing sd listen socket [::]:14500
Dec 05 20:51:34 joan xpra[669931]: closing sd listen socket /run/xpra/system
Dec 05 20:51:34 joan xpra[669931]: Warning: dbus process not found (pid=669940)
Dec 05 20:51:35 joan systemd[1]: xpra.service: Succeeded.
Dec 05 20:51:35 joan systemd[1]: Stopped Xpra System Server.
Dec 05 20:52:01 joan systemd[1]: Started Xpra System Server.
Dec 05 20:52:03 joan xpra[731071]: serving html content from '/usr/share/xpra/www'
Dec 05 20:52:03 joan xpra[731071]: wrote pid 731071 to '/run/xpra/proxy.pid'
Dec 05 20:52:03 joan xpra[731071]: Warning: invalid permissions on '/run/xpra' : 0o40755
Dec 05 20:52:03 joan xpra[731071]:  changing to 0o40775
Dec 05 20:52:03 joan xpra[731071]: Warning: invalid group on '/run/xpra': root
Dec 05 20:52:03 joan xpra[731071]:  changing to 'students'
Dec 05 20:52:03 joan xpra[731071]: xpra is ready.
...

Thanks!

comment:10 Changed 8 months ago by migration script

this ticket has been moved to: https://github.com/Xpra-org/xpra/issues/2964

Note: See TracTickets for help on using tickets.