Bug 14708

Summary:	[3.5 M2] Failed to boot up on NFS with systemd
Product:	[Build System, Metadata & Runtime] OE-Core	Reporter:	Yi Zhao <yi.zhao>
Component:	core	Assignee:	Pavel Zhukov <pavel>
Status:	VERIFIED FIXED	QA Contact:	Yi Zhao <yi.zhao>
Severity:	normal
Priority:	High	CC:	andrei, denis, jay.shen.teoh, meta.mr.watcher, meta.watcher, pavel, Qi.Chen, randy.macleod, yi.zhao
Version:	4.0
Target Milestone:	4.0 M3
Hardware:	x86
OS:	Multiple
Whiteboard:
OS type for building Yocto:	---	Type of Regression:	Regression (Used to work)
Verified:		Documentation change:	No (bug/feature does not impact docs)

Description Yi Zhao 2022-01-29 06:41:59 UTC

Git rev: master/27ff420543f0195dab024698d804aca33f2ae139
Image Location: https://autobuilder.yocto.io/pub/releases/yocto-3.5_M2.rc6/machines/edgerouter-alt/

Steps:
1. Deploy the alt rootfs on NFS.
2. boot cmdline:
   bootoctlinux $loadaddr coremask=0x3 root=/dev/nfs ip=128.224.165.32::128.224.165.1:255.255.254.0:edge:eth0:off nfsroot=128.224.178.20:/export/pxeboot/vlm-boards/22053/rootfs mtdparts=phys_mapped_flash:512k(boot0),512k(boot1),64k@3072k(eeprom) console=ttyS0,115200

The system can not boot up. Here are the boot messages:

U-Boot 1.1.1 (UBNT Build ID: 4493936-g009d77b) (Build time: Sep 20 2012 - 15:48:51)

BIST check passed.
UBNT_E100 r1:2, r2:12, serial #: DC9FDB29DAEF
Core clock: 500 MHz, DDR clock: 266 MHz (532 Mhz data rate)
DRAM:  512 MB
Clearing DRAM....... done
Flash:  4 MB
Net:   octeth0, octeth1, octeth2

USB:   (port 0) No USB devices found.
 0 
Interface 0 has 3 ports (RGMII)
Using octeth0 device
TFTP from server 128.224.178.20; our IP address is 128.224.165.32; sending through gateway 128.224.165.1
Filename 'vlm-boards/22053/kernel'.
Load address: 0x9f00000
Loading: octeth0: Up 1000 Mbps Full duplex (port  0)
#################################################################
	 ###########################################################
done
Bytes transferred = 17710600 (10e3e08 hex), 5534 Kbytes/sec
argv[2]: coremask=0x3
argv[3]: root=/dev/nfs
argv[4]: ip=128.224.165.32::128.224.165.1:255.255.254.0:edge:eth0:off
argv[5]: nfsroot=128.224.178.20:/export/pxeboot/vlm-boards/22053/rootfs
argv[6]: mtdparts=phys_mapped_flash:512k(boot0),512k(boot1),64k@3072k(eeprom)
ELF file is 64 bit
Allocating memory for ELF segment: addr: 0xffffffff81100000 (adjusted to: 0x1100000), size 0x219e230
Allocated memory for ELF segment: addr: 0xffffffff81100000, size 0x219e230
Processing PHDR 0
  Loading 10e27a0 bytes at ffffffff81100000
  Clearing 10bba90 bytes at ffffffff821e27a0
## Loading Linux kernel with entry point: 0xffffffff81c9c968 ...
Bootloader: Done loading app on coremask: 0x3
Linux version 5.10.63-yocto-standard (oe-user@oe-host) (mips64-poky-linux-gcc (GCC) 11.2.0, GNU ld (GNU Binutils) 2.37.20210721) #1 SMP PREEMPT Thu Sep 9 02:58:26 UTC 2021
CVMSEG size: 2 cache lines (256 bytes)
printk: bootconsole [early0] enabled
CPU0 revision is: 000d0601 (Cavium Octeon+)
Wasting 278528 bytes for tracking 4352 unused pages
Initrd not found or empty - disabling initrd
Using internal Device Tree.
software IO TLB: mapped [mem 0x0000000003309000-0x0000000007309000] (64MB)
Primary instruction cache 32kB, virtually tagged, 4 way, 64 sets, linesize 128 bytes.
Primary data cache 16kB, 64-way, 2 sets, linesize 128 bytes.
Zone ranges:
  DMA32    [mem 0x0000000001100000-0x00000000efffffff]
  Normal   [mem 0x00000000f0000000-0x000000041fbfffff]
Movable zone start for each node
Early memory node ranges
  node   0: [mem 0x0000000001100000-0x000000000329dfff]
  node   0: [mem 0x0000000003300000-0x0000000007efffff]
  node   0: [mem 0x0000000008200000-0x000000000fdfffff]
  node   0: [mem 0x0000000410000000-0x000000041fbfffff]
Initmem setup node 0 [mem 0x0000000001100000-0x000000041fbfffff]
On node 0, zone DMA32: 4352 pages in unavailable ranges
On node 0, zone DMA32: 98 pages in unavailable ranges
On node 0, zone DMA32: 768 pages in unavailable ranges
On node 0, zone Normal: 512 pages in unavailable ranges
On node 0, zone Normal: 1024 pages in unavailable ranges
percpu: Embedded 29 pages/cpu s79776 r8192 d30816 u118784
Built 1 zonelists, mobility grouping on.  Total pages: 122375
Kernel command line:  bootoctlinux $loadaddr coremask=0x3 root=/dev/nfs ip=128.224.165.32::128.224.165.1:255.255.254.0:edge:eth0:off nfsroot=128.224.178.20:/export/pxeboot/vlm-boards/22053/rootfs mtdparts=phys_mapped_flash:512k(boot0),512k(boot1),64k@3072k(eeprom) console=ttyS0,115200
Dentry cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
Inode-cache hash table entries: 32768 (order: 6, 262144 bytes, linear)
mem auto-init: stack:off, heap alloc:off, heap free:off
Memory: 387680K/497272K available (11932K kernel code, 2024K rwdata, 2592K rodata, 776K init, 17080K bss, 109592K reserved, 0K cma-reserved)
SLUB: HWalign=128, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
ftrace: allocating 31887 entries in 125 pages
ftrace: allocated 125 pages with 6 groups
rcu: Preemptible hierarchical RCU implementation.
rcu: 	RCU event tracing is enabled.
rcu: 	RCU restricting CPUs from NR_CPUS=32 to nr_cpu_ids=2.
	Trampoline variant of Tasks RCU enabled.
	Rude variant of Tasks RCU enabled.
	Tracing variant of Tasks RCU enabled.
rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
NR_IRQS: 512
random: get_random_bytes called from start_kernel+0x444/0x6cc with crng_init=0
clocksource: OCTEON_CVMCOUNT: mask: 0xffffffffffffffff max_cycles: 0xe6a171a037, max_idle_ns: 881590485102 ns
Console: colour dummy device 80x25
Calibrating delay loop (skipped) preset value.. 1000.00 BogoMIPS (lpj=5000000)
pid_max: default: 32768 minimum: 301
LSM: Security Framework initializing
Mount-cache hash table entries: 1024 (order: 1, 8192 bytes, linear)
Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes, linear)
rcu: Hierarchical SRCU implementation.
smp: Bringing up secondary CPUs ...
SMP: Booting CPU01 (CoreId  1)...
CPU1 revision is: 000d0601 (Cavium Octeon+)
smp: Brought up 1 node, 2 CPUs
devtmpfs: initialized
clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
futex hash table entries: 512 (order: 4, 65536 bytes, linear)
NET: Registered protocol family 16
Not in host mode, PCI Controller not initialized
raid6: int64x8  gen()   214 MB/s
raid6: int64x8  xor()   165 MB/s
random: fast init done
raid6: int64x4  gen()   367 MB/s
raid6: int64x4  xor()   205 MB/s
raid6: int64x2  gen()   394 MB/s
raid6: int64x2  xor()   204 MB/s
raid6: int64x1  gen()   333 MB/s
raid6: int64x1  xor()   153 MB/s
raid6: using algorithm int64x2 gen() 394 MB/s
raid6: .... xor() 204 MB/s, rmw enabled
raid6: using intx1 recovery algorithm
vgaarb: loaded
SCSI subsystem initialized
usbcore: registered new interface driver usbfs
usbcore: registered new interface driver hub
usbcore: registered new device driver usb
clocksource: Switched to clocksource OCTEON_CVMCOUNT
NET: Registered protocol family 2
IP idents hash table entries: 8192 (order: 4, 65536 bytes, linear)
tcp_listen_portaddr_hash hash table entries: 256 (order: 0, 4096 bytes, linear)
TCP established hash table entries: 4096 (order: 3, 32768 bytes, linear)
TCP bind hash table entries: 4096 (order: 4, 65536 bytes, linear)
TCP: Hash tables configured (established 4096 bind 4096)
UDP hash table entries: 256 (order: 1, 8192 bytes, linear)
UDP-Lite hash table entries: 256 (order: 1, 8192 bytes, linear)
NET: Registered protocol family 1
RPC: Registered named UNIX socket transport module.
RPC: Registered udp transport module.
RPC: Registered tcp transport module.
RPC: Registered tcp NFSv4.1 backchannel transport module.
PCI: CLS 0 bytes, default 128
workingset: timestamp_bits=46 max_order=17 bucket_order=0
NFS: Registering the id_resolver key type
Key type id_resolver registered
Key type id_legacy registered
Key type cifs.idmap registered
xor: measuring software checksum speed
   8regs           :   876 MB/sec
   8regs_prefetch  :   768 MB/sec
   32regs          :   982 MB/sec
   32regs_prefetch :   892 MB/sec
xor: using function: 32regs (982 MB/sec)
Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
io scheduler mq-deadline registered
io scheduler kyber registered
octeon_gpio 1070000000800.gpio-controller: OCTEON GPIO driver probed.
Serial: 8250/16550 driver, 2 ports, IRQ sharing disabled
printk: console [ttyS0] disabled
1180000000800.serial: ttyS0 at MMIO 0x1180000000800 (irq = 41, base_baud = 31250000) is a OCTEON
printk: console [ttyS0] enabled
printk: console [ttyS0] enabled
printk: bootconsole [early0] disabled
printk: bootconsole [early0] disabled
1180000000c00.serial: ttyS1 at MMIO 0x1180000000c00 (irq = 42, base_baud = 31250000) is a OCTEON
octeon_rng octeon_rng: Octeon Random Number Generator
brd: module loaded
libphy: Fixed MDIO Bus: probed
libphy: mdio_octeon: probed
[Firmware Warn]: /soc@0/mdio@1180000001800/ethernet-phy@7: Whitelisted compatible string. Please remove
[Firmware Warn]: /soc@0/mdio@1180000001800/ethernet-phy@6: Whitelisted compatible string. Please remove
[Firmware Warn]: /soc@0/mdio@1180000001800/ethernet-phy@5: Whitelisted compatible string. Please remove
mdio_octeon 1180000001800.mdio: Probed
ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
ehci-pci: EHCI PCI platform driver
ehci-platform: EHCI generic platform driver
ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
ohci-pci: OHCI PCI platform driver
ohci-platform: OHCI generic platform driver
usbcore: registered new interface driver usb-storage
i2c-octeon 1180000001000.i2c: probed
octeon_wdt: Initial granularity 5 Sec
device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: dm-devel@redhat.com
usbcore: registered new interface driver usbhid
usbhid: USB HID core driver
Interface 0 has 3 ports (RGMII)
octeon-hcd 16f0010000000.usbc: Octeon Host Controller
octeon-hcd 16f0010000000.usbc: new USB bus registered, assigned bus number 1
octeon-hcd 16f0010000000.usbc: irq 56, io mem 0x00000000
hub 1-0:1.0: USB hub found
hub 1-0:1.0: 1 port detected
octeon-hcd 16f0010000000.usbc: Registered HCD for port 0 on irq 56
u32 classifier
    input device check on
    Actions configured
NET: Registered protocol family 10
Segment Routing with IPv6
sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
NET: Registered protocol family 17
Bridge firewalling registered
Key type dns_resolver registered
oprofile: using timer interrupt.
Bootbus flash: Setting flash for 4MB flash at 0x1f800000
phys_mapped_flash: Found 1 x16 devices at 0x0 in 8-bit bank. Manufacturer ID 0x0000c2 Chip ID 0x0000a7
Amd/Fujitsu Extended Query Table at 0x0040
  Amd/Fujitsu Extended Query version 1.1.
phys_mapped_flash: Swapping erase regions for top-boot CFI table.
number of CFI chips: 1
3 cmdlinepart partitions found on MTD device phys_mapped_flash
Creating 3 MTD partitions on "phys_mapped_flash":
0x000000000000-0x000000080000 : "boot0"
0x000000080000-0x000000100000 : "boot1"
0x000000300000-0x000000310000 : "eeprom"
Key type ._fscrypt registered
Key type .fscrypt registered
Key type fscrypt-provisioning registered
Btrfs loaded, crc32c=crc32c-generic
Key type encrypted registered
printk: console [netcon0] enabled
netconsole: network logging started
OF: fdt: not creating '/sys/firmware/fdt': CRC check failed
eth0: 1000 Mbps Full duplex, port 0, queue 0
IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
IP-Config: Complete:
     device=eth0, hwaddr=dc:9f:db:29:da:ef, ipaddr=128.224.165.32, mask=255.255.254.0, gw=128.224.165.1
     host=edge, domain=, nis-domain=(none)
     bootserver=255.255.255.255, rootserver=128.224.178.20, rootpath=
md: Waiting for all devices to be available before autodetect
md: If you don't use raid, use raid=noautodetect
md: Autodetecting RAID arrays.
md: autorun ...
md: ... autorun DONE.
VFS: Mounted root (nfs filesystem) readonly on device 0:14.
devtmpfs: mounted
Freeing unused kernel memory: 776K
This architecture does not have kernel memory protection.
Run /sbin/init as init process
process '/lib/systemd/systemd' started with executable stack
systemd[1]: System time before build time, advancing clock.
systemd[1]: systemd 250.3+ running in system mode (+PAM -AUDIT -SELINUX -APPARMOR +IMA -SMACK -SECCOMP -GCRYPT -GNUTLS -OPENSSL +ACL +BLKID -CURL -ELFUTILS -FIDO2 -IDN2 -IDN -IPTC +KMOD -LIBCRYPTSETUP +LIBFDISK -PCRE2 -PWQUALITY -P11KIT -QRENCODE -BZIP2 -LZ4 -XZ -ZLIB +ZSTD -BPF_FRAMEWORK +XKBCOMMON +UTMP +SYSVINIT default-hierarchy=hybrid)
systemd[1]: Detected architecture mips64.

Welcome to Poky (Yocto Project Reference Distro) 3.4+snapshot-27ff420543f0195dab024698d804aca33f2ae139 (master)!

systemd[1]: Hostname set to <edgerouter>.
random: systemd: uninitialized urandom read (16 bytes read)
systemd[1]: Initializing machine ID from random generator.
systemd[1]: Installed transient /etc/machine-id file.
systemd[97]: /lib/systemd/system-generators/systemd-gpt-auto-generator failed with exit status 1.
random: crng init done
systemd[1]: Queued start job for default target Graphical Interface.
systemd[1]: Created slice Slice /system/getty.
[  OK  ] Created slice Slice /system/getty.
systemd[1]: Created slice Slice /system/modprobe.
[  OK  ] Created slice Slice /system/modprobe.
systemd[1]: Created slice Slice /system/serial-getty.
[  OK  ] Created slice Slice /system/serial-getty.
systemd[1]: Created slice User and Session Slice.
[  OK  ] Created slice User and Session Slice.
systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[  OK  ] Started Dispatch Password …ts to Console Directory Watch.
systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[  OK  ] Started Forward Password R…uests to Wall Directory Watch.
systemd[1]: Reached target Host and Network Name Lookups.
[  OK  ] Reached target Host and Network Name Lookups.
systemd[1]: Reached target Path Units.
[  OK  ] Reached target Path Units.
systemd[1]: Reached target Remote File Systems.
[  OK  ] Reached target Remote File Systems.
systemd[1]: Reached target Slice Units.
[  OK  ] Reached target Slice Units.
systemd[1]: Reached target Swaps.
[  OK  ] Reached target Swaps.
systemd[1]: Listening on RPCbind Server Activation Socket.
[  OK  ] Listening on RPCbind Server Activation Socket.
systemd[1]: Reached target RPC Port Mapper.
[  OK  ] Reached target RPC Port Mapper.
systemd[1]: Listening on Syslog Socket.
[  OK  ] Listening on Syslog Socket.
systemd[1]: Listening on initctl Compatibility Named Pipe.
[  OK  ] Listening on initctl Compatibility Named Pipe.
systemd[1]: Journal Audit Socket was skipped because of a failed condition check (ConditionSecurity=audit).
systemd[1]: Listening on Journal Socket (/dev/log).
[  OK  ] Listening on Journal Socket (/dev/log).
systemd[1]: Listening on Journal Socket.
[  OK  ] Listening on Journal Socket.
systemd[1]: Listening on Network Service Netlink Socket.
[  OK  ] Listening on Network Service Netlink Socket.
systemd[1]: Listening on udev Control Socket.
[  OK  ] Listening on udev Control Socket.
systemd[1]: Listening on udev Kernel Socket.
[  OK  ] Listening on udev Kernel Socket.
systemd[1]: Listening on User Database Manager Socket.
[  OK  ] Listening on User Database Manager Socket.
systemd[1]: Huge Pages File System was skipped because of a failed condition check (ConditionPathExists=/sys/kernel/mm/hugepages).
systemd[1]: Mounting POSIX Message Queue File System...
         Mounting POSIX Message Queue File System...
systemd[1]: Mounting Kernel Debug File System...
         Mounting Kernel Debug File System...
systemd[1]: Mounting Kernel Trace File System...
         Mounting Kernel Trace File System...
systemd[1]: Mounting Temporary Directory /tmp...
         Mounting Temporary Directory /tmp...
systemd[1]: Starting Create List of Static Device Nodes...
         Starting Create List of Static Device Nodes...
systemd[1]: Starting Load Kernel Module configfs...
         Starting Load Kernel Module configfs...
systemd[1]: Starting Load Kernel Module drm...
         Starting Load Kernel Module drm...
systemd[1]: Starting Load Kernel Module fuse...
         Starting Load Kernel Module fuse...
systemd[1]: Starting RPC Bind...
         Starting RPC Bind...
fuse: init (API version 7.32)
systemd[1]: Starting File System Check on Root Device...
         Starting File System Check on Root Device...
systemd[1]: Starting Journal Service...
         Starting Journal Service...
systemd[1]: Load Kernel Modules was skipped because all trigger condition checks failed.
systemd[1]: Starting Generate network units from Kernel command line...
         Starting Generate network …ts from Kernel command line...
systemd[1]: Starting Apply Kernel Variables...
         Starting Apply Kernel Variables...
systemd[1]: Starting Coldplug All udev Devices...
         Starting Coldplug All udev Devices...
systemd[1]: Started RPC Bind.
[  OK  ] Started RPC Bind.
systemd[1]: Mounted POSIX Message Queue File System.
[  OK  ] Mounted POSIX Message Queue File System.
systemd[1]: Mounted Kernel Debug File System.
[  OK  ] Mounted Kernel Debug File System.
systemd[1]: Mounted Kernel Trace File System.
[  OK  ] Mounted Kernel Trace File System.
systemd[1]: Mounted Temporary Directory /tmp.
[  OK  ] Mounted Temporary Directory /tmp.
systemd[1]: Started Journal Service.
[  OK  ] Started Journal Service.
[  OK  ] Finished Create List of Static Device Nodes.
[  OK  ] Finished Load Kernel Module configfs.
[  OK  ] Finished Load Kernel Module drm.
[  OK  ] Finished Load Kernel Module fuse.
[  OK  ] Finished File System Check on Root Device.
[  OK  ] Finished Generate network units from Kernel command line.
[  OK  ] Finished Apply Kernel Variables.
         Mounting FUSE Control File System...
         Mounting Kernel Configuration File System...
         Starting Remount Root and Kernel File Systems...
[  OK  ] Mounted FUSE Control File System.
[  OK  ] Mounted Kernel Configuration File System.
[  OK  ] Finished Remount Root and Kernel File Systems.
         Starting Flush Journal to Persistent Storage...
         Starting Create System Users...
systemd-journald[123]: Received client request to flush runtime journal.
[  OK  ] Finished Flush Journal to Persistent Storage.
[  OK  ] Finished Create System Users.
         Starting Create Static Device Nodes in /dev...
[  OK  ] Finished Coldplug All udev Devices.
         Starting Wait for udev To …plete Device Initialization...
[  OK  ] Finished Create Static Device Nodes in /dev.
[  OK  ] Reached target Preparation for Local File Systems.
         Mounting /var/volatile...
         Starting Rule-based Manage…for Device Events and Files...
[  OK  ] Mounted /var/volatile.
         Starting Load/Save Random Seed...
[  OK  ] Reached target Local File Systems.
         Starting Rebuild Dynamic Linker Cache...
         Starting Create Volatile Files and Directories...
[  OK  ] Finished Load/Save Random Seed.
         Starting Commit a transient machine-id on disk...
[  OK  ] Finished Commit a transient machine-id on disk.
[  OK  ] Started Rule-based Manager for Device Events and Files.
[  OK  ] Finished Create Volatile Files and Directories.
         Starting Rebuild Journal Catalog...
         Starting Network Time Synchronization...
         Starting Record System Boot/Shutdown in UTMP...
[  OK  ] Finished Record System Boot/Shutdown in UTMP.
[  OK  ] Finished Rebuild Journal Catalog.
[  OK  ] Finished Wait for udev To Complete Device Initialization.
[  OK  ] Listening on Load/Save RF …itch Status /dev/rfkill Watch.
[  OK  ] Started Hardware RNG Entropy Gatherer Daemon.
[  OK  ] Started Network Time Synchronization.
[  OK  ] Reached target System Time Set.
[  OK  ] Finished Rebuild Dynamic Linker Cache.
         Starting Update is Completed...
[  OK  ] Finished Update is Completed.
[  OK  ] Reached target System Initialization.
[  OK  ] Started Daily rotation of log files.
[  OK  ] Started Daily Cleanup of Temporary Directories.
[  OK  ] Reached target Timer Units.
[  OK  ] Listening on Avahi mDNS/DNS-SD Stack Activation Socket.
[  OK  ] Listening on D-Bus System Message Bus Socket.
         Starting sshd.socket...
         Starting Console System Startup Logging...
         Starting Reboot and dump vmcore via kexec...
[  OK  ] Listening on sshd.socket.
[  OK  ] Finished Console System Startup Logging.
[  OK  ] Reached target Socket Units.
[  OK  ] Reached target Basic System.
[  OK  ] Started Kernel Logging Service.
[  OK  ] Started System Logging Service.
[  OK  ] Started Periodic Command Scheduler.
[  OK  ] Started D-Bus System Message Bus.
         Starting IPv6 Packet Filtering Framework...
         Starting IPv4 Packet Filtering Framework...
         Starting Telephony service...
         Starting User Login Management...
[  OK  ] Started Xserver startup without a display manager.
         Starting OpenSSH Key Generation...
[  OK  ] Finished Reboot and dump vmcore via kexec.
[  OK  ] Finished IPv6 Packet Filtering Framework.
[  OK  ] Finished IPv4 Packet Filtering Framework.
[  OK  ] Reached target Preparation for Network.
         Starting Connection service...
         Starting Network Configuration...
[  OK  ] Started Telephony service.
[  OK  ] Started Connection service.
         Starting Avahi mDNS/DNS-SD Stack...
[  OK  ] Started Avahi mDNS/DNS-SD Stack.
         Starting WPA supplicant...
         Starting Hostname Service...
[  OK  ] Started WPA supplicant.
[  OK  ] Started Network Configuration.
[  OK  ] Reached target Network.
         Starting Permit User Sessions...
         Starting Target Communication Framework agent...
[ ***  ] (4 of 5) A start job is running for… Login Management (34s / 1min 46s)
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
rpc_check_timeout: 14 callbacks suppressed
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
rpc_check_timeout: 18 callbacks suppressed
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
nfs: server 128.224.178.20 not responding, still trying
rpc_check_timeout: 22 callbacks suppressed
nfs: server 128.224.178.20 not responding, still trying


This seems to be introduced by systemd 250.
We can disable systemd-network-generator.service as a workaround:

Comment the following lines in /lib/systemd/system/systemd-networkd.service:
systemd-networkd.service.in

# The output from this generator is used by udevd and networkd. Enable it by
# default when enabling systemd-networkd.service.
Also=systemd-network-generator.service

Comment 1 Andrei Gherzan 2022-02-03 16:10:47 UTC

Should be fixed by https://github.com/systemd/systemd/pull/22383 but should be verified.

Comment 2 Pavel Zhukov 2022-02-05 20:13:49 UTC

Patch submitted:
https://lists.openembedded.org/g/openembedded-core/message/161390

Comment 3 Pavel Zhukov 2022-02-10 15:51:11 UTC

Should be fixed in OE core master. Feel free to reopen if the issue still exists

Comment 4 Randy MacLeod 2022-02-10 16:40:14 UTC

Thanks Pavel.

We try to add a commit ID, when closing a bug. 
In this case, that's:
https://git.openembedded.org/openembedded-core/commit/?id=afb6b1625a43d64eba090f0f4c5e231d87df7833

Comment 5 Pavel Zhukov 2022-02-10 16:43:01 UTC

(In reply to comment #4)
> Thanks Pavel.
> 
> We try to add a commit ID, when closing a bug. 
> In this case, that's:
> https://git.openembedded.org/openembedded-core/commit/
> ?id=afb6b1625a43d64eba090f0f4c5e231d87df7833

Sorry, didn't know about that. Noted.

Comment 6 Yi Zhao 2022-03-09 03:36:01 UTC

Verified with 3.5 M3.
Git rev: afbdba9b12bc12638d82813d1cd31ec479971c4b