Gentoo Websites Logo
Go to: Gentoo Home Documentation Forums Lists Bugs Planet Store Wiki Get Gentoo!
Bug 733890 - x11-base/xorg-server USE=-suid - startx fails to start (Permission denied)
Summary: x11-base/xorg-server USE=-suid - startx fails to start (Permission denied)
Status: RESOLVED FIXED
Alias: None
Product: Gentoo Linux
Classification: Unclassified
Component: Current packages (show other bugs)
Hardware: All Linux
: Normal normal (vote)
Assignee: Gentoo X packagers
URL:
Whiteboard:
Keywords:
Depends on:
Blocks:
 
Reported: 2020-07-25 14:19 UTC by Vitaly Zdanevich
Modified: 2020-08-02 17:23 UTC (History)
3 users (show)

See Also:
Package list:
Runtime testing required: ---


Attachments
/var/log/messages (resp.txt,61.63 KB, text/plain)
2020-08-01 15:22 UTC, Vitaly Zdanevich
Details
dmesg of another PC with Gentoo and the same problem (dmesg.txt,53.90 KB, text/plain)
2020-08-01 16:51 UTC, Vitaly Zdanevich
Details

Note You need to log in before you can comment on or make changes to this bug.
Description Vitaly Zdanevich 2020-07-25 14:19:27 UTC
I see error message that permission to /dev/tty0 is denied. Looks like regular world update broke something. Suid is disabled.

And what is the correct way to fix it on my system?
Comment 1 Vitaly Zdanevich 2020-07-26 09:14:16 UTC
My emerge --info;
=================================================================
System uname: Linux-5.4.48-gentoo+-i686-Intel-R-_Core-TM-_i5-3320M_CPU_@_2.60GHz-with-gentoo-2.6
KiB Mem:     3326500 total,   1849800 free
KiB Swap:    4194300 total,   4194300 free
Timestamp of repository gentoo: Sun, 26 Jul 2020 07:00:01 +0000
Head commit of repository gentoo: 44e81ac0741c6011f0e3ae6d6af10379bdbde34f
sh bash 5.0_p17
ld GNU ld (Gentoo 2.33.1 p2) 2.33.1
app-shells/bash:          5.0_p17::gentoo
dev-lang/perl:            5.30.3::gentoo
dev-lang/python:          2.7.18-r1::gentoo, 3.7.8-r2::gentoo, 3.8.4-r1::gentoo
dev-util/cmake:           3.16.5::gentoo
sys-apps/baselayout:      2.6-r1::gentoo
sys-apps/openrc:          0.42.1::gentoo
sys-apps/sandbox:         2.18::gentoo
sys-devel/autoconf:       2.13-r1::gentoo, 2.69-r4::gentoo
sys-devel/automake:       1.16.1-r1::gentoo
sys-devel/binutils:       2.33.1-r1::gentoo
sys-devel/gcc:            9.3.0-r1::gentoo
sys-devel/gcc-config:     2.3::gentoo
sys-devel/libtool:        2.4.6-r6::gentoo
sys-devel/make:           4.2.1-r4::gentoo
sys-kernel/linux-headers: 5.4-r1::gentoo (virtual/os-headers)
sys-libs/glibc:           2.30-r8::gentoo
Repositories:

gentoo
    location: /var/db/repos/gentoo
    sync-type: rsync
    sync-uri: rsync://rsync.gentoo.org/gentoo-portage
    priority: -1000
    sync-rsync-verify-max-age: 24
    sync-rsync-verify-jobs: 1
    sync-rsync-verify-metamanifest: yes
    sync-rsync-extra-opts: 

ACCEPT_KEYWORDS="x86"
ACCEPT_LICENSE="@FREE @FREE ipw3945"
CBUILD="i686-pc-linux-gnu"
CFLAGS="-O2 -march=ivybridge -pipe"
CHOST="i686-pc-linux-gnu"
CONFIG_PROTECT="/etc /usr/share/gnupg/qualified.txt"
CONFIG_PROTECT_MASK="/etc/ca-certificates.conf /etc/dconf /etc/env.d /etc/fonts/fonts.conf /etc/gconf /etc/gentoo-release /etc/revdep-rebuild /etc/sandbox.d /etc/terminfo"
CXXFLAGS="-O2 -march=ivybridge -pipe"
DISTDIR="/var/cache/distfiles"
ENV_UNSET="DBUS_SESSION_BUS_ADDRESS DISPLAY GOBIN GOPATH PERL5LIB PERL5OPT PERLPREFIX PERL_CORE PERL_MB_OPT PERL_MM_OPT XAUTHORITY XDG_CACHE_HOME XDG_CONFIG_HOME XDG_DATA_HOME XDG_RUNTIME_DIR"
FCFLAGS="-O2 -march=ivybridge -pipe"
FEATURES="assume-digests binpkg-docompress binpkg-dostrip binpkg-logs config-protect-if-modified distlocks ebuild-locks fixlafiles ipc-sandbox merge-sync multilib-strict network-sandbox news parallel-fetch pid-sandbox preserve-libs protect-owned qa-unresolved-soname-deps sandbox sfperms strict unknown-features-warn unmerge-logs unmerge-orphans userfetch userpriv usersandbox usersync xattr"
FFLAGS="-O2 -march=ivybridge -pipe"
GENTOO_MIRRORS="http://distfiles.gentoo.org"
LDFLAGS="-Wl,-O1 -Wl,--as-needed"
PKGDIR="/var/cache/binpkgs"
PORTAGE_CONFIGROOT="/"
PORTAGE_RSYNC_OPTS="--recursive --links --safe-links --perms --times --omit-dir-times --compress --force --whole-file --delete --stats --human-readable --timeout=180 --exclude=/distfiles --exclude=/local --exclude=/packages --exclude=/.git"
PORTAGE_TMPDIR="/var/tmp"
USE="X a52 aac acl acpi alsa berkdb bluetooth branding bzip2 cairo cdr cli crypt dbus dri dts dvdr elogind emboss encode exif flac fortran gdbm gif glamor gpm gtk iconv icu ipv6 jpeg lcms ldap libinput libnotify libtirpc mad mng mp3 mp4 mpeg ncurses nls nptl ogg opengl openmp pam pango pcre pdf png policykit ppds readline sdl seccomp spell split-usr ssl startup-notification svg tcpd tiff truetype udev udisks unicode upower usb vorbis vpx wxwidgets x264 x86 xattr xcb xml xv xvid zlib" ABI_X86="32" ADA_TARGET="gnat_2018" ALSA_CARDS="ali5451 als4000 atiixp atiixp-modem bt87x ca0106 cmipci emu10k1 emu10k1x ens1370 ens1371 es1938 es1968 fm801 hda-intel intel8x0 intel8x0m maestro3 trident usb-audio via82xx via82xx-modem ymfpci" APACHE2_MODULES="authn_core authz_core socache_shmcb unixd actions alias auth_basic authn_alias authn_anon authn_dbm authn_default authn_file authz_dbm authz_default authz_groupfile authz_host authz_owner authz_user autoindex cache cgi cgid dav dav_fs dav_lock deflate dir disk_cache env expires ext_filter file_cache filter headers include info log_config logio mem_cache mime mime_magic negotiation rewrite setenvif speling status unique_id userdir usertrack vhost_alias" CALLIGRA_FEATURES="karbon sheets words" COLLECTD_PLUGINS="df interface irq load memory rrdtool swap syslog" CPU_FLAGS_X86="aes avx f16c mmx mmxext pclmul popcnt sse sse2 sse3 sse4_1 sse4_2 ssse3" ELIBC="glibc" GPSD_PROTOCOLS="ashtech aivdm earthmate evermore fv18 garmin garmintxt gpsclock greis isync itrax mtk3301 nmea ntrip navcom oceanserver oldstyle oncore rtcm104v2 rtcm104v3 sirf skytraq superstar2 timing tsip tripmate tnt ublox ubx" GRUB_PLATFORMS="pc" INPUT_DEVICES="libinput" KERNEL="linux" LCD_DEVICES="bayrad cfontz cfontz633 glk hd44780 lb216 lcdm001 mtxorb ncurses text" LIBREOFFICE_EXTENSIONS="presenter-console presenter-minimizer" OFFICE_IMPLEMENTATION="libreoffice" PHP_TARGETS="php7-2 php7-3" POSTGRES_TARGETS="postgres10 postgres11" PYTHON_SINGLE_TARGET="python3_7" PYTHON_TARGETS="python2_7 python3_7" RUBY_TARGETS="ruby25" USERLAND="GNU" VIDEO_CARDS="intel i965" XTABLES_ADDONS="quota2 psd pknock lscan length2 ipv4options ipset ipp2p iface geoip fuzzy condition tee tarpit sysrq steal rawnat logmark ipmark dhcpmac delude chaos account"
Unset:  CC, CPPFLAGS, CTARGET, CXX, EMERGE_DEFAULT_OPTS, INSTALL_MASK, LANG, LC_ALL, LINGUAS, MAKEOPTS, PORTAGE_BINHOST, PORTAGE_BUNZIP2_COMMAND, PORTAGE_COMPRESS, PORTAGE_COMPRESS_FLAGS, PORTAGE_RSYNC_EXTRA_OPTS
Comment 2 Brandon Sakai 2020-07-27 06:31:21 UTC
Same issue (AMD64). Adding +elogind USE flag allowed the X server to start, but starts my WM on tty1 instead of tty7 (where it was before) and has some minor latency issues and screen tearing on Firefox when scrolling and typing. Weird thing is, I updated yesterday and rebooted, it worked this morning, and then stopped working this evening after another reboot.

$ equery which xorg-server
/var/db/repos/gentoo/x11-base/xorg-server/xorg-server-1.20.8-r1.ebuild

$ equery -q u xorg-server
-debug
-dmx
-doc
+elogind
+ipv6
-kdrive
+libglvnd
-libressl
-minimal
-static-libs
-suid
-systemd
+udev
-unwind
-wayland
-xcsecurity
-xephyr
-xnest
+xorg
-xvfb
Comment 3 Vitaly Zdanevich 2020-07-27 07:58:56 UTC
About my problem: I remember that before that problem I tried to emerge Chromium (without success because of not enough RAM), and Chromium was with suid, maybe this process broke something.

@Brandon Sakai against tearing on my another machine I use Sway https://packages.gentoo.org/packages/gui-wm/sway  with Wayland instead of Xorg with i3. And for Intel GPU you can try this https://wiki.gentoo.org/wiki/Lenovo_Thinkpad_T430#Fix_screen_tearing
Comment 4 Brandon Sakai 2020-07-27 08:24:30 UTC
I masked xorg-server-1.20.8-r1 and downgraded to xorg-server-1.20.8, now works perfectly. Here's the bug as near as I can tell: xorg-server-1.20.8-r1 recently became stable on both amd64 and x86 (https://github.com/gentoo-mirror/gentoo/commit/2bedc9dc1b06d8b720a233283107db3786085d64). xorg-server-1.20.8-r1 changes the default use flags from -elogind +suid to +elogind -suid. I have USE -elogind set, so when I updated both elogind and suid were disabled. That means permissions errors. There's also some other modifications to the way that suid works in -r1 which I don't fully understand.
So it seems like the fix is to enable either suid or elogind

Also - How in the world did you know that I used i3 on this machine?
Comment 5 Francesco Turco 2020-07-27 10:52:17 UTC
Did you read the following news item?
https://gentoo.org/support/news-items/2020-06-24-xorg-server-dropping-default-suid.html
Comment 6 Vitaly Zdanevich 2020-07-28 04:27:53 UTC
(In reply to Brandon Sakai from comment #4)
 
> Also - How in the world did you know that I used i3 on this machine?

Just because I use i3 on one machine and Sway on another, I mention i3.
Comment 7 Vitaly Zdanevich 2020-07-28 04:29:53 UTC
(In reply to Francesco Turco from comment #5)
> Did you read the following news item?
> https://gentoo.org/support/news-items/2020-06-24-xorg-server-dropping-
> default-suid.html

I have a desktop profile, so according to this message I do not need to do anything:
"The systemd users and those who are
not using systemd but use desktop profiles can stop reading here, as
they already have a logind provider enabled.".
Comment 8 Vitaly Zdanevich 2020-07-29 06:29:03 UTC
The same problem on another machine, after trying to emerge Chromium or after update, on startx I receive error: xf860OpenConsole: Cannot open virtual console 7 (Permission denied).

emerge --info of this another machine (note that -elogind, startx started Xorg before):

Portage 2.3.103 (python 3.7.8-final-0, default/linux/x86/17.0/desktop, gcc-9.3.0, glibc-2.30-r8, 5.4.48-gentoo-my-custom-kernel+ i686)
=================================================================
System uname: Linux-5.4.48-gentoo-my-custom-kernel+-i686-AMD_Athlon-tm-_7550_Dual-Core_Processor-with-gentoo-2.6
KiB Mem:     4589792 total,   3077172 free
KiB Swap:    3905532 total,   3905532 free
Timestamp of repository gentoo: Mon, 27 Jul 2020 22:30:01 +0000
Head commit of repository gentoo: 835aa6465a6a5eca8f5fd80438e8bb7747a4d12c
sh bash 5.0_p17
ld GNU ld (Gentoo 2.33.1 p2) 2.33.1
app-shells/bash:          5.0_p17::gentoo
dev-java/java-config:     2.3.1::gentoo
dev-lang/perl:            5.30.3::gentoo
dev-lang/python:          2.7.18-r1::gentoo, 3.7.8-r2::gentoo, 3.8.4-r1::gentoo
dev-util/cmake:           3.16.5::gentoo
sys-apps/baselayout:      2.6-r1::gentoo
sys-apps/openrc:          0.42.1::gentoo
sys-apps/sandbox:         2.18::gentoo
sys-devel/autoconf:       2.69-r4::gentoo
sys-devel/automake:       1.16.1-r1::gentoo
sys-devel/binutils:       2.33.1-r1::gentoo
sys-devel/gcc:            9.3.0-r1::gentoo
sys-devel/gcc-config:     2.3::gentoo
sys-devel/libtool:        2.4.6-r6::gentoo
sys-devel/make:           4.2.1-r4::gentoo
sys-kernel/linux-headers: 5.4-r1::gentoo (virtual/os-headers)
sys-libs/glibc:           2.30-r8::gentoo
Repositories:

gentoo
    location: /var/db/repos/gentoo
    sync-type: rsync
    sync-uri: rsync://rsync.gentoo.org/gentoo-portage
    priority: -1000
    sync-rsync-extra-opts: 
    sync-rsync-verify-max-age: 24
    sync-rsync-verify-metamanifest: yes
    sync-rsync-verify-jobs: 1

ACCEPT_KEYWORDS="x86"
ACCEPT_LICENSE="@FREE"
CBUILD="i686-pc-linux-gnu"
CFLAGS="-O2 -march=athlon64 -pipe"
CHOST="i686-pc-linux-gnu"
CONFIG_PROTECT="/etc /usr/share/gnupg/qualified.txt"
CONFIG_PROTECT_MASK="/etc/ca-certificates.conf /etc/dconf /etc/env.d /etc/fonts/fonts.conf /etc/gconf /etc/gentoo-release /etc/revdep-rebuild /etc/sandbox.d /etc/terminfo"
CXXFLAGS="-O2 -march=athlon64 -pipe"
DISTDIR="/var/cache/distfiles"
ENV_UNSET="DBUS_SESSION_BUS_ADDRESS DISPLAY GOBIN GOPATH PERL5LIB PERL5OPT PERLPREFIX PERL_CORE PERL_MB_OPT PERL_MM_OPT XAUTHORITY XDG_CACHE_HOME XDG_CONFIG_HOME XDG_DATA_HOME XDG_RUNTIME_DIR"
FCFLAGS="-O2 -march=athlon64 -pipe"
FEATURES="assume-digests binpkg-docompress binpkg-dostrip binpkg-logs config-protect-if-modified distlocks ebuild-locks fixlafiles ipc-sandbox merge-sync multilib-strict network-sandbox news parallel-fetch pid-sandbox preserve-libs protect-owned qa-unresolved-soname-deps sandbox sfperms strict unknown-features-warn unmerge-logs unmerge-orphans userfetch userpriv usersandbox usersync xattr"
FFLAGS="-O2 -march=athlon64 -pipe"
GENTOO_MIRRORS="https://mirror.yandex.ru/gentoo-distfiles/ https://gentoo-mirror.alexxy.name/"
LDFLAGS="-Wl,-O1 -Wl,--as-needed"
MAKEOPTS="-j1"
PKGDIR="/var/cache/binpkgs"
PORTAGE_CONFIGROOT="/"
PORTAGE_RSYNC_OPTS="--recursive --links --safe-links --perms --times --omit-dir-times --compress --force --whole-file --delete --stats --human-readable --timeout=180 --exclude=/distfiles --exclude=/local --exclude=/packages --exclude=/.git"
PORTAGE_TMPDIR="/var/tmp"
USE="X a52 aac acl acpi alsa berkdb branding bzip2 cairo cdda cdr cli crypt dav1d dbus dri dts dvd emboss encode exif flac flickr fortran gdbm geolocation gif gles2 gpm gtk iconv icu inspector ipv6 jpeg lcms ldap libnotify libtirpc mad minizip mng mp3 mp4 mpeg ncurses nls nptl ogg opengl openmp ozone pam pango pcre pdf png policykit ppds readline sdl seccomp spell split-usr ssl startup-notification svg system-icu tcpd tiff truetype udev udisks unicode upower usb vorbis vpx wayland webp wxwidgets x264 x86 xattr xcb xml xv xvid zlib" ABI_X86="32" ADA_TARGET="gnat_2018" ALSA_CARDS="ali5451 als4000 atiixp atiixp-modem bt87x ca0106 cmipci emu10k1 emu10k1x ens1370 ens1371 es1938 es1968 fm801 hda-intel intel8x0 intel8x0m maestro3 trident usb-audio via82xx via82xx-modem ymfpci" APACHE2_MODULES="authn_core authz_core socache_shmcb unixd actions alias auth_basic authn_alias authn_anon authn_dbm authn_default authn_file authz_dbm authz_default authz_groupfile authz_host authz_owner authz_user autoindex cache cgi cgid dav dav_fs dav_lock deflate dir disk_cache env expires ext_filter file_cache filter headers include info log_config logio mem_cache mime mime_magic negotiation rewrite setenvif speling status unique_id userdir usertrack vhost_alias" CALLIGRA_FEATURES="karbon sheets words" COLLECTD_PLUGINS="df interface irq load memory rrdtool swap syslog" CPU_FLAGS_X86="3dnow 3dnowext mmx mmxext popcnt sse sse2 sse3 sse4a" ELIBC="glibc" GPSD_PROTOCOLS="ashtech aivdm earthmate evermore fv18 garmin garmintxt gpsclock greis isync itrax mtk3301 nmea ntrip navcom oceanserver oldstyle oncore rtcm104v2 rtcm104v3 sirf skytraq superstar2 timing tsip tripmate tnt ublox ubx" INPUT_DEVICES="libinput" KERNEL="linux" LCD_DEVICES="bayrad cfontz cfontz633 glk hd44780 lb216 lcdm001 mtxorb ncurses text" LIBREOFFICE_EXTENSIONS="presenter-console presenter-minimizer" OFFICE_IMPLEMENTATION="libreoffice" PHP_TARGETS="php7-2 php7-3" POSTGRES_TARGETS="postgres10 postgres11" PYTHON_SINGLE_TARGET="python3_7" PYTHON_TARGETS="python2_7 python3_7" RUBY_TARGETS="ruby25" USERLAND="GNU" VIDEO_CARDS="radeon r600" XTABLES_ADDONS="quota2 psd pknock lscan length2 ipv4options ipset ipp2p iface geoip fuzzy condition tee tarpit sysrq steal rawnat logmark ipmark dhcpmac delude chaos account"
Unset:  CC, CPPFLAGS, CTARGET, CXX, EMERGE_DEFAULT_OPTS, INSTALL_MASK, LANG, LC_ALL, LINGUAS, PORTAGE_BINHOST, PORTAGE_BUNZIP2_COMMAND, PORTAGE_COMPRESS, PORTAGE_COMPRESS_FLAGS, PORTAGE_RSYNC_EXTRA_OPTS

Please help, how can I fix it?
Comment 9 Piotr Karbowski (RETIRED) gentoo-dev 2020-07-30 20:00:51 UTC
Have you enabled globally elogind and re-logged as per news item? Confirm that you have user session via `loginctl user-status`.

Screen tearing and lag has no relation to elogind entailment, unless you can prove otherwise by testing with '-elogind suid' and 'elogind -suid' sets.
Comment 10 Vitaly Zdanevich 2020-07-30 23:04:18 UTC
As you can see in my first `emerge --info` I have elogind. Yes I rebooted.

`loginctl user-status` from non-root returns:
"Failed to create bus connection: No such file or directory"
Comment 11 Piotr Karbowski (RETIRED) gentoo-dev 2020-07-31 07:15:42 UTC
Meaning that pam_elogind.so was not executed on login.

I suspect you did modify something in /etc/pam.d and after enabling elogind globally you have not executed `dispatch-conf`. Modified files are not subject to automerge.

Give me the output of: find /etc/pam.d/ -type f -exec ls -l '{}' +
Comment 12 Vitaly Zdanevich 2020-07-31 14:04:51 UTC
Additional feedback - on one of my machines I enabled elogind global USE flag, rebuild world - and Sway stopped to run (do not know where to find log with that error message).

> I suspect you did modify something in /etc/pam.d and after enabling elogind globally you have not executed `dispatch-conf`. Modified files are not subject to automerge.

I did not modify /etc/pam.d.

I do not know about `dispatch-conf`. Executed it. `startx` returns the same
"parse_vt_settings": Cannot open /dev/tty0 (Permission denied)".

Output of
find /etc/pam.d/ -type f -exec ls -l '{}' +
-rw-r--r-- 1 root root 103 Apr  6 07:04 ./chfn
-rw-r--r-- 1 root root  42 Apr  6 07:04 ./chpasswd
-rw-r--r-- 1 root root 144 Apr  6 07:04 ./chsh
-rw-r--r-- 1 root root 210 Apr 17 05:16 ./elogind-user
-rw-r--r-- 1 root root 116 Apr  6 07:04 ./groupmems
-rw-r--r-- 1 root root 188 Jul 31 02:09 ./login
-rw-r--r-- 1 root root  42 Apr  6 07:04 ./newusers
-rw-r--r-- 1 root root 128 Jul 31 02:09 ./other
-rw-r--r-- 1 root root 170 Jul 31 02:09 ./passwd
-rw-r--r-- 1 root root 155 May  1 07:02 ./polkit-1
-rw-r--r-- 1 root root 278 Jul 10 03:29 ./runuser
-rw-r--r-- 1 root root 188 Jul 10 03:29 ./runuser-l
-rw-r--r-- 1 root root 152 Apr  6 07:04 ./shadow
-rw-r--r-- 1 root root 144 Apr  6 07:04 ./shfn
-rw-r--r-- 1 root root 156 Apr  6 07:05 ./sshd
-rw-r--r-- 1 root root  63 Jan  6  2020 ./start-stop-daemon
-rw-r--r-- 1 root root 278 Jul 31 02:09 ./su
-rw-r--r-- 1 root root  63 Jan  6  2020 ./supervise-daemon
-rw-r--r-- 1 root root 542 Jul 31 02:09 ./system-auth
-rw-r--r-- 1 root root 121 Jul 31 02:09 ./system-local-login
-rw-r--r-- 1 root root 554 Jul 31 02:09 ./system-login
-rw-r--r-- 1 root root 121 Jul 31 02:09 ./system-remote-login
-rw-r--r-- 1 root root 235 Jul 31 02:09 ./system-services
-rw-r--r-- 1 root root 106 Jun 15 16:39 ./vlock
Comment 13 Piotr Karbowski (RETIRED) gentoo-dev 2020-07-31 16:32:29 UTC
In that case

1. Provide output of `cat /etc/pam.d/system-auth`
2. Provide output of `env |grep XDG_`
3. Provide output of `grep -i pam /var/log/messages`
4. Provide output of (as root) `emerge -pv sys-auth/pambase sys-libs/pam sys-auth/elogind`
Comment 14 Vitaly Zdanevich 2020-07-31 20:01:36 UTC
1. `cat /etc/pam.d/system-auth`:

auth		required	pam_env.so 
auth		required	pam_unix.so try_first_pass likeauth nullok 
auth		optional	pam_permit.so
account		required	pam_unix.so 
account		optional	pam_permit.so
password	required	pam_cracklib.so difok=2 minlen=8 dcredit=2 ocredit=2 retry=3 
password	required	pam_unix.so try_first_pass use_authtok nullok sha512 shadow 
password	optional	pam_permit.so
-session        optional        pam_elogind.so
session		required	pam_limits.so 
session		required	pam_env.so 
session		required	pam_unix.so 
session		optional	pam_permit.so

2. `env |grep XDG_`: empty

3. `grep -i pam /var/log/messages`: No such file or directory

4. `emerge -pv sys-auth/pambase sys-libs/pam sys-auth/elogind`:
Calculating dependencies  .... done!
[ebuild   R    ] sys-libs/pam-1.3.1_p20200128-r1::gentoo  USE="berkdb cracklib filecaps pie (split-usr) -audit -debug -nis (-selinux) -static-libs" 0 KiB
[ebuild   R    ] sys-auth/elogind-243.7::gentoo  USE="acl pam policykit -debug -doc (-selinux)" 0 KiB
[ebuild   R    ] sys-auth/pambase-20200304::gentoo  USE="cracklib elogind nullok sha512 -caps -consolekit -debug -minimal -mktemp -pam_krb5 -pam_ssh -passwdqc -securetty (-selinux) -systemd" 0 KiB

Total: 3 packages (3 reinstalls), Size of downloads: 0 KiB
Comment 15 Piotr Karbowski (RETIRED) gentoo-dev 2020-07-31 20:17:33 UTC
What system logger are you using? Just grep the log for 'PAM' there. That should tell us why pam_elogind is not executed for you.
Comment 16 Vitaly Zdanevich 2020-08-01 07:37:16 UTC
I do not know what logger, maybe I did not install it.

grep -r PAM /var/log:
/var/log/portage/elog/summary.log:Some software with pre-loaded PAM libraries might experience
/var/log/portage/elog/summary.log:implementation of PAM and the software, and it requires you to
/var/log/portage/elog/summary.log:/var/tmp/portage/sys-libs/pam-1.3.0-r2/work/Linux-PAM-1.3.0/libpam_misc/misc_conv.c:329:19: warning: the address of 'binary_prompt' will always evaluate as 'true' [-Waddress]
/var/log/portage/elog/summary.log:Some software with pre-loaded PAM libraries might experience
/var/log/portage/elog/summary.log:implementation of PAM and the software, and it requires you to
/var/log/portage/elog/summary.log:Some software with pre-loaded PAM libraries might experience
/var/log/portage/elog/summary.log:implementation of PAM and the software, and it requires you to
/var/log/portage/elog/summary.log:Some software with pre-loaded PAM libraries might experience
/var/log/portage/elog/summary.log:implementation of PAM and the software, and it requires you to

grep -r pam /var/log:
/var/log/portage/elog/summary.log:>>> Messages generated by process 10986 on 2020-01-05 03:48:25 -00 for package sys-libs/pam-1.3.0-r2:
/var/log/portage/elog/summary.log:  lsof / | egrep -i 'del.*libpam\.so'
/var/log/portage/elog/summary.log:/var/tmp/portage/sys-libs/pam-1.3.0-r2/work/Linux-PAM-1.3.0/libpam_misc/misc_conv.c:329:19: warning: the address of 'binary_prompt' will always evaluate as 'true' [-Waddress]
/var/log/portage/elog/summary.log:Homepage: http://www.linux-pam.org/
/var/log/portage/elog/summary.log:>>> Messages generated by process 8307 on 2020-01-14 06:11:46 +03 for package sys-libs/pam-1.3.1-r1:
/var/log/portage/elog/summary.log:  lsof / | egrep -i 'del.*libpam\.so'
/var/log/portage/elog/summary.log:/var/tmp/portage/sys-libs/pam-1.3.1-r1/work/linux-pam-1.3.1/libpam_misc/misc_conv.c:329:19: warning: the address of 'binary_prompt' will always evaluate as 'true' [-Waddress]
/var/log/portage/elog/summary.log:Homepage: https://github.com/linux-pam/linux-pam
/var/log/portage/elog/summary.log:>>> Messages generated by process 3699 on 2020-04-06 05:35:09 +03 for package sys-libs/pam-1.3.1-r2:
/var/log/portage/elog/summary.log:  lsof / | egrep -i 'del.*libpam\.so'
/var/log/portage/elog/summary.log:/var/tmp/portage/sys-libs/pam-1.3.1-r2/work/linux-pam-1.3.1/libpam_misc/misc_conv.c:329:19: warning: the address of 'binary_prompt' will always evaluate as 'true' [-Waddress]
/var/log/portage/elog/summary.log:Homepage: https://github.com/linux-pam/linux-pam
/var/log/portage/elog/summary.log:>>> Messages generated by process 6238 on 2020-07-10 01:55:35 +03 for package sys-libs/pam-1.3.1_p20200128-r1:
/var/log/portage/elog/summary.log:  lsof / | egrep -i 'del.*libpam\.so'
/var/log/emerge.log:1578196054:  >>> emerge (125 of 233) sys-libs/pam-1.3.0-r2 to /
/var/log/emerge.log:1578196054:  === (125 of 233) Cleaning (sys-libs/pam-1.3.0-r2::/var/db/repos/gentoo/sys-libs/pam/pam-1.3.0-r2.ebuild)
/var/log/emerge.log:1578196054:  === (125 of 233) Compiling/Merging (sys-libs/pam-1.3.0-r2::/var/db/repos/gentoo/sys-libs/pam/pam-1.3.0-r2.ebuild)
/var/log/emerge.log:1578196101:  === (125 of 233) Merging (sys-libs/pam-1.3.0-r2::/var/db/repos/gentoo/sys-libs/pam/pam-1.3.0-r2.ebuild)
/var/log/emerge.log:1578196103:  >>> AUTOCLEAN: sys-libs/pam:0
/var/log/emerge.log:1578196103:  === Unmerging... (sys-libs/pam-1.3.0-r2)
/var/log/emerge.log:1578196104:  >>> unmerge success: sys-libs/pam-1.3.0-r2
/var/log/emerge.log:1578196106:  === (125 of 233) Post-Build Cleaning (sys-libs/pam-1.3.0-r2::/var/db/repos/gentoo/sys-libs/pam/pam-1.3.0-r2.ebuild)
/var/log/emerge.log:1578196106:  ::: completed emerge (125 of 233) sys-libs/pam-1.3.0-r2 to /
/var/log/emerge.log:1578206270:  >>> emerge (232 of 233) sys-auth/pambase-20190402 to /
/var/log/emerge.log:1578206270:  === (232 of 233) Cleaning (sys-auth/pambase-20190402::/var/db/repos/gentoo/sys-auth/pambase/pambase-20190402.ebuild)
/var/log/emerge.log:1578206271:  === (232 of 233) Compiling/Merging (sys-auth/pambase-20190402::/var/db/repos/gentoo/sys-auth/pambase/pambase-20190402.ebuild)
/var/log/emerge.log:1578206275:  === (232 of 233) Merging (sys-auth/pambase-20190402::/var/db/repos/gentoo/sys-auth/pambase/pambase-20190402.ebuild)
/var/log/emerge.log:1578206276:  >>> AUTOCLEAN: sys-auth/pambase:0
/var/log/emerge.log:1578206276:  === Unmerging... (sys-auth/pambase-20190402)
/var/log/emerge.log:1578206277:  >>> unmerge success: sys-auth/pambase-20190402
/var/log/emerge.log:1578206279:  === (232 of 233) Post-Build Cleaning (sys-auth/pambase-20190402::/var/db/repos/gentoo/sys-auth/pambase/pambase-20190402.ebuild)
/var/log/emerge.log:1578206279:  ::: completed emerge (232 of 233) sys-auth/pambase-20190402 to /
/var/log/emerge.log:1578971392:  >>> emerge (3 of 3) sys-libs/pam-1.3.1-r1 to /
/var/log/emerge.log:1578971392:  === (3 of 3) Cleaning (sys-libs/pam-1.3.1-r1::/var/db/repos/gentoo/sys-libs/pam/pam-1.3.1-r1.ebuild)
/var/log/emerge.log:1578971392:  === (3 of 3) Compiling/Merging (sys-libs/pam-1.3.1-r1::/var/db/repos/gentoo/sys-libs/pam/pam-1.3.1-r1.ebuild)
/var/log/emerge.log:1578971500:  === (3 of 3) Merging (sys-libs/pam-1.3.1-r1::/var/db/repos/gentoo/sys-libs/pam/pam-1.3.1-r1.ebuild)
/var/log/emerge.log:1578971502:  >>> AUTOCLEAN: sys-libs/pam:0
/var/log/emerge.log:1578971502:  === Unmerging... (sys-libs/pam-1.3.0-r2)
/var/log/emerge.log:1578971504:  >>> unmerge success: sys-libs/pam-1.3.0-r2
/var/log/emerge.log:1578971506:  === (3 of 3) Post-Build Cleaning (sys-libs/pam-1.3.1-r1::/var/db/repos/gentoo/sys-libs/pam/pam-1.3.1-r1.ebuild)
/var/log/emerge.log:1578971506:  ::: completed emerge (3 of 3) sys-libs/pam-1.3.1-r1 to /
/var/log/emerge.log:1586140395:  >>> emerge (26 of 72) sys-libs/pam-1.3.1-r2 to /
/var/log/emerge.log:1586140395:  === (26 of 72) Cleaning (sys-libs/pam-1.3.1-r2::/var/db/repos/gentoo/sys-libs/pam/pam-1.3.1-r2.ebuild)
/var/log/emerge.log:1586140395:  === (26 of 72) Compiling/Merging (sys-libs/pam-1.3.1-r2::/var/db/repos/gentoo/sys-libs/pam/pam-1.3.1-r2.ebuild)
/var/log/emerge.log:1586140502:  === (26 of 72) Merging (sys-libs/pam-1.3.1-r2::/var/db/repos/gentoo/sys-libs/pam/pam-1.3.1-r2.ebuild)
/var/log/emerge.log:1586140505:  >>> AUTOCLEAN: sys-libs/pam:0
/var/log/emerge.log:1586140505:  === Unmerging... (sys-libs/pam-1.3.1-r1)
/var/log/emerge.log:1586140506:  >>> unmerge success: sys-libs/pam-1.3.1-r1
/var/log/emerge.log:1586140509:  === (26 of 72) Post-Build Cleaning (sys-libs/pam-1.3.1-r2::/var/db/repos/gentoo/sys-libs/pam/pam-1.3.1-r2.ebuild)
/var/log/emerge.log:1586140509:  ::: completed emerge (26 of 72) sys-libs/pam-1.3.1-r2 to /
/var/log/emerge.log:1587090432:  >>> emerge (19 of 21) sys-auth/pambase-20190402 to /
/var/log/emerge.log:1587090432:  === (19 of 21) Cleaning (sys-auth/pambase-20190402::/var/db/repos/gentoo/sys-auth/pambase/pambase-20190402.ebuild)
/var/log/emerge.log:1587090432:  === (19 of 21) Compiling/Merging (sys-auth/pambase-20190402::/var/db/repos/gentoo/sys-auth/pambase/pambase-20190402.ebuild)
/var/log/emerge.log:1587090437:  === (19 of 21) Merging (sys-auth/pambase-20190402::/var/db/repos/gentoo/sys-auth/pambase/pambase-20190402.ebuild)
/var/log/emerge.log:1587090439:  >>> AUTOCLEAN: sys-auth/pambase:0
/var/log/emerge.log:1587090439:  === Unmerging... (sys-auth/pambase-20190402)
/var/log/emerge.log:1587090440:  >>> unmerge success: sys-auth/pambase-20190402
/var/log/emerge.log:1587090442:  === (19 of 21) Post-Build Cleaning (sys-auth/pambase-20190402::/var/db/repos/gentoo/sys-auth/pambase/pambase-20190402.ebuild)
/var/log/emerge.log:1587090442:  ::: completed emerge (19 of 21) sys-auth/pambase-20190402 to /
/var/log/emerge.log:1594335219:  >>> emerge (16 of 38) sys-libs/pam-1.3.1_p20200128-r1 to /
/var/log/emerge.log:1594335219:  === (16 of 38) Cleaning (sys-libs/pam-1.3.1_p20200128-r1::/var/db/repos/gentoo/sys-libs/pam/pam-1.3.1_p20200128-r1.ebuild)
/var/log/emerge.log:1594335219:  === (16 of 38) Compiling/Merging (sys-libs/pam-1.3.1_p20200128-r1::/var/db/repos/gentoo/sys-libs/pam/pam-1.3.1_p20200128-r1.ebuild)
/var/log/emerge.log:1594335329:  === (16 of 38) Merging (sys-libs/pam-1.3.1_p20200128-r1::/var/db/repos/gentoo/sys-libs/pam/pam-1.3.1_p20200128-r1.ebuild)
/var/log/emerge.log:1594335331:  >>> AUTOCLEAN: sys-libs/pam:0
/var/log/emerge.log:1594335331:  === Unmerging... (sys-libs/pam-1.3.1-r2)
/var/log/emerge.log:1594335333:  >>> unmerge success: sys-libs/pam-1.3.1-r2
/var/log/emerge.log:1594335336:  === (16 of 38) Post-Build Cleaning (sys-libs/pam-1.3.1_p20200128-r1::/var/db/repos/gentoo/sys-libs/pam/pam-1.3.1_p20200128-r1.ebuild)
/var/log/emerge.log:1594335336:  ::: completed emerge (16 of 38) sys-libs/pam-1.3.1_p20200128-r1 to /
/var/log/emerge.log:1596014257:  >>> emerge (4 of 4) sys-auth/pambase-20190402 to /
/var/log/emerge.log:1596014257:  === (4 of 4) Cleaning (sys-auth/pambase-20190402::/var/db/repos/gentoo/sys-auth/pambase/pambase-20190402.ebuild)
/var/log/emerge.log:1596014257:  === (4 of 4) Compiling/Merging (sys-auth/pambase-20190402::/var/db/repos/gentoo/sys-auth/pambase/pambase-20190402.ebuild)
/var/log/emerge.log:1596014261:  === (4 of 4) Merging (sys-auth/pambase-20190402::/var/db/repos/gentoo/sys-auth/pambase/pambase-20190402.ebuild)
/var/log/emerge.log:1596014262:  >>> AUTOCLEAN: sys-auth/pambase:0
/var/log/emerge.log:1596014262:  === Unmerging... (sys-auth/pambase-20190402)
/var/log/emerge.log:1596014264:  >>> unmerge success: sys-auth/pambase-20190402
/var/log/emerge.log:1596014265:  === (4 of 4) Post-Build Cleaning (sys-auth/pambase-20190402::/var/db/repos/gentoo/sys-auth/pambase/pambase-20190402.ebuild)
/var/log/emerge.log:1596014265:  ::: completed emerge (4 of 4) sys-auth/pambase-20190402 to /
/var/log/emerge.log:1596015297:  >>> emerge (4 of 4) sys-auth/pambase-20200304 to /
/var/log/emerge.log:1596015297:  === (4 of 4) Cleaning (sys-auth/pambase-20200304::/var/db/repos/gentoo/sys-auth/pambase/pambase-20200304.ebuild)
/var/log/emerge.log:1596015297:  === (4 of 4) Compiling/Merging (sys-auth/pambase-20200304::/var/db/repos/gentoo/sys-auth/pambase/pambase-20200304.ebuild)
/var/log/emerge.log:1596015301:  === (4 of 4) Merging (sys-auth/pambase-20200304::/var/db/repos/gentoo/sys-auth/pambase/pambase-20200304.ebuild)
/var/log/emerge.log:1596015302:  >>> AUTOCLEAN: sys-auth/pambase:0
/var/log/emerge.log:1596015302:  === Unmerging... (sys-auth/pambase-20190402)
/var/log/emerge.log:1596015304:  >>> unmerge success: sys-auth/pambase-20190402
/var/log/emerge.log:1596015305:  === (4 of 4) Post-Build Cleaning (sys-auth/pambase-20200304::/var/db/repos/gentoo/sys-auth/pambase/pambase-20200304.ebuild)
/var/log/emerge.log:1596015305:  ::: completed emerge (4 of 4) sys-auth/pambase-20200304 to /
/var/log/emerge.log:1596150563:  >>> emerge (3 of 4) sys-auth/pambase-20200304 to /
/var/log/emerge.log:1596150563:  === (3 of 4) Cleaning (sys-auth/pambase-20200304::/var/db/repos/gentoo/sys-auth/pambase/pambase-20200304.ebuild)
/var/log/emerge.log:1596150563:  === (3 of 4) Compiling/Merging (sys-auth/pambase-20200304::/var/db/repos/gentoo/sys-auth/pambase/pambase-20200304.ebuild)
/var/log/emerge.log:1596150567:  === (3 of 4) Merging (sys-auth/pambase-20200304::/var/db/repos/gentoo/sys-auth/pambase/pambase-20200304.ebuild)
/var/log/emerge.log:1596150568:  >>> AUTOCLEAN: sys-auth/pambase:0
/var/log/emerge.log:1596150568:  === Unmerging... (sys-auth/pambase-20200304)
/var/log/emerge.log:1596150569:  >>> unmerge success: sys-auth/pambase-20200304
/var/log/emerge.log:1596150571:  === (3 of 4) Post-Build Cleaning (sys-auth/pambase-20200304::/var/db/repos/gentoo/sys-auth/pambase/pambase-20200304.ebuild)
/var/log/emerge.log:1596150571:  ::: completed emerge (3 of 4) sys-auth/pambase-20200304 to /
Comment 17 Piotr Karbowski (RETIRED) gentoo-dev 2020-08-01 07:50:46 UTC
Check if you have any syslog, rsyslog, metalog or anything like that in `rc-status --all`. Your lack of any logs regarding PAM is concerning
Comment 18 Vitaly Zdanevich 2020-08-01 10:10:16 UTC
No "log" here:

Runlevel: shutdown
 killprocs                                                         [  stopped  ]
 savecache                                                         [  stopped  ]
 mount-ro                                                          [  stopped  ]
Runlevel: default
 net.wlp3s0                                                        [  started  ]
 netmount                                                          [  started  ]
 local                                                             [  started  ]
Runlevel: sysinit
 sysfs                                                             [  started  ]
 devfs                                                             [  started  ]
 udev                                                              [  started  ]
 dmesg                                                             [  started  ]
 kmod-static-nodes                                                 [  started  ]
 opentmpfiles-dev                                                  [  started  ]
 udev-trigger                                                      [  started  ]
 cgroups                                                           [  started  ]
Runlevel: boot
 hwclock                                                           [  started  ]
 modules                                                           [  started  ]
 fsck                                                              [  started  ]
 root                                                              [  started  ]
 sysctl                                                            [  started  ]
 termencoding                                                      [  started  ]
 keymaps                                                           [  started  ]
 mtab                                                              [  started  ]
 swap                                                              [  started  ]
 localmount                                                        [  started  ]
 opentmpfiles-setup                                                [  started  ]
 procfs                                                            [  started  ]
 binfmt                                                            [  started  ]
 urandom                                                           [  started  ]
 hostname                                                          [  started  ]
 bootmisc                                                          [  started  ]
 save-termencoding                                                 [  started  ]
 loopback                                                          [  started  ]
 save-keymaps                                                      [  started  ]
Runlevel: nonetwork
 local                                                             [  started  ]
Dynamic Runlevel: hotplugged
Dynamic Runlevel: needed/wanted
Dynamic Runlevel: manual
Comment 19 Francesco Turco 2020-08-01 10:44:10 UTC
https://wiki.gentoo.org/wiki/Cron might be useful.
Comment 20 Vitaly Zdanevich 2020-08-01 11:07:27 UTC
(In reply to Francesco Turco from comment #19)
> https://wiki.gentoo.org/wiki/Cron might be useful.

Why I need cron?
Comment 21 Francesco Turco 2020-08-01 11:43:33 UTC
(In reply to Vitaly Zdanevich from comment #20)
> (In reply to Francesco Turco from comment #19)
> > https://wiki.gentoo.org/wiki/Cron might be useful.
> 
> Why I need cron?

Sorry, I made a mistake, please disregard my suggestion.
Comment 22 Piotr Karbowski (RETIRED) gentoo-dev 2020-08-01 14:19:19 UTC
First get yourself logger https://wiki.gentoo.org/wiki/Handbook:AMD64/Installation/Tools#System_logger

Then reboot, relogin and check logs, like /var/log/messages in case of syslog*, or /var/log/everything/current in case of metalog, with `grep -i pam`.
Comment 23 Vitaly Zdanevich 2020-08-01 14:47:12 UTC
Emerged sysklogd
`rc-update add sysklogd default`
Output from /var/log/messages have no pam/PAM (looks like output from dmesg), last part of messages (Bugzilla limit to amount of chars):

Aug  1 17:36:11 thinkpad-t430 kernel: [    0.545995] thinkpad_acpi: ThinkPad ACPI Extras v0.26
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.546001] thinkpad_acpi: http://ibm-acpi.sf.net/
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.546006] thinkpad_acpi: ThinkPad BIOS G1ETC2WW (2.82 ), EC G1HT36WW
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.546022] thinkpad_acpi: Lenovo ThinkPad T430, model 2349PQ3
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.546922] thinkpad_acpi: radio switch found; radios are enabled
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.546952] thinkpad_acpi: This ThinkPad has standard ACPI backlight brightness control, supported by the ACPI video driver
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.546959] thinkpad_acpi: Disabling thinkpad-acpi brightness events by default...
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.552326] random: fast init done
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.556898] thinkpad_acpi: battery 1 registered (start 0, stop 100)
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.556902] battery: new extension: ThinkPad Battery Extension
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.556940] input: ThinkPad Extra Buttons as /devices/platform/thinkpad_acpi/input/input6
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.560286] Initializing XFRM netlink socket
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.560389] NET: Registered protocol family 10
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.560528] Segment Routing with IPv6
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.560613] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.560723] NET: Registered protocol family 17
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.560730] Key type dns_resolver registered
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.563265] microcode: sig=0x306a9, pf=0x10, revision=0x21
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.563288] microcode: Microcode Update Driver: v2.2.
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.563290] IPI shorthand broadcast: enabled
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.563301] sched_clock: Marking stable (549739987, 13444108)->(573545435, -10361340)
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.563362] registered taskstats version 1
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.563365] Loading compiled-in X.509 certificates
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.563544] PM:   Magic number: 0:153:636
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.563570] power_supply AC: hash matches
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.563644] cfg80211: Loading compiled-in X.509 certificates for regulatory database
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.564469] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.564475] ALSA device list:
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.564477]   No soundcards found.
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.564508] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.564512] cfg80211: failed to load regulatory.db
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.662102] snd_hda_intel 0000:00:1b.0: bound 0000:00:02.0 (ops 0xc18fa71c)
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.662653] fbcon: i915drmfb (fb0) is primary device
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.672783] snd_hda_codec_realtek hdaudioC0D0: autoconfig for ALC3202: line_outs=1 (0x14/0x0/0x0/0x0/0x0) type:speaker
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.672785] snd_hda_codec_realtek hdaudioC0D0:    speaker_outs=0 (0x0/0x0/0x0/0x0/0x0)
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.672787] snd_hda_codec_realtek hdaudioC0D0:    hp_outs=2 (0x15/0x1b/0x0/0x0/0x0)
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.672788] snd_hda_codec_realtek hdaudioC0D0:    mono: mono_out=0x0
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.672789] snd_hda_codec_realtek hdaudioC0D0:    inputs:
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.672791] snd_hda_codec_realtek hdaudioC0D0:      Mic=0x18
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.672793] snd_hda_codec_realtek hdaudioC0D0:      Dock Mic=0x19
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.672794] snd_hda_codec_realtek hdaudioC0D0:      Internal Mic=0x12
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.684075] input: HDA Intel PCH Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input8
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.684110] input: HDA Intel PCH Dock Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input9
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.684141] input: HDA Intel PCH Headphone as /devices/pci0000:00/0000:00:1b.0/sound/card0/input10
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.684172] input: HDA Intel PCH Dock Headphone as /devices/pci0000:00/0000:00:1b.0/sound/card0/input11
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.684202] input: HDA Intel PCH HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:1b.0/sound/card0/input12
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.684234] input: HDA Intel PCH HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:1b.0/sound/card0/input13
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.684265] input: HDA Intel PCH HDMI/DP,pcm=8 as /devices/pci0000:00/0000:00:1b.0/sound/card0/input14
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.828088] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.829200] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.830266] ata1.00: ATA-8: HGST HTS725032A7E630, GHBZB550, max UDMA/133
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.830269] ata1.00: 625142448 sectors, multi 16: LBA48 NCQ (depth 32), AA
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.831466] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.832542] ata1.00: configured for UDMA/133
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.848076] usb 1-1: new high-speed USB device number 2 using ehci-pci
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.856072] usb 2-1: new high-speed USB device number 2 using ehci-pci
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.976471] usb 1-1: New USB device found, idVendor=8087, idProduct=0024, bcdDevice= 0.00
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.976475] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.976861] hub 1-1:1.0: USB hub found
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.977055] hub 1-1:1.0: 6 ports detected
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.985773] usb 2-1: New USB device found, idVendor=8087, idProduct=0024, bcdDevice= 0.00
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.985777] usb 2-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.986141] hub 2-1:1.0: USB hub found
Aug  1 17:36:11 thinkpad-t430 kernel: [    0.986353] hub 2-1:1.0: 8 ports detected
Aug  1 17:36:11 thinkpad-t430 kernel: [    1.264577] psmouse serio1: trackpoint: IBM TrackPoint firmware: 0x0e, buttons: 3/3
Aug  1 17:36:11 thinkpad-t430 kernel: [    1.278657] input: TPPS/2 IBM TrackPoint as /devices/platform/i8042/serio1/input/input7
Aug  1 17:36:11 thinkpad-t430 kernel: [    1.421091] tsc: Refined TSC clocksource calibration: 2594.106 MHz
Aug  1 17:36:11 thinkpad-t430 kernel: [    1.421105] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x25647bfab01, max_idle_ns: 440795211785 ns
Aug  1 17:36:11 thinkpad-t430 kernel: [    1.421146] clocksource: Switched to clocksource tsc
Aug  1 17:36:11 thinkpad-t430 kernel: [    1.515410] Console: switching to colour frame buffer device 170x48
Aug  1 17:36:11 thinkpad-t430 kernel: [    1.555034] i915 0000:00:02.0: fb0: i915drmfb frame buffer device
Aug  1 17:36:11 thinkpad-t430 kernel: [    1.557635] scsi 0:0:0:0: Direct-Access     ATA      HGST HTS725032A7 B550 PQ: 0 ANSI: 5
Aug  1 17:36:11 thinkpad-t430 kernel: [    1.560142] sd 0:0:0:0: Attached scsi generic sg0 type 0
Aug  1 17:36:11 thinkpad-t430 kernel: [    1.560208] sd 0:0:0:0: [sda] 625142448 512-byte logical blocks: (320 GB/298 GiB)
Aug  1 17:36:11 thinkpad-t430 kernel: [    1.563315] sd 0:0:0:0: [sda] 4096-byte physical blocks
Aug  1 17:36:11 thinkpad-t430 kernel: [    1.564640] sd 0:0:0:0: [sda] Write Protect is off
Aug  1 17:36:11 thinkpad-t430 kernel: [    1.565971] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Aug  1 17:36:11 thinkpad-t430 kernel: [    1.614457]  sda: sda1 sda2
Aug  1 17:36:11 thinkpad-t430 kernel: [    1.616665] sd 0:0:0:0: [sda] Attached SCSI disk
Aug  1 17:36:11 thinkpad-t430 kernel: [    1.866922] ata2: SATA link down (SStatus 0 SControl 300)
Aug  1 17:36:11 thinkpad-t430 kernel: [    2.179579] ata5: SATA link down (SStatus 0 SControl 300)
Aug  1 17:36:11 thinkpad-t430 kernel: [    2.258502] EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: (null)
Aug  1 17:36:11 thinkpad-t430 kernel: [    2.259454] VFS: Mounted root (ext4 filesystem) readonly on device 8:2.
Aug  1 17:36:11 thinkpad-t430 kernel: [    2.296581] devtmpfs: mounted
Aug  1 17:36:11 thinkpad-t430 kernel: [    2.298900] Freeing unused kernel image memory: 712K
Aug  1 17:36:11 thinkpad-t430 kernel: [    2.301132] Write protecting kernel text and read-only data: 12168k
Aug  1 17:36:11 thinkpad-t430 kernel: [    2.303242] Run /sbin/init as init process
Aug  1 17:36:11 thinkpad-t430 kernel: [    2.968068] random: crng init done
Aug  1 17:36:11 thinkpad-t430 kernel: [    6.556885] Intel(R) Wireless WiFi driver for Linux
Aug  1 17:36:11 thinkpad-t430 kernel: [    6.556886] Copyright(c) 2003- 2015 Intel Corporation
Aug  1 17:36:11 thinkpad-t430 kernel: [    6.557135] iwlwifi 0000:03:00.0: can't disable ASPM; OS doesn't have ASPM control
Aug  1 17:36:11 thinkpad-t430 kernel: [    6.557929] iwlwifi 0000:03:00.0: loaded firmware version 18.168.6.1 op_mode iwldvm
Aug  1 17:36:11 thinkpad-t430 kernel: [    6.589609] iwlwifi 0000:03:00.0: CONFIG_IWLWIFI_DEBUG disabled
Aug  1 17:36:11 thinkpad-t430 kernel: [    6.589613] iwlwifi 0000:03:00.0: CONFIG_IWLWIFI_DEBUGFS disabled
Aug  1 17:36:11 thinkpad-t430 kernel: [    6.589615] iwlwifi 0000:03:00.0: CONFIG_IWLWIFI_DEVICE_TRACING enabled
Aug  1 17:36:11 thinkpad-t430 kernel: [    6.589619] iwlwifi 0000:03:00.0: Detected Intel(R) Centrino(R) Advanced-N 6205 AGN, REV=0xB0
Aug  1 17:36:11 thinkpad-t430 kernel: [    6.677287] iwlwifi 0000:03:00.0 wlp3s0: renamed from wlan0
Aug  1 17:36:11 thinkpad-t430 kernel: [    8.102047] EXT4-fs (sda2): re-mounted. Opts: (null)
Aug  1 17:36:11 thinkpad-t430 kernel: [    8.315079] Adding 4194300k swap on /dev/sda1.  Priority:-2 extents:1 across:4194300k 
Aug  1 17:36:11 thinkpad-t430 kernel: [   10.260191] iwlwifi 0000:03:00.0: Radio type=0x1-0x2-0x0
Aug  1 17:36:11 thinkpad-t430 kernel: [   10.552706] iwlwifi 0000:03:00.0: Radio type=0x1-0x2-0x0
Aug  1 17:36:14 thinkpad-t430 kernel: [   14.316003] wlp3s0: authenticate with 00:37:6d:59:a2:db
Aug  1 17:36:14 thinkpad-t430 kernel: [   14.321379] wlp3s0: send auth to 00:37:6d:59:a2:db (try 1/3)
Aug  1 17:36:14 thinkpad-t430 kernel: [   14.326467] wlp3s0: authenticated
Aug  1 17:36:14 thinkpad-t430 kernel: [   14.327067] wlp3s0: associate with 00:37:6d:59:a2:db (try 1/3)
Aug  1 17:36:14 thinkpad-t430 kernel: [   14.332641] wlp3s0: RX AssocResp from 00:37:6d:59:a2:db (capab=0x411 status=0 aid=1)
Aug  1 17:36:14 thinkpad-t430 kernel: [   14.336061] wlp3s0: associated
Aug  1 17:36:15 thinkpad-t430 kernel: [   15.014349] IPv6: ADDRCONF(NETDEV_CHANGE): wlp3s0: link becomes ready
Aug  1 17:36:15 thinkpad-t430 wpa_cli: interface wlp3s0 CONNECTED
Comment 24 Piotr Karbowski (RETIRED) gentoo-dev 2020-08-01 15:14:24 UTC
Yes this is kernel and wpa log, have you rebooted? You can always compress the log and upload it as attachment to this bug.
Comment 25 Vitaly Zdanevich 2020-08-01 15:22:51 UTC
Created attachment 652072 [details]
/var/log/messages

(In reply to Piotr Karbowski from comment #24)
> Yes this is kernel and wpa log, have you rebooted? You can always compress
> the log and upload it as attachment to this bug.

Yes I rebooted, this is a full log after reboot.
Comment 26 Piotr Karbowski (RETIRED) gentoo-dev 2020-08-01 15:53:28 UTC
Are you logging normally on tty1 using agetty? What's yours `emerge -pv sys-apps/coreutils`?
Comment 27 Vitaly Zdanevich 2020-08-01 16:02:50 UTC
What you mean by normal logging? I just emerged logger, add to OpenRC, reboot. On tty1, yes.

Output:
[ebuild   R    ] sys-apps/coreutils-8.31-r1::gentoo  USE="acl nls (split-usr) xattr -caps -gmp -hostname -kill -multicall (-selinux) -static -test -vanilla" 0 KiB
Comment 28 Piotr Karbowski (RETIRED) gentoo-dev 2020-08-01 16:17:32 UTC
And `emerge -pv sys-apps/util-linux`?

Also, is it only one affected system or you have more of them?
Comment 29 Vitaly Zdanevich 2020-08-01 16:50:56 UTC
(In reply to Piotr Karbowski from comment #28)
> And `emerge -pv sys-apps/util-linux`?
[ebuild   R    ] sys-apps/util-linux-2.35.2::gentoo  USE="cramfs logger ncurses nls pam readline (split-usr) suid udev unicode -audit -build -caps -cryptsetup -fdformat -hardlink -kill -python (-selinux) -slang -static-libs -su -systemd -test -tty-helpers" PYTHON_TARGETS="python3_7 -python3_6 (-python3_8)" 0 KiB


> Also, is it only one affected system or you have more of them?
I have another PC with Xorg and Wayland. `startx` returns "xf860OpenConsole: Cannot open virtual console 7 (Permission denied)", Sway works.

Logs from this another PC:

No pam/PAM in dmesg.

# emerge -pv sys-apps/util-linux:
[ebuild   R    ] sys-apps/util-linux-2.35.2::gentoo  USE="cramfs logger ncurses nls pam readline (split-usr) suid udev unicode -audit -build -caps -cryptsetup -fdformat -hardlink -kill -python (-selinux) -slang -static-libs -su -systemd -test -tty-helpers" PYTHON_TARGETS="python3_7 -python3_6 (-python3_8)" 0 KiB

emerge -pv sys-apps/coreutils:
[ebuild   R    ] sys-apps/coreutils-8.31-r1::gentoo  USE="acl nls (split-usr) xattr -caps -gmp -hostname -kill -multicall (-selinux) -static -test -vanilla" 0 KiB

# cat /etc/pam.d/system-auth
auth		required	pam_env.so 
auth		required	pam_unix.so try_first_pass likeauth nullok 
auth		optional	pam_permit.so
account		required	pam_unix.so 
account		optional	pam_permit.so
password	required	pam_cracklib.so difok=2 minlen=8 dcredit=2 ocredit=2 retry=3 
password	required	pam_unix.so try_first_pass use_authtok nullok sha512 shadow 
password	optional	pam_permit.so
session		required	pam_limits.so 
session		required	pam_env.so 
session		required	pam_unix.so 
session		optional	pam_permit.so

# env |grep XDG_
XDG_CONFIG_DIRS=/etc/xdg
XDG_RUNTIME_DIR=/tmp/1000-runtime-dir/
XDG_DATA_DIRS=/usr/local/share:/usr/share

# emerge -pv sys-auth/pambase sys-libs/pam sys-auth/elogind
[ebuild   R    ] sys-libs/pam-1.3.1_p20200128-r1::gentoo  USE="berkdb cracklib filecaps pie (split-usr) -audit -debug -nis (-selinux) -static-libs" 0 KiB
[ebuild   R    ] sys-auth/pambase-20190402::gentoo  USE="cracklib nullok sha512 -consolekit -debug -elogind -minimal -mktemp -pam_krb5 -pam_ssh -passwdqc -securetty (-selinux) -systemd" 0 KiB
[ebuild   R    ] sys-auth/elogind-243.7::gentoo  USE="acl pam policykit -debug -doc (-selinux)" 0 KiB
Comment 30 Vitaly Zdanevich 2020-08-01 16:51:52 UTC
Created attachment 652090 [details]
dmesg of another PC with Gentoo and the same problem
Comment 31 Piotr Karbowski (RETIRED) gentoo-dev 2020-08-01 17:00:35 UTC
(In reply to Vitaly Zdanevich from comment #29)
> # cat /etc/pam.d/system-auth
> auth		required	pam_env.so 
> auth		required	pam_unix.so try_first_pass likeauth nullok 
> auth		optional	pam_permit.so
> account		required	pam_unix.so 
> account		optional	pam_permit.so
> password	required	pam_cracklib.so difok=2 minlen=8 dcredit=2 ocredit=2
> retry=3 
> password	required	pam_unix.so try_first_pass use_authtok nullok sha512
> shadow 
> password	optional	pam_permit.so
> session		required	pam_limits.so 
> session		required	pam_env.so 
> session		required	pam_unix.so 
> session		optional	pam_permit.so

I do not see pam_elogind here, Are you sure you've enabled elogind globally, updated @world with new use and updated config files (dispatch-conf)?
Comment 32 Vitaly Zdanevich 2020-08-01 17:56:17 UTC
Yes, sorry, my this another PC with Sway has USE flag "-elogind". Just now tried to remove "-elogind", rebuild world - cannot startx with the same permission problem, and cannot run Sway:
2020-08-01 20:36:20 - [backend/session/logind.c:637] User has no sessions
2020-08-01 20:36:20 - [backend/session/logind.c:696] Couldn't find an active session or a greeter session
2020-08-01 20:36:20 - [backend/session/direct-ipc.c:35] Do not have CAP_SYS_ADMIN; cannot become DRM master
2020-08-01 20:36:20 - [backend/session/session.c:96] Failed to load session backend
2020-08-01 20:36:20 - [backend/backend.c:286] Failed to start a DRM session
2020-08-01 20:36:20 - [sway/server.c:47] Unable to create backend
Comment 33 Vitaly Zdanevich 2020-08-01 17:57:10 UTC
Oops forgot dispatch-conf, now I will try again.
Comment 34 Piotr Karbowski (RETIRED) gentoo-dev 2020-08-01 18:01:34 UTC
1. enable elogind *globally*, in make.conf in USE.
2. update @world
3. update configuration files (dispatch-conf)
4. relogin
5. confirm that `loginctl user-status` works.
Comment 35 Vitaly Zdanevich 2020-08-01 18:21:36 UTC
Did, `loginctl user-status` returns:

"Failed to create bus connection: No such file or directory"
Comment 36 Piotr Karbowski (RETIRED) gentoo-dev 2020-08-01 18:25:08 UTC
Does it change anything if you first start /etc/init.d/elogind, then login? Usually elogind is started via pam_elogind.so.

Also, run `strace -s 1024 loginctl user-status > /tmp/log.txt 2>&1` and upload the /tmp/log.txt.
Comment 37 Vitaly Zdanevich 2020-08-01 19:09:35 UTC
(In reply to Piotr Karbowski from comment #36)
> Does it change anything if you first start /etc/init.d/elogind, then login?
> Usually elogind is started via pam_elogind.so.

Started on my second PC as root, startx works, but again only from root.
Comment 38 Matt Turner gentoo-dev 2020-08-01 19:11:19 UTC
(In reply to Vitaly Zdanevich from comment #35)
> Did, `loginctl user-status` returns:
> 
> "Failed to create bus connection: No such file or directory"

Just a thought: I assume that elogind relies on dbus. Is dbus not running, perhaps?
Comment 39 Vitaly Zdanevich 2020-08-01 19:14:01 UTC
(In reply to Piotr Karbowski from comment #36)
> Does it change anything if you first start /etc/init.d/elogind, then login?
> Usually elogind is started via pam_elogind.so.

Tried on my first PC (laptop): elogind start as root - startx successful from regular user!
Comment 40 Vitaly Zdanevich 2020-08-01 19:22:35 UTC
Now problem solved for my both computers! For that in root I execute:
`/etc/init.d/elogind start`

and exit (Ctrl+D) as root, enter as a regular user - and startx (and sway for second PC) works. Previously I started elogind in one tty, but tried startx in another tty.

THANK YOU.
Comment 41 Vitaly Zdanevich 2020-08-01 19:23:26 UTC
> Just a thought: I assume that elogind relies on dbus. Is dbus not running,
> perhaps?

In stdout I see that dbus started on `/etc/init.d/elogind start`.
Comment 42 Vitaly Zdanevich 2020-08-01 19:24:42 UTC
> Also, run `strace -s 1024 loginctl user-status > /tmp/log.txt 2>&1` and
> upload the /tmp/log.txt.

Do you still need it? Just strace is not installed.
Comment 43 Piotr Karbowski (RETIRED) gentoo-dev 2020-08-01 19:27:54 UTC
(In reply to Matt Turner from comment #38)
> (In reply to Vitaly Zdanevich from comment #35)
> > Did, `loginctl user-status` returns:
> > 
> > "Failed to create bus connection: No such file or directory"
> 
> Just a thought: I assume that elogind relies on dbus. Is dbus not running,
> perhaps?

This appears to be indeed a problem. pam_elogind starts starts elogind only if dbus is already running. Since above there's no `dbus` in rc-status I assume it was not running. I have dbus running everywhere around due to it being dependency for things like connman so I've not noticed it.

Added the dbus part to https://wiki.gentoo.org/wiki/Non_root_Xorg

@Vitaly, 'rc-update add dbus` should solve it once and for all for you.