[Pkg-utopia-maintainers] Bug#884897: Fwd: Bug#884897: dbus-x11: .xinitrc requires "dbus-update-activation-environment --all"

Carlos Eduardo Moreira dos Santos cems at cemshost.com.br
Thu Dec 21 15:42:26 UTC 2017


Thank you. While debugging, I think I found the problem of the slow startx:
xauth's segfault. I'm going to search for this bug. Your answers:

On Thu, Dec 21, 2017 at 6:44 AM, Simon McVittie <smcv at debian.org> wrote:

> Control: tags -1 + moreinfo
>
> On Thu, 21 Dec 2017 at 01:34:32 -0200, Carlos Eduardo M. Santos wrote:
> > The following problems started after dist-upgrading from jessie to buster
>
> I hope you upgraded from jessie to stretch first, and then from stretch
> to buster. Upgrades that skip a release are not supported by Debian.
> (If it worked, then it's *probably* OK, but please go via stretch on any
> other machines you upgrade in the same way.)
>

I upgraded from stretch. I'm sorry, I got confused with the names.

>
> > 1. startx takes a lot of time to launch X;
> > 2. gnome-terminal doesn't start.
>
> How do you get into the environment from which you run startx? Is it a
> text-mode console (getty/login) or something else?
>

tty

>
> Is dbus-user-session installed? Is libpam-systemd installed?
>

dbus-user-session/testing,now 1.12.2-1 amd64
libpam-systemd/testing,now 235-3 amd64

>
> What's in your /etc/X11/Xsession.options?
>

allow-failsafe
allow-user-resources
allow-user-xsession
use-ssh-agent
use-session-dbus

>
> If you drop a script into /etc/X11/Xsession.d/01debug-early or similar
> that runs
>
>     env | LC_ALL=C sort | logger -t Xsession-early
>
> then look at the systemd journal, what environment variables are set
> there? (In particular LANG, LANGUAGE, LC_anything, DBUS_anything,
> XDG_RUNTIME_DIR)
>
> Similarly, if you put
>
>     env | LC_ALL=C sort | logger -t Xsession-late
>
> right at the beginning of 95dbus_update-activation-env, what happens there?
>

In both cases, there's no output in journal. I'm afraid the files in its dir
are not being read. However, I manually ran these commands in xterm with the
marker "xterm". There's no DBUS related variable:

Dec 21 12:48:12 kytos xterm[19709]: LANG=en_US.UTF-8
Dec 21 12:48:12 kytos xterm[19709]: SHELL=/bin/zsh
Dec 21 12:48:12 kytos xterm[19709]: XAUTHORITY=/home/cemsbr/.Xauthority
Dec 21 12:48:12 kytos xterm[19709]: XDG_RUNTIME_DIR=/run/user/1000
Dec 21 12:48:12 kytos xterm[19709]: XTERM_LOCALE=en_US.UTF-8
Dec 21 12:48:12 kytos xterm[19709]: XTERM_SHELL=/bin/zsh


> > In journalctl, I found 2 famous messages:
> > - gnome-terminal-server[18005]: Unable to init server: Could not
> connect: Connection refused
> > - Failed to activate service 'org.gnome.Terminal': timed out
> (service_start_timeout=120000ms)
>
> I'm sure you get more messages than just those two. Please show me the
> rest of what's logged when you:
>
> - start from not being logged in
> - log in at the text-mode prompt, or whatever else you do to get into the
>   environment from which you want to run startx
> - put a marker in the log: logger -t marker "now I am logged in"
> - run startx
>

- journalctl_report.txt: Note: I had to switch to tty2 and kill Xorg to
quit;
- journalctl_report_workaround.txt: a successful launch of gnome-terminal
using the workaround in .xinitrc.

>
> The output of systemd-cgls after you get into your GUI session (use
> a non-D-Bus-related terminal like xterm) would also be useful
> information.
>

systemd-cgls.txt

>
> Regards,
>     smcv
>

Best,
cems
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.alioth.debian.org/pipermail/pkg-utopia-maintainers/attachments/20171221/c1f544dd/attachment-0001.html>
-------------- next part --------------
Dec 21 12:22:35 kytos kernel: xauth[13999]: segfault at 1 ip 00007f70be84e405 sp 00007fff744a2a28 error 4 in libc-2.25.so[7f70be7b8000+199000]
Dec 21 12:18:13 kytos login[12126]: pam_unix(login:session): session opened for user cemsbr by LOGIN(uid=0)
Dec 21 12:18:13 kytos systemd[1]: Created slice User Slice of cemsbr.
Dec 21 12:18:13 kytos systemd[1]: Starting User Manager for UID 1000...
Dec 21 12:18:13 kytos systemd-logind[888]: New session 17 of user cemsbr.
Dec 21 12:18:13 kytos systemd[1]: Started Session 17 of user cemsbr.
Dec 21 12:18:13 kytos systemd[12136]: pam_unix(systemd-user:session): session opened for user cemsbr by (uid=0)
Dec 21 12:18:13 kytos systemd[12136]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
Dec 21 12:18:13 kytos systemd[12136]: Reached target Timers.
Dec 21 12:18:13 kytos systemd[12136]: Reached target Paths.
Dec 21 12:18:13 kytos systemd[12136]: Listening on Sound System.
Dec 21 12:18:13 kytos systemd[12136]: Listening on GnuPG cryptographic agent (ssh-agent emulation).
Dec 21 12:18:13 kytos systemd[12136]: Listening on GnuPG network certificate management daemon.
Dec 21 12:18:13 kytos systemd[12136]: Starting D-Bus User Message Bus Socket.
Dec 21 12:18:13 kytos systemd[12136]: Listening on GnuPG cryptographic agent and passphrase cache.
Dec 21 12:18:13 kytos systemd[12136]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
Dec 21 12:18:13 kytos systemd[12136]: Listening on D-Bus User Message Bus Socket.
Dec 21 12:18:13 kytos systemd[12136]: Reached target Sockets.
Dec 21 12:18:13 kytos systemd[12136]: Reached target Basic System.
Dec 21 12:18:13 kytos systemd[12136]: Reached target Default.
Dec 21 12:18:13 kytos systemd[12136]: Startup finished in 17ms.
Dec 21 12:18:13 kytos systemd[1]: Started User Manager for UID 1000.
Dec 21 12:18:20 kytos marker[12351]: Now I am logged in
Dec 21 12:18:34 kytos kernel: xauth[12556]: segfault at 1 ip 00007f058e06d405 sp 00007fff095bb9e8 error 4 in libc-2.25.so[7f058dfd7000+199000]
Dec 21 12:18:54 kytos pkexec[12566]: pam_unix(polkit-1:session): session opened for user root by (uid=1000)
Dec 21 12:18:54 kytos pkexec[12566]: cemsbr: Executing command [USER=root] [TTY=unknown] [CWD=/home/cemsbr] [COMMAND=/usr/lib/xserver-xorg-video-intel/xf86-video-intel-backlight-helper intel_backlight]
Dec 21 12:19:34 kytos marker[12982]: Launching gnome-terminal
Dec 21 12:19:48 kytos systemd[12136]: Started D-Bus User Message Bus.
Dec 21 12:19:48 kytos dbus-daemon[13163]: [session uid=1000 pid=13163] Activating via systemd: service name='org.a11y.Bus' unit='at-spi-dbus-bus.service' requested by ':1.1' (uid=1000 pid=13161 comm="/usr/bin/gnome-terminal ")
Dec 21 12:19:48 kytos systemd[12136]: Starting Accessibility services bus...
Dec 21 12:19:48 kytos dbus-daemon[13163]: [session uid=1000 pid=13163] Successfully activated service 'org.a11y.Bus'
Dec 21 12:19:48 kytos systemd[12136]: Started Accessibility services bus.
Dec 21 12:19:48 kytos at-spi-bus-launcher[13164]: dbus-daemon[13169]: Activating service name='org.a11y.atspi.Registry' requested by ':1.0' (uid=1000 pid=13161 comm="/usr/bin/gnome-terminal ")
Dec 21 12:19:48 kytos dbus-daemon[13163]: [session uid=1000 pid=13163] Activating via systemd: service name='org.gnome.Terminal' unit='gnome-terminal-server.service' requested by ':1.3' (uid=1000 pid=13161 comm="/usr/bin/gnome-terminal ")
Dec 21 12:19:48 kytos systemd[12136]: Starting GNOME Terminal Server...
Dec 21 12:19:48 kytos at-spi-bus-launcher[13164]: dbus-daemon[13169]: Successfully activated service 'org.a11y.atspi.Registry'
Dec 21 12:19:48 kytos at-spi-bus-launcher[13164]: SpiRegistry daemon is running with well-known name - org.a11y.atspi.Registry
Dec 21 12:19:48 kytos gnome-terminal-server[13174]: Unable to init server: Could not connect: Connection refused
Dec 21 12:19:48 kytos gnome-terminal-server[13174]: Failed to parse arguments: Cannot open display:
Dec 21 12:19:48 kytos systemd[12136]: gnome-terminal-server.service: Main process exited, code=exited, status=10/n/a
Dec 21 12:19:48 kytos systemd[12136]: gnome-terminal-server.service: Failed with result 'exit-code'.
Dec 21 12:19:48 kytos systemd[12136]: Failed to start GNOME Terminal Server.
Dec 21 12:20:35 kytos marker[13268]: Quitting
Dec 21 12:21:55 kytos systemd[1]: getty at tty2.service: Service has no hold-off time, scheduling restart.
Dec 21 12:21:55 kytos systemd[1]: getty at tty2.service: Scheduled restart job, restart counter is at 5.
Dec 21 12:21:55 kytos systemd[1]: Stopped Getty on tty2.
Dec 21 12:21:55 kytos systemd[1]: Started Getty on tty2.
Dec 21 12:21:55 kytos systemd-logind[888]: Removed session 19.
Dec 21 12:22:07 kytos login[12126]: pam_unix(login:session): session closed for user cemsbr
Dec 21 12:22:07 kytos systemd[1]: getty at tty1.service: Service has no hold-off time, scheduling restart.
Dec 21 12:22:07 kytos systemd[1]: getty at tty1.service: Scheduled restart job, restart counter is at 5.
Dec 21 12:22:07 kytos systemd[1]: Stopped Getty on tty1.
Dec 21 12:22:07 kytos systemd[1]: Started Getty on tty1.
Dec 21 12:22:07 kytos systemd-logind[888]: Removed session 17.
Dec 21 12:22:07 kytos systemd[1]: Stopping User Manager for UID 1000...
Dec 21 12:22:07 kytos systemd[12136]: Stopping D-Bus User Message Bus...
Dec 21 12:22:07 kytos systemd[12136]: Stopping Accessibility services bus...
Dec 21 12:22:07 kytos systemd[12136]: Stopped target Default.
Dec 21 12:22:07 kytos systemd[12136]: Stopped D-Bus User Message Bus.
Dec 21 12:22:07 kytos systemd[12136]: Stopped Accessibility services bus.
Dec 21 12:22:07 kytos systemd[12136]: Stopped target Basic System.
Dec 21 12:22:07 kytos systemd[12136]: Stopped target Sockets.
Dec 21 12:22:07 kytos systemd[12136]: Closed GnuPG cryptographic agent (ssh-agent emulation).
Dec 21 12:22:07 kytos systemd[12136]: Closed GnuPG cryptographic agent and passphrase cache (access for web browsers).
Dec 21 12:22:07 kytos systemd[12136]: Closed Sound System.
Dec 21 12:22:07 kytos systemd[12136]: Closed GnuPG cryptographic agent and passphrase cache (restricted).
Dec 21 12:22:07 kytos systemd[12136]: Closed GnuPG network certificate management daemon.
Dec 21 12:22:07 kytos systemd[12136]: Closed GnuPG cryptographic agent and passphrase cache.
Dec 21 12:22:07 kytos systemd[12136]: Stopped target Paths.
Dec 21 12:22:07 kytos systemd[12136]: Stopped target Timers.
Dec 21 12:22:07 kytos systemd[12136]: Closed D-Bus User Message Bus Socket.
Dec 21 12:22:07 kytos systemd[12136]: Reached target Shutdown.
Dec 21 12:22:07 kytos systemd[12136]: Starting Exit the Session...
Dec 21 12:22:07 kytos systemd[12136]: Received SIGRTMIN+24 from PID 13678 (kill).
Dec 21 12:22:07 kytos systemd[12137]: pam_unix(systemd-user:session): session closed for user cemsbr
Dec 21 12:22:07 kytos systemd[1]: Stopped User Manager for UID 1000.
Dec 21 12:22:07 kytos systemd[1]: Removed slice User Slice of cemsbr.
-------------- next part --------------
Dec 21 12:22:55 kytos pkexec[14007]: pam_unix(polkit-1:session): session opened for user root by (uid=1000)
Dec 21 12:22:55 kytos pkexec[14007]: cemsbr: Executing command [USER=root] [TTY=unknown] [CWD=/home/cemsbr] [COMMAND=/usr/lib/xserver-xorg-video-intel/xf86-video-intel-backlight-helper intel_backlight]
Dec 21 12:22:55 kytos systemd[13683]: Started D-Bus User Message Bus.
Dec 21 12:23:00 kytos dbus-daemon[14017]: [session uid=1000 pid=14017] Activating via systemd: service name='org.a11y.Bus' unit='at-spi-dbus-bus.service' requested by ':1.2' (uid=1000 pid=14164 comm="/usr/bin/gnome-terminal --hide-menubar ")
Dec 21 12:23:00 kytos systemd[13683]: Starting Accessibility services bus...
Dec 21 12:23:00 kytos dbus-daemon[14017]: [session uid=1000 pid=14017] Successfully activated service 'org.a11y.Bus'
Dec 21 12:23:00 kytos systemd[13683]: Started Accessibility services bus.
Dec 21 12:23:00 kytos at-spi-bus-launcher[14168]: dbus-daemon[14173]: Activating service name='org.a11y.atspi.Registry' requested by ':1.0' (uid=1000 pid=14164 comm="/usr/bin/gnome-terminal --hide-menubar ")
Dec 21 12:23:00 kytos dbus-daemon[14017]: [session uid=1000 pid=14017] Activating via systemd: service name='org.gnome.Terminal' unit='gnome-terminal-server.service' requested by ':1.4' (uid=1000 pid=14164 comm="/usr/bin/gnome-terminal --hide-menubar ")
Dec 21 12:23:00 kytos systemd[13683]: Starting GNOME Terminal Server...
Dec 21 12:23:00 kytos at-spi-bus-launcher[14168]: dbus-daemon[14173]: Successfully activated service 'org.a11y.atspi.Registry'
Dec 21 12:23:00 kytos at-spi-bus-launcher[14168]: SpiRegistry daemon is running with well-known name - org.a11y.atspi.Registry
Dec 21 12:23:00 kytos dbus-daemon[14017]: [session uid=1000 pid=14017] Successfully activated service 'org.gnome.Terminal'
Dec 21 12:23:00 kytos systemd[13683]: Started GNOME Terminal Server.
-------------- next part --------------
Control group /:
-.slice
├─user.slice
│ └─user-1000.slice
│   ├─user at 1000.service
│   │ └─init.scope
│   │   ├─12136 /lib/systemd/systemd --user
│   │   └─12137 (sd-pam)
│   └─session-17.scope
│     ├─12126 /bin/login -p --
│     ├─12147 -zsh
│     ├─12537 /bin/sh /usr/bin/startx
│     ├─12561 xinit /home/cemsbr/.xinitrc -- /etc/X11/xinit/xserverrc :0 vt1...
│     ├─12562 /usr/lib/xorg/Xorg -nolisten tcp :0 vt1 -keeptty -auth /tmp/ser...
│     ├─12566 /usr/lib/xserver-xorg-video-intel/xf86-video-intel-backlight-he...
│     ├─12574 i3
│     ├─12584 /bin/sh -c i3bar --bar_id=bar-0 --socket="/run/user/1000/i3/ipc...
│     ├─12585 i3bar --bar_id=bar-0 --socket=/run/user/1000/i3/ipc-socket.12574
│     ├─12586 /bin/sh -c i3status | i3status.pl
│     ├─12587 i3status
│     ├─12588 perl /home/cemsbr/bin/i3status.pl
│     ├─12600 /bin/zsh
│     ├─12726 xterm
│     ├─12728 zsh
│     └─12921 systemd-cgls
├─init.scope
│ └─1 /sbin/init
└─system.slice
  ├─irqbalance.service
  │ └─886 /usr/sbin/irqbalance --foreground
  ├─lvm2-lvmetad.service
  │ └─329 /sbin/lvmetad -f
  ├─systemd-timesyncd.service
  │ └─725 /lib/systemd/systemd-timesyncd
  ├─bumblebeed.service
  │ └─882 /usr/sbin/bumblebeed
  ├─dbus.service
  │ └─820 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfi...
  ├─dnscrypt-proxy.service
  │ └─12559 /usr/sbin/dnscrypt-proxy /etc/dnscrypt-proxy/dnscrypt-proxy.conf
  ├─system-getty.slice
  │ └─getty at tty2.service
  │   └─12130 /sbin/agetty -o -p -- \u --noclear tty2 linux
  ├─smartd.service
  │ └─885 /usr/sbin/smartd -n
  ├─systemd-logind.service
  │ └─888 /lib/systemd/systemd-logind
  ├─minissdpd.service
  │ └─981 /usr/sbin/minissdpd -i 0.0.0.0
  ├─polkit.service
  │ └─938 /usr/lib/policykit-1/polkitd --no-debug
  ├─cron.service
  │ └─804 /usr/sbin/cron -f
  ├─systemd-udevd.service
  │ └─331 /lib/systemd/systemd-udevd
  ├─rsyslog.service
  │ └─883 /usr/sbin/rsyslogd -n
  └─systemd-journald.service
    └─315 /lib/systemd/systemd-journald


More information about the Pkg-utopia-maintainers mailing list