Hi Rutherther, Danny Milosavljevic <dan...@friendly-machines.com> writes:
>As for grub, yeah, there isn't much you can do other than booting >manually or to a live iso. While we are trying to find the cause, we should just make guix do a sync after each guix system reconfigure. Damaging user's system beyond repair-without-external-system is not okay, especially when known (regardless of whether cause was already found or not). Also, given the log file corruption (see below), we should have something like "halt" but which doesn't turn the computer off at the end so we can still see log messages on screen. Do we have that? Also, where is the creation of /etc/protocols, which is not a symlink, done in guix source code? >I don't think this makes sense as the files are from the store, if >anything, the files in the store should be fdatasync'd, the etc files >will be recreated on boot anyway. How come they are now fine (after reconfigure from rescue system and reboot)? Shouldn't it have damaged the files in /etc again? ext4 has the behavior that while the journal guarantees metadata to be fixed up, it does not guarantee anything of the sort with regular data inside the files. So I still think sync did not happen. I think mounting the ext4 fs in the rescue system caused the journal to be replayed, fixing the filesystem metadata (ONLY), and not fixing the contents of the files. I'm using ext4 on / . Where in /gnu/store is the source for /etc/protocols ? I'd like to check them for damage. (Note: /etc/protocols is not a symlink) dannym@nova /var/guix/profiles/system-197-link/etc$ cat protocols # Internet (IP) protocols # # Updated from http://www.iana.org/assignments/protocol-numbers and other # sources. # New protocols will be added on request if they have been officially # assigned by IANA and are not historical. # If you need a huge list of used numbers please install the nmap package. ip 0 IP # internet protocol, pseudo protocol number hopopt 0 HOPOPT # IPv6 Hop-by-Hop Option [RFC1883] icmp 1 ICMP # internet control message protocol igmp 2 IGMP # Internet Group Management ggp 3 GGP # gateway-gateway protocol ipencap 4 IP-ENCAP # IP encapsulated in IP (officially ``IP'') st 5 ST # ST datagram mode tcp 6 TCP # transmission control protocol egp 8 EGP # exterior gateway protocol igp 9 IGP # any private interior gateway (Cisco) pup 12 PUP # PARC universal packet protocol udp 17 UDP # user datagram protocol hmp 20 HMP # host monitoring protocol xns-idp 22 XNS-IDP # Xerox NS IDP rdp 27 RDP # "reliable datagram" protocol iso-tp4 29 ISO-TP4 # ISO Transport Protocol class 4 [RFC905] dccp 33 DCCP # Datagram Congestion Control Prot. [RFC4340] xtp 36 XTP # Xpress Transfer Protocol ddp 37 DDP # Datagram Delivery Protocol idpr-cmtp 38 IDPR-CMTP # IDPR Control Message Transport ipv6 41 IPv6 # Internet Protocol, version 6 ipv6-route 43 IPv6-Route # Routing Header for IPv6 ipv6-frag 44 IPv6-Frag # Fragment Header for IPv6 idrp 45 IDRP # Inter-Domain Routing Protocol rsvp 46 RSVP # Reservation Protocol gre 47 GRE # General Routing Encapsulation esp 50 IPSEC-ESP # Encap Security Payload [RFC2406] ah 51 IPSEC-AH # Authentication Header [RFC2402] skip 57 SKIP # SKIP ipv6-icmp 58 IPv6-ICMP # ICMP for IPv6 ipv6-nonxt 59 IPv6-NoNxt # No Next Header for IPv6 ipv6-opts 60 IPv6-Opts # Destination Options for IPv6 rspf 73 RSPF CPHB # Radio Shortest Path First (officially CPHB) vmtp 81 VMTP # Versatile Message Transport eigrp 88 EIGRP # Enhanced Interior Routing Protocol (Cisco) ospf 89 OSPFIGP # Open Shortest Path First IGP ax.25 93 AX.25 # AX.25 frames ipip 94 IPIP # IP-within-IP Encapsulation Protocol etherip 97 ETHERIP # Ethernet-within-IP Encapsulation [RFC3378] encap 98 ENCAP # Yet Another IP encapsulation [RFC1241] # 99 # any private encryption scheme pim 103 PIM # Protocol Independent Multicast ipcomp 108 IPCOMP # IP Payload Compression Protocol vrrp 112 VRRP # Virtual Router Redundancy Protocol [RFC5798] l2tp 115 L2TP # Layer Two Tunneling Protocol [RFC2661] isis 124 ISIS # IS-IS over IPv4 sctp 132 SCTP # Stream Control Transmission Protocol fc 133 FC # Fibre Channel mobility-header 135 Mobility-Header # Mobility Support for IPv6 [RFC3775] udplite 136 UDPLite # UDP-Lite [RFC3828] mpls-in-ip 137 MPLS-in-IP # MPLS-in-IP [RFC4023] manet 138 # MANET Protocols [RFC5498] hip 139 HIP # Host Identity Protocol shim6 140 Shim6 # Shim6 Protocol [RFC5533] wesp 141 WESP # Wrapped Encapsulating Security Payload rohc 142 ROHC # Robust Header Compression And the old one: dannym@nova /var/guix/profiles/system-193-link/etc$ cat protocols # Internet (IP) protocols # # Updated from http://www.iana.org/assignments/protocol-numbers and other # sources. # New protocols will be added on request if they have been officially # assigned by IANA and are not historical. # If you need a huge list of used numbers please install the nmap package. ip 0 IP # internet protocol, pseudo protocol number hopopt 0 HOPOPT # IPv6 Hop-by-Hop Option [RFC1883] icmp 1 ICMP # internet control message protocol igmp 2 IGMP # Internet Group Management ggp 3 GGP # gateway-gateway protocol ipencap 4 IP-ENCAP # IP encapsulated in IP (officially ``IP'') st 5 ST # ST datagram mode tcp 6 TCP # transmission control protocol egp 8 EGP # exterior gateway protocol igp 9 IGP # any private interior gateway (Cisco) pup 12 PUP # PARC universal packet protocol udp 17 UDP # user datagram protocol hmp 20 HMP # host monitoring protocol xns-idp 22 XNS-IDP # Xerox NS IDP rdp 27 RDP # "reliable datagram" protocol iso-tp4 29 ISO-TP4 # ISO Transport Protocol class 4 [RFC905] dccp 33 DCCP # Datagram Congestion Control Prot. [RFC4340] xtp 36 XTP # Xpress Transfer Protocol ddp 37 DDP # Datagram Delivery Protocol idpr-cmtp 38 IDPR-CMTP # IDPR Control Message Transport ipv6 41 IPv6 # Internet Protocol, version 6 ipv6-route 43 IPv6-Route # Routing Header for IPv6 ipv6-frag 44 IPv6-Frag # Fragment Header for IPv6 idrp 45 IDRP # Inter-Domain Routing Protocol rsvp 46 RSVP # Reservation Protocol gre 47 GRE # General Routing Encapsulation esp 50 IPSEC-ESP # Encap Security Payload [RFC2406] ah 51 IPSEC-AH # Authentication Header [RFC2402] skip 57 SKIP # SKIP ipv6-icmp 58 IPv6-ICMP # ICMP for IPv6 ipv6-nonxt 59 IPv6-NoNxt # No Next Header for IPv6 ipv6-opts 60 IPv6-Opts # Destination Options for IPv6 rspf 73 RSPF CPHB # Radio Shortest Path First (officially CPHB) vmtp 81 VMTP # Versatile Message Transport eigrp 88 EIGRP # Enhanced Interior Routing Protocol (Cisco) ospf 89 OSPFIGP # Open Shortest Path First IGP ax.25 93 AX.25 # AX.25 frames ipip 94 IPIP # IP-within-IP Encapsulation Protocol etherip 97 ETHERIP # Ethernet-within-IP Encapsulation [RFC3378] encap 98 ENCAP # Yet Another IP encapsulation [RFC1241] # 99 # any private encryption scheme pim 103 PIM # Protocol Independent Multicast ipcomp 108 IPCOMP # IP Payload Compression Protocol vrrp 112 VRRP # Virtual Router Redundancy Protocol [RFC5798] l2tp 115 L2TP # Layer Two Tunneling Protocol [RFC2661] isis 124 ISIS # IS-IS over IPv4 sctp 132 SCTP # Stream Control Transmission Protocol fc 133 FC # Fibre Channel mobility-header 135 Mobility-Header # Mobility Support for IPv6 [RFC3775] udplite 136 UDPLite # UDP-Lite [RFC3828] mpls-in-ip 137 MPLS-in-IP # MPLS-in-IP [RFC4023] manet 138 # MANET Protocols [RFC5498] hip 139 HIP # Host Identity Protocol shim6 140 Shim6 # Shim6 Protocol [RFC5533] wesp 141 WESP # Wrapped Encapsulating Security Payload rohc 142 ROHC # Robust Header Compression Seems good to me, too. dannym@nova /var/guix/profiles/system-193-link/etc$ ls -l protocols lrwxrwxrwx 1 root root 70 Jan 1 1970 protocols -> /gnu/store/bfp25w47fxn8z0fdwj45prx2609sx59j-net-base-5.3/etc/protocols dannym@nova /var/guix/profiles/system-197-link/etc$ ls -l protocols lrwxrwxrwx 1 root root 70 Jan 1 1970 protocols -> /gnu/store/bfp25w47fxn8z0fdwj45prx2609sx59j-net-base-5.3/etc/protocols So it's the same one. dannym@nova /var/guix/profiles$ ls -L -l system-*-link/etc/protocols -r--r--r-- 1 root root 2932 Jan 1 1970 system-188-link/etc/protocols -r--r--r-- 1 root root 2932 Jan 1 1970 system-189-link/etc/protocols -r--r--r-- 1 root root 2932 Jan 1 1970 system-190-link/etc/protocols -r--r--r-- 1 root root 2932 Jan 1 1970 system-191-link/etc/protocols -r--r--r-- 1 root root 2932 Jan 1 1970 system-192-link/etc/protocols -r--r--r-- 1 root root 2932 Jan 1 1970 system-193-link/etc/protocols -r--r--r-- 1 root root 2932 Jan 1 1970 system-194-link/etc/protocols -r--r--r-- 1 root root 2932 Jan 1 1970 system-195-link/etc/protocols -r--r--r-- 1 root root 2932 Jan 1 1970 system-196-link/etc/protocols -r--r--r-- 1 root root 2932 Jan 1 1970 system-197-link/etc/protocols dannym@nova /var/guix/profiles$ ls -l system-*-link/etc/protocols lrwxrwxrwx 1 root root 70 Jan 1 1970 system-188-link/etc/protocols -> /gnu/store/bfp25w47fxn8z0fdwj45prx2609sx59j-net-base-5.3/etc/protocols lrwxrwxrwx 1 root root 70 Jan 1 1970 system-189-link/etc/protocols -> /gnu/store/bfp25w47fxn8z0fdwj45prx2609sx59j-net-base-5.3/etc/protocols lrwxrwxrwx 1 root root 70 Jan 1 1970 system-190-link/etc/protocols -> /gnu/store/bfp25w47fxn8z0fdwj45prx2609sx59j-net-base-5.3/etc/protocols lrwxrwxrwx 1 root root 70 Jan 1 1970 system-191-link/etc/protocols -> /gnu/store/bfp25w47fxn8z0fdwj45prx2609sx59j-net-base-5.3/etc/protocols lrwxrwxrwx 1 root root 70 Jan 1 1970 system-192-link/etc/protocols -> /gnu/store/bfp25w47fxn8z0fdwj45prx2609sx59j-net-base-5.3/etc/protocols lrwxrwxrwx 1 root root 70 Jan 1 1970 system-193-link/etc/protocols -> /gnu/store/bfp25w47fxn8z0fdwj45prx2609sx59j-net-base-5.3/etc/protocols lrwxrwxrwx 1 root root 70 Jan 1 1970 system-194-link/etc/protocols -> /gnu/store/bfp25w47fxn8z0fdwj45prx2609sx59j-net-base-5.3/etc/protocols lrwxrwxrwx 1 root root 70 Jan 1 1970 system-195-link/etc/protocols -> /gnu/store/bfp25w47fxn8z0fdwj45prx2609sx59j-net-base-5.3/etc/protocols lrwxrwxrwx 1 root root 70 Jan 1 1970 system-196-link/etc/protocols -> /gnu/store/bfp25w47fxn8z0fdwj45prx2609sx59j-net-base-5.3/etc/protocols lrwxrwxrwx 1 root root 70 Jan 1 1970 system-197-link/etc/protocols -> /gnu/store/bfp25w47fxn8z0fdwj45prx2609sx59j-net-base-5.3/etc/protocols Note: sudo guix gc --verify did not find things. I also checked all those system-*link/etc/protocols for NUL bytes now and didn't find any. I also checked both /gnu/store/*-net-base*/etc/protocols I have and both are fine. >In the stop procedure of root-file-system shepherd service, located in >(gnu services base) Thanks. I found it--and it syncs *before* unmounting. Why? umount could totally have added more stuff to the buffer cache (like its superblock update that was updating the dirty flag, or any user writes that had not been flushed to disk yet), no? In any case, I suspect it never reached the "stop" routine. >Probably not, everyone's setup is different, so it's impossible to >properly mount everything. There could be some steps in a script, but >not everything. Well, doing the guix-specific stuff would be good. Basically, what "activate" would do--only actually working (especially with a previous generation). For future reference, after fixing all that, I have this kernel command line: dannym@nova ~$ cat /proc/cmdline BOOT_IMAGE=/gnu/store/csz2yfcdaav8akwv15wvri9jnqqw377i-linux-6.13.11/bzImage root=/dev/mapper/nova-root gnu.system=/gnu/store/1dgdxwxmr3fnjrjp1yl4hhz8m48vaz20-system gnu.load=/gnu/store/1dgdxwxmr3fnjrjp1yl4hhz8m48vaz20-system/boot root_trim=yes iomem=relaxed modprobe.blacklist=pcspkr,snd_pcsp ath9k.use_msi=1 nokaslr quiet zram.num_devices=4 So I suspect had I smuggled gnu.system=/var/guix/profiles/system-193-link gnu.load=/var/guix/profiles/system-193-link/boot into the kernel command line of the rescue system (good luck with that), it would have worked. >From what you said here it seems it would've been possible to boot to >an older generation without recovering from a live iso, but it's much >harder to do than live iso. Is it? I didn't have cp or cat, so no way of me reading what's in grub.cfg--and I'm not correctly guessing these hashes from my human memory: linux /gnu/store/csz2yfcdaav8akwv15wvri9jnqqw377i-linux-6.13.11/bzImage root=/dev/mapper/nova-root gnu.system=/var/guix/profiles/system-196-link gnu.load=/var/guix/profiles/system-196-link/boot root_trim=yes iomem=relaxed modprobe.blacklist=pcspkr,snd_pcsp ath9k.use_msi=1 nokaslr quiet zram.num_devices=4 initrd /gnu/store/ngp975xdm478nqm6wj1mr79xdcvsrqkz-combined-initrd/initrd.img >The sync here is not so important, I would rather unmount it, that's >more effective as you're making sure nothing can write there anymore. Yeah. But I think for correctness, you need to do BOTH. First umount, then sync. Or does umount do sync internally after all that? But I dimly remember floppy drive activity on sync, long after umounting it--internet search yields lots of speculation to that effect and also other speculation against that. Sigh. >Are you using tlp? If you could share anything, I think it would be >good to see your /var/log/messages for when you rebooted. I am using tlp. For after I fixed it: 2025-04-20 22:00:00 localhost shepherd[1]: Deleting old log file '/var/log/messages.11.zst'. 2025-04-20 22:00:00 localhost shepherd[1]: Rotating '/var/log/messages' to '/var/log/messages.1'. 2025-04-20 22:00:00 localhost shepherd[1]: Registering new logger for log-rotation. 2025-04-20 22:00:00 localhost shepherd[1]: Rotated '/var/log/messages'. 2025-04-20 22:00:00 localhost shepherd[1]: Not rotating '/dev/tty12', which is not a regular file. 2025-04-20 22:00:00 localhost shepherd[1]: Deleting old log file '/var/log/debug.11.zst'. 2025-04-20 22:00:00 localhost shepherd[1]: Rotating '/var/log/debug' to '/var/log/debug.1'. 2025-04-20 22:00:00 localhost shepherd[1]: Registering new logger for log-rotation. 2025-04-20 22:00:00 localhost shepherd[1]: Rotated '/var/log/debug'. 2025-04-20 22:00:00 localhost shepherd[1]: Deleting old log file '/var/log/secure.11.zst'. 2025-04-20 22:00:00 localhost shepherd[1]: Rotating '/var/log/secure' to '/var/log/secure.1'. 2025-04-20 22:00:00 localhost shepherd[1]: Registering new logger for log-rotation. 2025-04-20 22:00:00 localhost shepherd[1]: Rotated '/var/log/secure'. 2025-04-20 22:00:00 localhost shepherd[1]: Deleting old log file '/var/log/guix-daemon.log.11.zst'. 2025-04-20 22:00:00 localhost shepherd[1]: Rotating '/var/log/guix-daemon.log' to '/var/log/guix-daemon.log.1'. 2025-04-20 22:00:00 localhost shepherd[1]: Registering new logger for log-rotation. 2025-04-20 22:00:00 localhost shepherd[1]: Rotated '/var/log/guix-daemon.log'. [... and lots of stuff refering to my work mails... not adding that here...] (So I take it we rotate at some random time? Given that system seems to be up in the middle of me using it to read mail right when the rotation happened. That's ok--but good to know) Next, for before I fixed it: So I guess we need /var/log/messages.1.zstd for the time before I rebooted. That one it said it rotated to messages.1 (no ".zstd")--which doesn't exist. grep for "Apr.*20" over all "messages"* (after uncompressing them) gave me: messages.1 (so from messages.1.zstd). So I guess that one is meant. That one starts at Apr 13 and ends at end of Apr 20. I copied messages* away so I will still have them. I checked the contents of messages.1 and at least it's easy to find the spot since there's a big block of damage in there, see end (note: I manually removed lines containing secret keys :P): [...] 2025-04-20 15:54:54 localhost shepherd[1]: Stopping service nscd... 2025-04-20 15:54:54 localhost shepherd[1]: Service nscd stopped. 2025-04-20 15:54:54 localhost shepherd[1]: Service nscd is now stopped. 2025-04-20 15:54:54 localhost shepherd[1]: Starting service user-homes... 2025-04-20 15:54:54 localhost shepherd[1]: Service user-homes has been started. 2025-04-20 15:54:54 localhost shepherd[1]: Service user-homes started. 2025-04-20 15:54:54 localhost shepherd[1]: Service user-homes running with value #t. 2025-04-20 15:54:54 localhost shepherd[1]: Starting service nscd... 2025-04-20 15:54:54 localhost nscd: 2272 monitoring file `/etc/passwd` (1) 2025-04-20 15:54:54 localhost nscd: 2272 monitoring directory `/etc` (2) 2025-04-20 15:54:54 localhost nscd: 2272 monitoring file `/etc/group` (3) 2025-04-20 15:54:54 localhost nscd: 2272 monitoring directory `/etc` (2) 2025-04-20 15:54:54 localhost nscd: 2272 monitoring file `/etc/hosts` (4) 2025-04-20 15:54:54 localhost nscd: 2272 monitoring directory `/etc` (2) 2025-04-20 15:54:54 localhost nscd: 2272 monitoring file `/etc/resolv.conf` (5) 2025-04-20 15:54:54 localhost nscd: 2272 monitoring directory `/etc` (2) 2025-04-20 15:54:54 localhost nscd: 2272 monitoring file `/etc/services` (6) 2025-04-20 15:54:54 localhost nscd: 2272 monitoring directory `/etc` (2) 2025-04-20 15:54:54 localhost nscd: 2272 monitoring file `/etc/nsswitch.conf` (7) 2025-04-20 15:54:54 localhost nscd: 2272 monitoring directory `/etc` (2) 2025-04-20 15:54:54 localhost nscd: 2272 monitoring file `/etc/nsswitch.conf` (7) 2025-04-20 15:54:54 localhost nscd: 2272 monitoring directory `/etc` (2) 2025-04-20 15:54:54 localhost nscd: 2272 monitoring file `/etc/nsswitch.conf` (7) 2025-04-20 15:54:54 localhost nscd: 2272 monitoring directory `/etc` (2) 2025-04-20 15:54:54 localhost nscd: 2272 monitoring file `/etc/nsswitch.conf` (7) 2025-04-20 15:54:54 localhost nscd: 2272 monitoring directory `/etc` (2) 2025-04-20 15:54:54 localhost shepherd[1]: Service rpc.statd has been started. 2025-04-20 15:54:54 localhost shepherd[1]: Service rpc.statd started. 2025-04-20 15:54:54 localhost shepherd[1]: Service rpc.statd running with value #<<process> id: 2141 command: ("/gnu/store/7hh8w39sqi94s70b30sffaai72vap6aw-nfs-utils-2.4.3/sbin/rpc.statd" "--no-notify" "--foreground")>. 2025-04-20 15:54:54 localhost shepherd[1]: Starting service rpc.mountd... 2025-04-20 15:54:54 localhost shepherd[1]: Starting service rpc.nfsd... 2025-04-20 15:54:54 localhost shepherd[1]: Service rpc.mountd has been started. 2025-04-20 15:54:54 localhost shepherd[1]: Service rpc.mountd started. 2025-04-20 15:54:54 localhost shepherd[1]: Service rpc.mountd running with value #<<process> id: 2359 command: ("/gnu/store/7hh8w39sqi94s70b30sffaai72vap6aw-nfs-utils-2.4.3/sbin/rpc.mountd" "--foreground")>. 2025-04-20 15:54:54 localhost rpc.mountd[2359]: Version 2.4.3 starting 2025-04-20 15:54:54 localhost shepherd[1]: rpc.mountd[2359] rpc.mountd: Version 2.4.3 starting 2025-04-20 15:54:54 localhost ntpd[2131]: Soliciting pool server 178.251.64.52 2025-04-20 15:54:54 localhost ntpd[2131]: 178.251.64.52 local addr <null> -> 192.168.10.144 2025-04-20 15:54:54 localhost linux: [ 28.965668] fuse: init (API version 7.41) 2025-04-20 15:54:54 localhost obexd[2418]: OBEX daemon 5.72 2025-04-20 15:54:55 localhost gnome-keyring-daemon[2427]: couldn't access control socket: /run/user/1000/keyring/control: No such file or directory 2025-04-20 15:54:55 localhost gnome-keyring-daemon[2427]: discover_other_daemon: 0 2025-04-20 15:54:55 localhost gcr-prompter[2435]: Gcr: bus acquired: org.gnome.keyring.SystemPrompter 2025-04-20 15:54:55 localhost gcr-prompter[2435]: Gcr: registering prompter 2025-04-20 15:54:55 localhost gcr-prompter[2435]: Gcr: bus acquired: org.gnome.keyring.PrivatePrompter 2025-04-20 15:54:55 localhost gcr-prompter[2435]: Gcr: acquired name: org.gnome.keyring.SystemPrompter 2025-04-20 15:54:55 localhost gcr-prompter[2435]: Gcr: received BeginPrompting call from callback /org/gnome/keyring/Prompt/p2@:1.27 2025-04-20 15:54:55 localhost gcr-prompter[2435]: Gcr: preparing a prompt for callback /org/gnome/keyring/Prompt/p2@:1.27 2025-04-20 15:54:55 localhost gcr-prompter[2435]: Gcr: creating new GcrPromptDialog prompt 2025-04-20 15:54:55 localhost gcr-prompter[2435]: Gcr: automatically selecting secret exchange protocol 2025-04-20 15:54:55 localhost gcr-prompter[2435]: Gcr: generating public key 2025-04-20 15:54:55 localhost gcr-prompter[2435]: Gcr: calling the PromptReady method on /org/gnome/keyring/Prompt/p2@:1.27 2025-04-20 15:54:55 localhost gcr-prompter[2435]: Gcr: acquired name: org.gnome.keyring.PrivatePrompter 2025-04-20 15:54:55 localhost gcr-prompter[2435]: Gcr: returned from the PromptReady method on /org/gnome/keyring/Prompt/p2@:1.27 2025-04-20 15:54:55 localhost gcr-prompter[2435]: Gcr: received PerformPrompt call from callback /org/gnome/keyring/Prompt/p2@:1.27 2025-04-20 15:54:55 localhost gcr-prompter[2435]: Gcr: deriving shared transport key 2025-04-20 15:54:55 localhost gcr-prompter[2435]: Gcr: deriving transport key 2025-04-20 15:54:55 localhost gcr-prompter[2435]: Gcr: starting password prompt for callback /org/gnome/keyring/Prompt/p2@:1.27 2025-04-20 15:54:55 localhost shepherd[1]: Service nscd has been started. 2025-04-20 15:54:55 localhost shepherd[1]: Service nscd started. 2025-04-20 15:54:55 localhost shepherd[1]: Service nscd running with value #<<process> id: 2272 command: ("/gnu/store/hw6g2kjayxnqi8rwpnmpraalxi0djkxc-glibc-2.39/sbin/nscd" "-f" "/gnu/store/mam32iva1j0kfrnd1dncj0l4f3bx55l0-nscd.conf" "--foreground")>. 2025-04-20 15:54:55 localhost shepherd[1]: [NetworkManager] Service user-homes has been started. 2025-04-20 15:54:55 localhost shepherd[1]: [NetworkManager] Service nscd has been started. 2025-04-20 15:54:55 localhost NetworkManager[1619]: <info> [1745157295.2563] dhcp6 (wlp5s0): state changed new lease, address=fd96:f37e:6837::d9c 2a02:8388:184d:f020::d9c 2025-04-20 15:54:55 localhost NetworkManager[1619]: <info> [1745157295.2773] agent-manager: agent[19c20ae18da97638,:1.19/org.freedesktop.nm-applet/1000]: agent registered 2025-04-20 15:54:55 localhost ntpd[2131]: Soliciting pool server 162.159.200.123 2025-04-20 15:54:55 localhost ntpd[2131]: 162.159.200.123 local addr <null> -> 192.168.10.144 2025-04-20 15:54:55 localhost shepherd[1]: Service rpc.nfsd has been started. 2025-04-20 15:54:55 localhost shepherd[1]: Service rpc.nfsd started. 2025-04-20 15:54:55 localhost shepherd[1]: Service rpc.nfsd running with value #t. 2025-04-20 15:54:55 localhost linux: [ 29.920473] NFSD: Unable to initialize client recovery tracking! (-110) 2025-04-20 15:54:55 localhost linux: [ 29.920479] NFSD: Is nfsdcld running? If not, enable CONFIG_NFSD_LEGACY_CLIENT_TRACKING. 2025-04-20 15:54:55 localhost linux: [ 29.920481] NFSD: starting 90-second grace period (net f0000000) 2025-04-20 15:54:55 localhost shepherd[1]: Starting service nfs... 2025-04-20 15:54:55 localhost shepherd[1]: [exportfs] exporting *:/home/dannym/src/Oxide 2025-04-20 15:54:55 localhost shepherd[1]: Service nfs has been started. 2025-04-20 15:54:55 localhost shepherd[1]: Service nfs started. 2025-04-20 15:54:55 localhost shepherd[1]: Successfully started 82 services in the background. 2025-04-20 15:54:55 localhost shepherd[1]: Service nfs running with value #t. 2025-04-20 15:54:56 localhost ntpd[2131]: Soliciting pool server 152.53.132.244 2025-04-20 15:54:56 localhost ntpd[2131]: 152.53.132.244 local addr <null> -> 192.168.10.144 2025-04-20 15:54:57 localhost gcr-prompter[2435]: Gcr: completed password prompt for callback :1.27@/org/gnome/keyring/Prompt/p2 2025-04-20 15:54:57 localhost gcr-prompter[2435]: Gcr: encrypting data 2025-04-20 15:54:57 localhost gcr-prompter[2435]: Gcr: calling the PromptReady method on /org/gnome/keyring/Prompt/p2@:1.27 2025-04-20 15:54:57 localhost gcr-prompter[2435]: Gcr: returned from the PromptReady method on /org/gnome/keyring/Prompt/p2@:1.27 2025-04-20 15:54:57 localhost gcr-prompter[2435]: Gcr: received PerformPrompt call from callback /org/gnome/keyring/Prompt/p2@:1.27 2025-04-20 15:54:57 localhost gcr-prompter[2435]: Gcr: stopping prompting for operation /org/gnome/keyring/Prompt/p2@:1.27 2025-04-20 15:54:57 localhost gcr-prompter[2435]: Gcr: closing the prompt 2025-04-20 15:54:57 localhost gcr-prompter[2435]: Gcr: stopping prompting for operation /org/gnome/keyring/Prompt/p2@:1.27 2025-04-20 15:54:57 localhost gcr-prompter[2435]: Gcr: couldn't find the callback for prompting operation /org/gnome/keyring/Prompt/p2@:1.27 2025-04-20 15:54:57 localhost gcr-prompter[2435]: Gcr: stopping prompting for operation /org/gnome/keyring/Prompt/p2@:1.27 2025-04-20 15:54:57 localhost gcr-prompter[2435]: Gcr: couldn't find the callback for prompting operation /org/gnome/keyring/Prompt/p2@:1.27 2025-04-20 15:54:57 localhost gcr-prompter[2435]: Gcr: stopping prompting for operation /org/gnome/keyring/Prompt/p2@:1.27 2025-04-20 15:54:57 localhost gcr-prompter[2435]: Gcr: couldn't find the callback for prompting operation /org/gnome/keyring/Prompt/p2@:1.27 2025-04-20 15:54:57 localhost gcr-prompter[2435]: Gcr: calling the PromptDone method on /org/gnome/keyring/Prompt/p2@:1.27, and ignoring reply 2025-04-20 15:54:57 localhost ntpd[2131]: Soliciting pool server 91.206.8.34 2025-04-20 15:54:57 localhost ntpd[2131]: 91.206.8.34 local addr <null> -> 192.168.10.144 2025-04-20 15:54:58 localhost linux: [ 32.478303] ath: phy0: __ath9k_hw_enable_interrupts: _msi_reg = 0x6A0C9C8 2025-04-20 15:54:59 localhost ntpd[2131]: Listen normally on 6 wlp5s0 [fd96:f37e:6837::d9c]:123 2025-04-20 15:54:59 localhost ntpd[2131]: Listen normally on 7 wlp5s0 [2a02:8388:184d:f020::d9c]:123 2025-04-20 15:54:59 localhost ntpd[2131]: Listen normally on 8 wlp5s0 [2a02:8388:184d:f020:16d0:36cd:6a73:78cc]:123 2025-04-20 15:54:59 localhost ntpd[2131]: Listen normally on 9 wlp5s0 [fd96:f37e:6837:0:5ccf:aacf:cef:3033]:123 2025-04-20 15:54:59 localhost ntpd[2131]: Listen normally on 10 wlp5s0 [fe80::5b28:560f:d64f:8272%2]:123 2025-04-20 15:54:59 localhost ntpd[2131]: new interface(s) found: waking up resolver 2025-04-20 15:55:01 localhost dbus-daemon[902]: [system] Activating service name='org.freedesktop.fwupd' requested by ':1.30' (uid=1000 pid=2557 comm="/home/dannym/.guix-home/profile/bin/fwupdmgr") (using servicehelper) 2025-04-20 15:55:02 localhost dbus-daemon[902]: [system] Activating service name='org.freedesktop.UDisks2' requested by ':1.31' (uid=0 pid=2564 comm="/gnu/store/wbp9hl5hiyfcb97qp60pkvz1x23az72y-fwupd-") (using servicehelper) 2025-04-20 15:55:02 localhost linux: [ 36.347540] nvme nvme0: using unchecked data buffer 2025-04-20 15:55:02 localhost dbus-daemon[902]: [system] Successfully activated service 'org.freedesktop.UDisks2' 2025-04-20 15:55:02 localhost dbus-daemon[902]: [system] Successfully activated service 'org.freedesktop.fwupd' 2025-04-20 15:55:06 localhost wpa_supplicant[1180]: wlp5s0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-62 noise=-91 txrate=6000 2025-04-20 15:55:06 localhost linux: [ 40.710547] ath: phy0: __ath9k_hw_enable_interrupts: _msi_reg = 0x6A0C9C8 2025-04-20 15:55:07 localhost gcr-prompter[2435]: Gcr: 10 second inactivity timeout, quitting 2025-04-20 15:55:07 localhost gcr-prompter[2435]: Gcr: unregistering prompter 2025-04-20 15:55:07 localhost gcr-prompter[2435]: Gcr: disposing prompter 2025-04-20 15:55:07 localhost gcr-prompter[2435]: Gcr: finalizing prompter 2025-04-20 15:55:22 localhost wpa_supplicant[1180]: wlp5s0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-56 noise=-91 txrate=121500 2025-04-20 15:56:04 localhost ntpd[2131]: Soliciting pool server 2a02:1748:0:1500:3::2005 2025-04-20 15:56:04 localhost ntpd[2131]: 2a02:1748:0:1500:3::2005 local addr <null> -> 2a02:8388:184d:f020::d9c 2025-04-20 15:56:05 localhost ntpd[2131]: Soliciting pool server 2a02:1748:0:1500:1::8002 2025-04-20 15:56:05 localhost ntpd[2131]: 2a02:1748:0:1500:1::8002 local addr <null> -> 2a02:8388:184d:f020::d9c 2025-04-20 15:56:06 localhost ntpd[2131]: Soliciting pool server 2a0a:4cc0:c0:1264:c4b0:eaff:fe65:e4bf 2025-04-20 15:56:06 localhost ntpd[2131]: 2a0a:4cc0:c0:1264:c4b0:eaff:fe65:e4bf local addr <null> -> 2a02:8388:184d:f020::d9c 2025-04-20 15:56:07 localhost ntpd[2131]: Soliciting pool server 2606:4700:f1::1 2025-04-20 15:56:07 localhost ntpd[2131]: 2606:4700:f1::1 local addr <null> -> 2a02:8388:184d:f020::d9c 2025-04-20 15:56:37 localhost wpa_supplicant[1180]: wlp5s0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-67 noise=-91 txrate=216000 2025-04-20 15:56:38 localhost linux: [ 132.293806] ath: phy0: __ath9k_hw_enable_interrupts: _msi_reg = 0x6A0C9C8 2025-04-20 15:56:43 localhost linux: [ 137.571269] ath: phy0: __ath9k_hw_enable_interrupts: _msi_reg = 0x6A0C9C8 2025-04-20 15:56:47 localhost wpa_supplicant[1180]: wlp5s0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-64 noise=-92 txrate=6000 2025-04-20 15:56:57 localhost wpa_supplicant[1180]: wlp5s0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-56 noise=-92 txrate=6000 2025-04-20 15:57:05 localhost wpa_supplicant[1180]: wlp5s0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-70 noise=-92 txrate=6000 2025-04-20 15:57:10 localhost linux: [ 165.038608] ath: phy0: __ath9k_hw_enable_interrupts: _msi_reg = 0x6A0C9C8 2025-04-20 15:57:15 localhost wpa_supplicant[1180]: wlp5s0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-60 noise=-92 txrate=6000 2025-04-20 15:57:19 localhost wpa_supplicant[1180]: wlp5s0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-71 noise=-92 txrate=135000 2025-04-20 15:57:21 localhost linux: [ 176.142341] ath: phy0: __ath9k_hw_enable_interrupts: _msi_reg = 0x6A0C9C8 2025-04-20 15:57:23 localhost linux: [ 177.659014] ath: phy0: __ath9k_hw_enable_interrupts: _msi_reg = 0x6A0C9C8 2025-04-20 15:57:29 localhost wpa_supplicant[1180]: wlp5s0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-60 noise=-92 txrate=6000 2025-04-20 15:57:38 localhost wpa_supplicant[1180]: wlp5s0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-67 noise=-92 txrate=135000 2025-04-20 15:57:42 localhost shepherd[1]: Spawning systemd-style service /gnu/store/xl8ih9f81aws1pykwfc4v1irywa87pbb-guix-1.4.0-36.0772d36/bin/guix-daemon. 2025-04-20 15:57:42 localhost shepherd[1]: Running value of service guix-daemon changed to #<<process> id: 3028 command: ("/gnu/store/xl8ih9f81aws1pykwfc4v1irywa87pbb-guix-1.4.0-36.0772d36/bin/guix-daemon" "--build-users-group" "guixbuild" "--max-silent-time" "3600" "--timeout" "86400" "--log-compression" "gzip" "--discover=no" "--substitute-urls" "https://bordeaux.guix.gnu.org https://ci.guix.gnu.org https://substitutes.nonguix.org")>. 2025-04-20 15:57:46 localhost linux: [ 200.619697] ath: phy0: __ath9k_hw_enable_interrupts: _msi_reg = 0x6A0C9C8 2025-04-20 15:57:47 localhost wpa_supplicant[1180]: wlp5s0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-55 noise=-90 txrate=6000 2025-04-20 15:57:51 localhost wpa_supplicant[1180]: wlp5s0: CTRL-EVENT-SIGNAL-CHANGE above=0 signal=-68 noise=-90 txrate=6000 2025-04-20 15:58:01 localhost wpa_supplicant[1180]: wlp5s0: CTRL-EVENT-SIGNAL-CHANGE above=1 signal=-58 noise=-90 txrate=6000 2025-04-20 15:58:04 localhost nscd: 2272 monitored file `/etc/hosts` was deleted, removing watch 2025-04-20 15:58:04 localhost nscd: 2272 monitored file `/etc/hosts` was created, adding watch 2025-04-20 15:58:04 localhost nscd: 2272 monitored file `/etc/hosts` was written to 2025-04-20 15:58:04 localhost nscd: 2272 monitored file `/etc/nsswitch.conf` was deleted, removing watch 2025-04-20 15:58:04 localhost nscd: 2272 monitored file `/etc/nsswitch.conf` was deleted, removing watch 2025-04-20 15:58:04 localhost nscd: 2272 monitored file `/etc/nsswitch.conf` was created, adding watch 2025-04-20 15:58:04 localhost nscd: 2272 monitored file `/etc/nsswitch.conf` was created, adding watch 2025-04-20 15:58:04 localhost nscd: 2272 monitored file `/etc/nsswitch.conf` was created, adding watch 2025-04-20 15:58:04 localhost nscd: 2272 monitored file `/etc/nsswitch.conf` was created, adding watch 2025-04-20 15:58:04 localhost nscd: 2272 monitored file `/etc/nsswitch.conf` was written to 2025-04-20 15:58:04 localhost nscd: 2272 monitored file `/etc/services` was deleted, removing watch 2025-04-20 15:58:04 localhost nscd: 2272 monitored file `/etc/services` was created, adding watch 2025-04-20 15:58:04 localhost nscd: 2272 monitored file `/etc/services` was written to 2025-04-20 15:58:04 localhost nscd: 2272 monitored file `/etc/group` was moved into place, adding watch 2025-04-20 15:58:04 localhost nscd: 2272 monitored file `/etc/passwd` was moved into place, adding watch ^@^@^@...............................................^@^@^@^@