From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: Received: from mp2 ([2001:41d0:2:bcc0::]) (using TLSv1.3 with cipher TLS_AES_256_GCM_SHA384 (256/256 bits)) by ms0.migadu.com with LMTPS id UBmjL1z9nmEaIAEAgWs5BA (envelope-from ) for ; Thu, 25 Nov 2021 04:05:00 +0100 Received: from aspmx1.migadu.com ([2001:41d0:2:bcc0::]) (using TLSv1.3 with cipher TLS_AES_256_GCM_SHA384 (256/256 bits)) by mp2 with LMTPS id PdtZK1z9nmGkRgAAB5/wlQ (envelope-from ) for ; Thu, 25 Nov 2021 03:05:00 +0000 Received: from lists.gnu.org (lists.gnu.org [209.51.188.17]) (using TLSv1.2 with cipher ECDHE-RSA-AES256-GCM-SHA384 (256/256 bits)) (No client certificate requested) by aspmx1.migadu.com (Postfix) with ESMTPS id 2BC7F302D1 for ; Thu, 25 Nov 2021 04:05:00 +0100 (CET) Received: from localhost ([::1]:55012 helo=lists1p.gnu.org) by lists.gnu.org with esmtp (Exim 4.90_1) (envelope-from ) id 1mq54E-0007AX-TZ for larch@yhetil.org; Wed, 24 Nov 2021 22:04:58 -0500 Received: from eggs.gnu.org ([209.51.188.92]:42358) by lists.gnu.org with esmtps (TLS1.2:ECDHE_RSA_AES_256_GCM_SHA384:256) (Exim 4.90_1) (envelope-from ) id 1mq53K-0005yM-K5 for bug-guix@gnu.org; Wed, 24 Nov 2021 22:04:02 -0500 Received: from debbugs.gnu.org ([209.51.188.43]:43866) by eggs.gnu.org with esmtps (TLS1.2:ECDHE_RSA_AES_128_GCM_SHA256:128) (Exim 4.90_1) (envelope-from ) id 1mq53K-00032p-Bx for bug-guix@gnu.org; Wed, 24 Nov 2021 22:04:02 -0500 Received: from Debian-debbugs by debbugs.gnu.org with local (Exim 4.84_2) (envelope-from ) id 1mq53K-000474-7W for bug-guix@gnu.org; Wed, 24 Nov 2021 22:04:02 -0500 X-Loop: help-debbugs@gnu.org Subject: bug#52051: [core-updates-frozen] cannot login ('org.freedesktop.login1' service times out) Resent-From: Maxim Cournoyer Original-Sender: "Debbugs-submit" Resent-CC: bug-guix@gnu.org Resent-Date: Thu, 25 Nov 2021 03:04:02 +0000 Resent-Message-ID: Resent-Sender: help-debbugs@gnu.org X-GNU-PR-Message: followup 52051 X-GNU-PR-Package: guix X-GNU-PR-Keywords: To: Josselin Poiret Received: via spool by 52051-submit@debbugs.gnu.org id=B52051.163780941015762 (code B ref 52051); Thu, 25 Nov 2021 03:04:02 +0000 Received: (at 52051) by debbugs.gnu.org; 25 Nov 2021 03:03:30 +0000 Received: from localhost ([127.0.0.1]:55412 helo=debbugs.gnu.org) by debbugs.gnu.org with esmtp (Exim 4.84_2) (envelope-from ) id 1mq52n-00046A-Ly for submit@debbugs.gnu.org; Wed, 24 Nov 2021 22:03:30 -0500 Received: from mail-qk1-f173.google.com ([209.85.222.173]:33623) by debbugs.gnu.org with esmtp (Exim 4.84_2) (envelope-from ) id 1mq52k-00045v-Ob for 52051@debbugs.gnu.org; Wed, 24 Nov 2021 22:03:27 -0500 Received: by mail-qk1-f173.google.com with SMTP id de30so7776321qkb.0 for <52051@debbugs.gnu.org>; Wed, 24 Nov 2021 19:03:26 -0800 (PST) DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=gmail.com; s=20210112; h=from:to:cc:subject:references:date:in-reply-to:message-id :user-agent:mime-version; bh=IZYFgvzI8IemdQ1kMVx43hk9z8MIxXE1sICxDR1UdHE=; b=OlkXBlMd3eKGXy5kPyrzkspgEZiz9uryH3RTHKPwmQqtbZRwYMUK8TQmXaclne1dCI FhwLQQpxXrUC3emLGIGbUgcATYr2KDGQvG9hIfFEmfX7TucwXQWhsb/d0GZS0sBrwT2V drLOlsQhsNlCZ/1x9vrtPNa98seKwTkTSj3vyqbbD+z2FqBpv5ODi0w0azAu7vyd2+Qh v0jwi/UQm4S2dWeh68J1UeQNEvjtvkF+aiM9a/0xSqEAZn306bkh6DcotRrw4yhM4UZT D1yZoZV9EktEYExFs+tS0tcHzDiL5DldLySJ+CXrqVdjY5f4mKzmzBtXR9M84JWYZl9N LCQg== X-Google-DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=1e100.net; s=20210112; h=x-gm-message-state:from:to:cc:subject:references:date:in-reply-to :message-id:user-agent:mime-version; bh=IZYFgvzI8IemdQ1kMVx43hk9z8MIxXE1sICxDR1UdHE=; b=tvcxmjQr9lbo+A7Ilp57hhgX2l3mkbPpaKvJ+sg0+qWwSmZX1PvmzjwSfUG235xFkI tR0QcLnrgCWSanvmbA4mbVSQLUzUPaDFuUio+V3BBeIpXDG3W8n2Fc/4tBygPZpUbuZI DF+6p9ioC5v8+4RBH2fwn5olZdqo8OEYpkpO+nNlnsKe9yX7BaDgrqS+Bz5SiR13mieO +QxzPZYPpzG79CpbbyuIVC2nP5Qp77WKO+xXQmJA8/xHfSV9aJHe5rulwdpgsRL2FgnB o+bfo52PDzWxLZDngZC+fGt6mlpxcOYc73oMN/0PA/Ulne2k8HlD9e647f+6b+F7rRZd /e9Q== X-Gm-Message-State: AOAM530O/QHdHs0Aof79FLYoBS7IbpATcCZ7Kho9Zj/BipPFfgrTTXW7 r4yrJdw+Mww1ZI1EwSZFgHx9oyERKtkcjw== X-Google-Smtp-Source: ABdhPJw6ngNRxDnXdc2lH/qSg9rJEy6q2EnOivQyqa2DKLbXCWlJLdf0BsHg+RTjM/Qivn1Nvi/S/g== X-Received: by 2002:a37:a353:: with SMTP id m80mr11640425qke.7.1637809400868; Wed, 24 Nov 2021 19:03:20 -0800 (PST) Received: from kwak ([207.35.95.55]) by smtp.gmail.com with ESMTPSA id 15sm833429qtp.55.2021.11.24.19.03.20 (version=TLS1_3 cipher=TLS_AES_256_GCM_SHA384 bits=256/256); Wed, 24 Nov 2021 19:03:20 -0800 (PST) From: Maxim Cournoyer References: <87pmqr1i8k.fsf@gmail.com> <87czmqorjb.fsf@jpoiret.xyz> Date: Wed, 24 Nov 2021 22:03:13 -0500 In-Reply-To: <87czmqorjb.fsf@jpoiret.xyz> (Josselin Poiret's message of "Wed, 24 Nov 2021 09:02:16 +0000") Message-ID: <87sfvlos26.fsf@gmail.com> User-Agent: Gnus/5.13 (Gnus v5.13) Emacs/27.2 (gnu/linux) MIME-Version: 1.0 Content-Type: text/plain X-BeenThere: debbugs-submit@debbugs.gnu.org X-Mailman-Version: 2.1.18 Precedence: list X-BeenThere: bug-guix@gnu.org List-Id: Bug reports for GNU Guix List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , Cc: 52051@debbugs.gnu.org Errors-To: bug-guix-bounces+larch=yhetil.org@gnu.org Sender: "bug-Guix" X-Migadu-Flow: FLOW_IN ARC-Message-Signature: i=1; a=rsa-sha256; c=relaxed/relaxed; d=yhetil.org; s=key1; t=1637809500; h=from:from:sender:sender:reply-to:subject:subject:date:date: message-id:message-id:to:to:cc:cc:mime-version:mime-version: content-type:content-type:resent-cc:resent-from:resent-sender: resent-message-id:in-reply-to:in-reply-to:references:references: list-id:list-help:list-unsubscribe:list-subscribe:list-post: dkim-signature; bh=IZYFgvzI8IemdQ1kMVx43hk9z8MIxXE1sICxDR1UdHE=; b=kXo704mRzVpTdBpYJvPJEEUyvleeChW+zWDWCxFPtCCUTG80SNZdUs+ktb5yYyQXMtaDca Shf5YT/3o8OqwtQqtKXfz3h0ml1MijbaBptFu6BcTtmb8IpoU2YV77LH+Y79O2KAODSegm /awe1g9EgrnQ36puG1Ul8CMNLgZN7swxBsqSfM9HK8wPXvwLByXgXcbwDR+NdDZHRhlAUg OSXm4+4qgptEZZ8FaPrOh/sKi1t/AhLIBXZjoxIdjMpR/GZlAtQxe12VkEb+7xeyQPHB/U EksyQoe1oXTzc1b0TWC9ZCa0qMFD36HMMqAsVg/KiYI15PrJM1h+oCRvu2a6+w== ARC-Seal: i=1; s=key1; d=yhetil.org; t=1637809500; a=rsa-sha256; cv=none; b=Uo1KXj4vgn5zqrHh8zViI/ymiSUSbYMVIZqqknZnwGj4Z4jUa+4uA9g/VphbcAl9P4/pOR S/QYWNCK9RXMCadNCtMxW+BMvSUaDf5T/DSn0SasDkTKHclAvfNpvlAfxCG6L1+q+D/J5R 4WQDvGV23HszRihA5QQcHN1AaJBuPRDiLFdyvulZcKp4c7FqItMB/OHZXtcVyCq1DHTSa7 RxyTD5Zh0TRO+11u3lwRSSSALJtgOjHuyEvT5FmPUxzxnEVdom7afbSDAYVXlBA8KrPTO9 HXuSDi0MdymhzYOkeNjO/6EKZGJFyKO3mYdJ1SUDMHD6gCmbA/vtj96oRBgRfQ== ARC-Authentication-Results: i=1; aspmx1.migadu.com; dkim=fail ("headers rsa verify failed") header.d=gmail.com header.s=20210112 header.b=OlkXBlMd; dmarc=fail reason="SPF not aligned (relaxed)" header.from=gmail.com (policy=none); spf=pass (aspmx1.migadu.com: domain of bug-guix-bounces@gnu.org designates 209.51.188.17 as permitted sender) smtp.mailfrom=bug-guix-bounces@gnu.org X-Migadu-Spam-Score: -1.79 Authentication-Results: aspmx1.migadu.com; dkim=fail ("headers rsa verify failed") header.d=gmail.com header.s=20210112 header.b=OlkXBlMd; dmarc=fail reason="SPF not aligned (relaxed)" header.from=gmail.com (policy=none); spf=pass (aspmx1.migadu.com: domain of bug-guix-bounces@gnu.org designates 209.51.188.17 as permitted sender) smtp.mailfrom=bug-guix-bounces@gnu.org X-Migadu-Queue-Id: 2BC7F302D1 X-Spam-Score: -1.79 X-Migadu-Scanner: scn1.migadu.com X-TUID: /2j5nEvGbSPl Hello Josselin, Josselin Poiret writes: > Hello Maxim, > > Maxim Cournoyer writes: > >> --8<---------------cut here---------------start------------->8--- >> Nov 23 01:09:14 localhost dbus-daemon[383]: [system] Activating >> service name='org.freedesktop.login1' requested by ':1.17' (uid=0 >> pid=370 >> comm="/gnu/store/ximad0zvg12r4x0x80mvym8hzg0n33jl-shadow") (using servicehelper) >> Nov 23 01:09:14 localhost elogind[1189]: elogind is already running as PID 390 >> Nov 23 01:09:20 localhost shepherd[1]: Respawning term-tty1. >> Nov 23 01:09:20 localhost shepherd[1]: Service host-name has been started. >> Nov 23 01:09:20 localhost shepherd[1]: Service term-tty1 has been started. >> Nov 23 01:09:39 localhost dbus-daemon[383]: [system] Failed to >> activate service 'org.freedesktop.login1': timed out >> (service_start_timeout=25000ms) >> --8<---------------cut here---------------end--------------->8--- >> >> I don't remember if I saw the slim login screen; but in any case I >> couldn't successfully login even via a ptty. >> >> It may have to do with polkit. >> >> To be investigated. >> >> This happened on a system *not* using gdm (it uses slim) and with >> ratpoison as the WM, on commit f42bc604547d9ee8e35fcd66d5db7786954cfac3 >> of the core-updates-frozen branch. >> >> To be investigated. > > I cannot reproduce in a fresh VM on commit > d5de4e163ccef80f78bc5fe330f568d8fe3a23ab, and can login just fine, with > > (services (cons* (service slim-service-type (slim-configuration)) > (modify-services %desktop-services > (delete gdm-service-type)))) > > Is this still affecting you? Yes! It didn't occur in a 'guix system vm my-config.scm', but the exact same config deployed on my machine fails at login. Some symptoms: 1. Slim login screen comes up, but after entering credentials Xorg resets (back to login screen) 2. going to a TTY and attempting to login there, it'd fail with a "Login failed after 60 s timeout" or similar error. 3. I can login via SSH (thanks goodness!) 4. There are no errors (EE) in /var/log/Xorg.0.log 5. here's the tail of my /var/log/messages: --8<---------------cut here---------------start------------->8--- Nov 24 21:23:54 localhost ntpd[346]: Soliciting pool server 216.197.156.83 Nov 24 21:23:55 localhost ntpd[346]: Soliciting pool server 206.108.0.133 Nov 24 21:23:56 localhost wpa_supplicant[343]: wlp4s0: CTRL-EVENT-BEACON-LOSS Nov 24 21:23:56 localhost ntpd[346]: Soliciting pool server 98.143.85.249 Nov 24 21:23:57 localhost ntpd[346]: Soliciting pool server 192.95.27.155 Nov 24 21:23:58 localhost dbus-daemon[341]: [system] Activating service name='org.freedesktop.login1' requested by ':1.16' (uid=0 pid=324 comm="/gnu/store/ximad0zvg12r4x0x80mvym8hzg0n33jl-shadow") (using servicehelper) Nov 24 21:23:58 localhost elogind[1114]: elogind is already running as PID 355 Nov 24 21:24:11 localhost wpa_supplicant[343]: wlp4s0: CTRL-EVENT-BEACON-LOSS Nov 24 21:24:21 localhost last message repeated 5 times Nov 24 21:24:23 localhost dbus-daemon[341]: [system] Failed to activate service 'org.freedesktop.login1': timed out (service_start_timeout=25000ms) Nov 24 21:24:23 localhost shepherd[1]: Respawning term-tty2. Nov 24 21:24:23 localhost shepherd[1]: Service host-name has been started. Nov 24 21:24:23 localhost shepherd[1]: Service term-tty2 has been started. Nov 24 21:24:23 localhost wpa_supplicant[343]: wlp4s0: CTRL-EVENT-BEACON-LOSS Nov 24 21:24:27 localhost last message repeated 3 times Nov 24 21:26:04 localhost dbus-daemon[341]: [system] Activating service name='org.freedesktop.login1' requested by ':1.17' (uid=0 pid=429 comm="/gnu/store/nvvmksc9pvahqmypaz3h8mqya82vnga8-slim-1") (using servicehelper) Nov 24 21:26:04 localhost elogind[1127]: elogind is already running as PID 355 Nov 24 21:26:29 localhost dbus-daemon[341]: [system] Failed to activate service 'org.freedesktop.login1': timed out (service_start_timeout=25000ms) Nov 24 21:26:29 localhost shepherd[1]: Respawning xorg-server. Nov 24 21:26:29 localhost shepherd[1]: Service host-name has been started. Nov 24 21:26:29 localhost shepherd[1]: Service xorg-server has been started. Nov 24 21:27:23 localhost ntpd[346]: Soliciting pool server 209.115.181.108 Nov 24 21:27:24 localhost ntpd[346]: Soliciting pool server 138.197.153.200 Nov 24 21:27:25 localhost ntpd[346]: Soliciting pool server 162.159.200.123 Nov 24 21:27:26 localhost ntpd[346]: Soliciting pool server 162.159.200.1 Nov 24 21:29:09 localhost ntpd[346]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 24 21:29:42 localhost ntpd[346]: Soliciting pool server 199.182.221.110 Nov 24 21:35:23 localhost wpa_supplicant[343]: wlp4s0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-87 noise=-95 txrate=270000 Nov 24 21:35:32 localhost wpa_supplicant[343]: wlp4s0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-67 noise=-95 txrate=270000 Nov 24 21:42:50 localhost dbus-daemon[341]: [system] Activating service name='org.freedesktop.login1' requested by ':1.19' (uid=0 pid=1269 comm="sudo herd status dbus ") (using servicehelper) Nov 24 21:42:50 localhost elogind[1273]: elogind is already running as PID 355 Nov 24 21:43:15 localhost dbus-daemon[341]: [system] Failed to activate service 'org.freedesktop.login1': timed out (service_start_timeout=25000ms) Nov 24 21:47:25 localhost last message repeated 3 times --8<---------------cut here---------------end--------------->8--- So it seems the issue is with some D-Bus service (org.freedesktop.login1) failing to be started. I'm not sure how it can be explained that it works in a VM but not on the real machine... Also, the dbus-system process (pid 341) as the following environment variable (singular) defined: --8<---------------cut here---------------start------------->8--- # cat /proc/341/environ | xargs -0 -n1 PATH=/run/current-system/profile/bin --8<---------------cut here---------------end--------------->8--- which seems like not much. Perhaps it needs some XDG_DATA_DIRS to find that D-Bus service file? Where would it come from? To be investigated... Thanks, Maxim