[gentoo-user-de] Timeouts bei Geraeteerkennung auf einem Thinkpad T410 mit Systemd

[Juergen Rose]

Hallo,

nach dem Booten zeigt mir dmesg eine Menge von Timeouts. Sie scheinen
unter anderen die eingebaute Kamera, das eingebaute USB-Modem und den
Fingerprint-Leser zu betreffen. Die Kamera funktioniert trotz der
Timeouts zu funktionieren, den Fingerprint-Leser und das Modem habe ich
noch nicht getested. Die letzten beiden sind mir bis jetzt auch nicht
wichtig. Schlimmer scheint zu sein, dass der systemd-logind.service und
sendmail.service nicht funktionieren. Das scheint zur Folge zu haben,
dass Login fuer mich (Nutzer rose) und 'su -' zwar funktionieren, aber
sehr lange dauern. Der dbus.service scheint auch nicht richtig zu
funktionieren. 'systemctl status dbus' sagt dass der service
'org.freedesktop.ColorManager' and 'org.freedesktop.hostname1' nicht
aktiviert werden kann. Manchmal funktioniert 'meld' vollstaendig,
manchmal kann es gestartet werden, aber die Menues funktionieren nicht.
Weiterhin scheint auf Grund dieser Probleme das Multi-User-Target
haeufig nicht gestarted zu werden, 'journalctl -u multi-user.target'
zeigt an, dass nach einem Reboot das multi-user.target im gestoppten
(dead, nicht active) Zustand ist. Ich waere fuer jeden Hinweis dankbar.

dmesg:
...
[   35.047095] systemd-sysctl[1911]: Overwriting earlier assignment of
kernel/sysrq in file '/usr/lib64/sysctl.d/60-gentoo.conf'.
[   66.071885] systemd-udevd[1727]: worker
[1778] /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3 timeout; kill it
[   66.995877] systemd-udevd[1781]: timeout
'mtp-probe /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.6 1 5'
[   66.995879] systemd-udevd[1784]: timeout
'mtp-probe /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.4 2 3'
[   76.072105] systemd-udevd[1727]: seq 2789
'/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3' killed
[   77.948158] systemd[1]: Failed to subscribe to NameOwnerChanged
signal: Connection timed out
[   77.997166] systemd-udevd[1784]: timeout: killing
'mtp-probe /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.4 2
3' [1968]
[   77.998088] systemd-udevd[1781]: timeout: killing
'mtp-probe /sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.6 1
5' [1969]
[   86.072355] systemd-udevd[1727]: worker
[1781] /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.6 timeout; kill it
[   87.997441] systemd-udevd[1784]:
'mtp-probe /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.4 2
3' [1968] terminated by signal 9 (Killed)
[   96.072667] systemd-udevd[1727]: seq 2796
'/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.6' killed
[   97.999680] systemd-udevd[1784]: timeout
'/lib/udev/VBoxCreateUSBNode.sh 189 130 00'
[  106.072924] systemd-udevd[1727]: worker
[1784] /devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.4 timeout; kill it
[  116.073141] systemd-udevd[1727]: seq 2817
'/devices/pci0000:00/0000:00:1d.0/usb2/2-1/2-1.4' killed
[  116.105931] Linux video capture interface: v2.00
[  116.120847] usbcore: registered new interface driver usbserial
[  116.127977] usbcore: registered new interface driver qcserial
[  116.128305] usbserial: USB Serial support registered for Qualcomm USB
modem
[  116.128582] qcserial 2-1.4:1.1: Qualcomm USB modem converter detected
[  116.129254] usb 2-1.4: Qualcomm USB modem converter now attached to
ttyUSB0
[  116.129928] uvcvideo: Found UVC 1.00 device Integrated Camera
(17ef:480f)
[  116.131890] input: Integrated Camera
as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.6/1-1.6:1.0/input/input10
[  116.132615] usbcore: registered new interface driver uvcvideo
[  116.133110] USB Video Class driver (1.1.1)
[  126.074412] systemd-udevd[1779]: error opening
ATTR{/sys/devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3/1-1.3:1.0/power/control} for writing: Permission denied
[  126.075332] systemd-udevd[1727]: worker [1778] terminated by signal 9
(Killed)
[  128.009483] systemd[1]: Failed to subscribe to activation signal:
Connection timed out
[  136.075694] systemd-udevd[1727]: worker [1781] terminated by signal 9
(Killed)
[  146.075917] systemd-udevd[1727]: worker [1784] terminated by signal 9
(Killed)
[  153.045105] systemd[1]: Failed to register name: Connection timed out
[  153.055108] systemd[1]: Failed to set up API bus: Connection timed
out
[  153.182054] systemd[1]: sendmail.service start-pre operation timed
out. Terminating.
[  153.195094] systemd[1]: systemd-logind.service start operation timed
out. Terminating.
[  153.331094] systemd[1]: Unit systemd-logind.service entered failed
state.
[  153.333348] iwlwifi 0000:03:00.0: L1 Enabled; Disabling L0S
[  153.340135] iwlwifi 0000:03:00.0: Radio type=0x0-0x3-0x1
[  153.374118] systemd[1]: Unit sendmail.service entered failed state.
[  153.385058] systemd[1]: systemd-logind.service has no holdoff time,
scheduling restart.
...

root@gepard:/root(6)# systemctl status sendmail.service
● sendmail.service - Sendmail Mail Transport Agent
   Loaded: loaded (/usr/lib64/systemd/system/sendmail.service; enabled)
   Active: failed (Result: timeout) since Tue 2014-10-07 07:56:50 CEST;
26min ago
  Process: 2046 ExecStartPre=/bin/rm -f /var/spool/mqueue/xf*
(code=exited, status=0/SUCCESS)
  Process: 1801 ExecStartPre=/usr/bin/newaliases (code=exited,
status=0/SUCCESS)

root@gepard:/root(7)# systemctl status systemd-logind.service
● systemd-logind.service - Login Service
   Loaded: loaded (/usr/lib64/systemd/system/systemd-logind.service;
static)
   Active: activating (start) since Tue 2014-10-07 08:22:24 CEST; 1min
22s ago
     Docs: man:systemd-logind.service(8)
           man:logind.conf(5)
           http://www.freedesktop.org/wiki/Software/systemd/logind
           http://www.freedesktop.org/wiki/Software/systemd/multiseat
 Main PID: 3255 (systemd-logind)
   Status: "Processing requests..."
   CGroup: /system.slice/systemd-logind.service
           └─3255 /usr/lib/systemd/systemd-logind

Oct 07 08:22:24 gepard systemd-logind[3255]: New seat seat0.
Oct 07 08:22:24 gepard systemd-logind[3255]: Watching system buttons
on /dev/input/event4 (Power Button)
Oct 07 08:22:24 gepard systemd-logind[3255]: Watching system buttons
on /dev/input/event0 (Video Bus)
Oct 07 08:22:24 gepard systemd-logind[3255]: Watching system buttons
on /dev/input/event2 (Lid Switch)
Oct 07 08:22:24 gepard systemd-logind[3255]: Watching system buttons
on /dev/input/event3 (Sleep Button)
Oct 07 08:22:24 gepard systemd-logind[3255]: Watching system buttons
on /dev/input/event6 (ThinkPad Extra Buttons)
Oct 07 08:22:24 gepard systemd-logind[3255]: New session c1 of user
root.
Oct 07 08:22:24 gepard systemd-logind[3255]: New session 1 of user rose.

root@gepard:/root(8)# systemctl status dbus
● dbus.service - D-Bus System Message Bus
   Loaded: loaded (/usr/lib64/systemd/system/dbus.service; static)
   Active: active (running) since Tue 2014-10-07 07:54:35 CEST; 31min
ago
     Docs: man:dbus-daemon(1)
 Main PID: 1829 (dbus-daemon)
   CGroup: /system.slice/dbus.service
           └─1829 /usr/bin/dbus-daemon --system --address=systemd:
--nofork --nopidfile --systemd-activation

Oct 07 07:56:50 gepard dbus[1829]: [system] Activating systemd to
hand-off: service name='org.freedesktop.ColorManager'
unit='colord.service'
Oct 07 07:56:50 gepard dbus[1829]: [system] Failed to activate service
'org.freedesktop.ColorManager': timed out
Oct 07 07:56:50 gepard dbus[1829]: [system] Activating systemd to
hand-off: service name='org.freedesktop.ColorManager'
unit='colord.service'
Oct 07 07:56:50 gepard dbus[1829]: [system] Successfully activated
service 'org.freedesktop.systemd1'
Oct 07 07:57:15 gepard dbus[1829]: [system] Failed to activate service
'org.freedesktop.ColorManager': timed out
Oct 07 08:01:56 gepard dbus[1829]: [system] Activating via systemd:
service name='org.freedesktop.hostname1'
unit='dbus-org.freedesktop.hostname1.service'
Oct 07 08:02:21 gepard dbus[1829]: [system] Failed to activate service
'org.freedesktop.hostname1': timed out


root@gepard:/root(12)# journalctl -u multi-user.target | tail -n 20
Oct 05 18:32:56 gepard systemd[1]: Stopping Multi-User System.
Oct 05 18:32:56 gepard systemd[1]: Stopped target Multi-User System.
-- Reboot --
Oct 05 18:33:49 gepard systemd[1]: Starting Multi-User System.
Oct 05 18:33:49 gepard systemd[1]: Reached target Multi-User System.
Oct 05 18:42:05 gepard systemd[1]: Stopping Multi-User System.
Oct 05 18:42:05 gepard systemd[1]: Stopped target Multi-User System.
-- Reboot --
Oct 05 19:16:20 gepard systemd[1]: Stopped target Multi-User System.
-- Reboot --
Oct 05 19:17:13 gepard systemd[1]: Starting Multi-User System.
Oct 05 19:17:13 gepard systemd[1]: Reached target Multi-User System.
Oct 05 19:37:20 gepard systemd[1]: Stopping Multi-User System.
Oct 05 19:37:20 gepard systemd[1]: Stopped target Multi-User System.
-- Reboot --
Oct 05 20:14:54 gepard systemd[1]: Stopped target Multi-User System.
-- Reboot --
Oct 06 19:27:37 gepard systemd[1]: Stopped target Multi-User System.
-- Reboot --
Oct 07 07:53:58 gepard systemd[1]: Stopped target Multi-User System.
root@gepard:/root(13)# systemctl status multi-user.target
● multi-user.target - Multi-User System
   Loaded: loaded (/usr/lib64/systemd/system/multi-user.target; static)
   Active: inactive (dead)
     Docs: man:systemd.special(7)