You are not logged in.

#1 2020-07-14 12:02:22

exoyds
Member
Registered: 2020-07-14
Posts: 3

[SOLVED] Systemd-networkd cant bring up wifi interface

Hi!

I have very recently installed arch and it all went well. I can bring up my wifi interface with netctl, but since i wanted to use wireguard I tried to make systemd do all of my networking.

I followed this guide:
https://wiki.archlinux.org/index.php/Sy … ss_adapter
and
https://wiki.archlinux.org/index.php/Wp … figuration

I also had to use -Dwext for wpa_supplicant as the adapter doesnt seem to be able to use nl80211.

Unfortunately it seems that systemd does not like something about the device itself, as  it fails to run the dhcp client. I can run dhcpcd manually and I do get the IP anyway, but would much prefer to not have to login everytime its rebooted.

Is this an issue with my config? I have included all my conf files and logs below:

lsusb for the adapter:

Bus 001 Device 007: ID 0bda:8179 Realtek Semiconductor Corp. RTL8188EUS 802.11n Wireless Network Adapter

enabled systemd services:

autovt@.service                            enabled         disabled     
dbus-org.freedesktop.network1.service      enabled         disabled     
dbus-org.freedesktop.resolve1.service      enabled         disabled     
dbus-org.freedesktop.timesync1.service     enabled         disabled     
getty@.service                             enabled         enabled      
haveged.service                            enabled         disabled     
sshd.service                               enabled         disabled     
systemd-homed.service                      disabled        enabled      
systemd-networkd-wait-online.service       enabled         disabled     
systemd-networkd.service                   enabled         enabled      
systemd-pstore.service                     disabled        enabled      
systemd-remount-fs.service                 enabled-runtime disabled     
systemd-repart.service                     disabled        enabled      
systemd-resolved.service                   enabled         enabled      
systemd-timesyncd.service                  enabled         enabled      
systemd-networkd.socket                    enabled         disabled     
systemd-userdbd.socket                     disabled        enabled      
machines.target                            disabled        enabled      
reboot.target                              disabled        enabled      
remote-cryptsetup.target                   disabled        enabled      
remote-fs.target                           enabled         enabled      

wpa supplicant conf:

ctrl_interface=/var/run/wpa_supplicant
network={
   ssid="Network"
  psk="pass"
}

wpa supplicant service

* wpa_supplicant@wlan0.service - WPA supplicant daemon (interface-specific version)
     Loaded: loaded (/usr/lib/systemd/system/wpa_supplicant@.service; enabled; vendor preset: disabled)
     Active: active (running) since Tue 2020-07-14 10:55:43 UTC; 56min ago
   Main PID: 217 (wpa_supplicant)
      Tasks: 1 (limit: 848)
     CGroup: /system.slice/system-wpa_supplicant.slice/wpa_supplicant@wlan0.service
             `-217 /usr/bin/wpa_supplicant -Dwext -c/etc/wpa_supplicant/wpa_supplicant-wlan0.conf -iwlan0

Jul 14 10:55:43 host1 wpa_supplicant[217]: rfkill: Cannot get wiphy information
Jul 14 10:55:45 host1 wpa_supplicant[217]: ioctl[SIOCSIWAP]: Operation not permitted
Jul 14 10:55:45 host1 wpa_supplicant[217]: ioctl[SIOCSIWENCODEEXT]: Invalid argument
Jul 14 10:55:45 host1 wpa_supplicant[217]: ioctl[SIOCSIWENCODEEXT]: Invalid argument
Jul 14 10:55:47 host1 wpa_supplicant[217]: wlan0: Trying to associate with 80:20:X (SSID='Network' freq=2447 MHz)
Jul 14 10:55:47 host1 wpa_supplicant[217]: Failed to add supported operating classes IE
Jul 14 10:55:47 host1 wpa_supplicant[217]: wlan0: Association request to the driver failed
Jul 14 10:55:47 host1 wpa_supplicant[217]: wlan0: Associated with 80:20:X
Jul 14 10:55:47 host1 wpa_supplicant[217]: wlan0: WPA: Key negotiation completed with 80:20:X [PTK=CCMP GTK=TKIP]
Jul 14 10:55:47 host1 wpa_supplicant[217]: wlan0: CTRL-EVENT-CONNECTED - Connection to 80:20:X completed [id=0 id_str=]

/etc/systemd/network/wlan0.network

[Match]
Name=wlan0

[Network]
DHCP=ipv4

systemd-networkd status

* systemd-networkd.service - Network Service
     Loaded: loaded (/usr/lib/systemd/system/systemd-networkd.service; enabled; vendor preset: enabled)
     Active: active (running) since Tue 2020-07-14 11:20:47 UTC; 33min ago
TriggeredBy: * systemd-networkd.socket
       Docs: man:systemd-networkd.service(8)
   Main PID: 623 (systemd-network)
     Status: "Processing requests..."
      Tasks: 1 (limit: 848)
     CGroup: /system.slice/systemd-networkd.service
             `-623 /usr/lib/systemd/systemd-networkd

Jul 14 11:20:46 host1 systemd[1]: Starting Network Service...
Jul 14 11:20:47 host1 systemd-networkd[623]: wlan0: Gained IPv6LL
Jul 14 11:20:47 host1 systemd-networkd[623]: Enumeration completed
Jul 14 11:20:47 host1 systemd[1]: Started Network Service.
Jul 14 11:20:47 host1 systemd-networkd[623]: wlan0: Failed

networkctl-status after running dhcpcd manually:

*   State: routable                                     
  Address: 192.168.1.37 on wlan0                        
           fe80::7e8b:caff:fe13:9db1 on wlan0           
  Gateway: 192.168.1.1 (Sagemcom Broadband SAS) on wlan0

Jul 14 11:16:49 host1 systemd[1]: Started Network Service.
Jul 14 11:16:49 host1 systemd-networkd[539]: wlan0: Failed
Jul 14 11:20:46 host1 systemd[1]: Stopping Network Service...
Jul 14 11:20:46 host1 systemd[1]: systemd-networkd.service: Succeeded.
Jul 14 11:20:46 host1 systemd[1]: Stopped Network Service.
Jul 14 11:20:46 host1 systemd[1]: Starting Network Service...
Jul 14 11:20:47 host1 systemd-networkd[623]: wlan0: Gained IPv6LL
Jul 14 11:20:47 host1 systemd-networkd[623]: Enumeration completed
Jul 14 11:20:47 host1 systemd[1]: Started Network Service.
Jul 14 11:20:47 host1 systemd-networkd[623]: wlan0: Failed

Last edited by exoyds (2020-07-15 08:40:47)

Offline

#2 2020-07-14 13:35:52

seth
Member
From: Won't reply 2 private help req
Registered: 2012-09-03
Posts: 77,764

Re: [SOLVED] Systemd-networkd cant bring up wifi interface

Jul 14 11:20:47 host1 systemd-networkd[623]: wlan0: Failed

systemd-networkd still fails, what runs your network is dhcpcd (which is not supposed to be invoked by systemd-networkd)

If you want to use systemd-network, please post a complete system journal.

Online

#3 2020-07-14 15:50:05

exoyds
Member
Registered: 2020-07-14
Posts: 3

Re: [SOLVED] Systemd-networkd cant bring up wifi interface

thanks for helping me out seth!

Yeah systemd-networkd fails and that's why I start up dhcpcd to get an ip to be able to connect to the machine. Also because networkd fails i have to stop resolved to get DNS working.

Anyways, here's the full journal from boot:

-- Logs begin at Sat 2019-06-22 13:41:00 UTC, end at Tue 2020-07-14 15:34:16 UTC. --
Jun 24 12:44:47 host1 kernel: Booting Linux on physical CPU 0x0
Jun 24 12:44:47 host1 kernel: Linux version 5.4.50-1-ARCH (builduser@leming) (gcc version 9.3.0 (GCC)) #1 SMP PREEMPT Mon Jul 6 00:33:51 UTC 2020
Jun 24 12:44:47 host1 kernel: CPU: ARMv6-compatible processor [410fb767] revision 7 (ARMv7), cr=00c5387d
Jun 24 12:44:47 host1 kernel: CPU: PIPT / VIPT nonaliasing data cache, VIPT nonaliasing instruction cache
Jun 24 12:44:47 host1 kernel: OF: fdt: Machine model: Raspberry Pi Zero Rev 1.3
Jun 24 12:44:47 host1 kernel: Memory policy: Data cache writeback
Jun 24 12:44:47 host1 kernel: Reserved memory: created CMA memory pool at 0x17800000, size 64 MiB
Jun 24 12:44:47 host1 kernel: OF: reserved mem: initialized node linux,cma, compatible id shared-dma-pool
Jun 24 12:44:47 host1 kernel: On node 0 totalpages: 114688
Jun 24 12:44:47 host1 kernel:   Normal zone: 1008 pages used for memmap
Jun 24 12:44:47 host1 kernel:   Normal zone: 0 pages reserved
Jun 24 12:44:47 host1 kernel:   Normal zone: 114688 pages, LIFO batch:31
Jun 24 12:44:47 host1 kernel: CPU: All CPU(s) started in SVC mode.
Jun 24 12:44:47 host1 kernel: percpu: Embedded 20 pages/cpu s50252 r8192 d23476 u81920
Jun 24 12:44:47 host1 kernel: pcpu-alloc: s50252 r8192 d23476 u81920 alloc=20*4096
Jun 24 12:44:47 host1 kernel: pcpu-alloc: [0] 0 
Jun 24 12:44:47 host1 kernel: Built 1 zonelists, mobility grouping on.  Total pages: 113680
Jun 24 12:44:47 host1 kernel: Kernel command line: coherent_pool=1M snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 bcm2708_fb.fbwidth=1680 bcm2708_fb.fbheight=1050 bcm2708_fb.fbswap=1 smsc95xx.macaddr=B8:27:EB:02:AB:10 vc_mem.mem_base=0x1ec00000 vc_mem.mem_size=0x20000000  root=/dev/mmcblk0p2 rw rootwait console=ttyAMA0,115200 console=tty1 selinux=0 plymouth.enable=0 smsc95xx.turbo_mode=N dwc_otg.lpm_enable=0 kgdboc=ttyAMA0,115200 elevator=noop audit=0
Jun 24 12:44:47 host1 kernel: audit: disabled (until reboot)
Jun 24 12:44:47 host1 kernel: Dentry cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
Jun 24 12:44:47 host1 kernel: Inode-cache hash table entries: 32768 (order: 5, 131072 bytes, linear)
Jun 24 12:44:47 host1 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
Jun 24 12:44:47 host1 kernel: Memory: 361872K/458752K available (12288K kernel code, 867K rwdata, 3436K rodata, 1024K init, 884K bss, 31344K reserved, 65536K cma-reserved, 0K highmem)
Jun 24 12:44:47 host1 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
Jun 24 12:44:47 host1 kernel: rcu: Preemptible hierarchical RCU implementation.
Jun 24 12:44:47 host1 kernel: rcu:         RCU restricting CPUs from NR_CPUS=4 to nr_cpu_ids=1.
Jun 24 12:44:47 host1 kernel:         Tasks RCU enabled.
Jun 24 12:44:47 host1 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 10 jiffies.
Jun 24 12:44:47 host1 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
Jun 24 12:44:47 host1 kernel: NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
Jun 24 12:44:47 host1 kernel: [Firmware Bug]: Bootloader left irq enabled: bank 1 irq 9
Jun 24 12:44:47 host1 kernel: random: get_random_bytes called from start_kernel+0x2e4/0x52c with crng_init=0
Jun 24 12:44:47 host1 kernel: sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
Jun 24 12:44:47 host1 kernel: clocksource: timer: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
Jun 24 12:44:47 host1 kernel: bcm2835: system timer (irq = 27)
Jun 24 12:44:47 host1 kernel: Console: colour dummy device 80x30
Jun 24 12:44:47 host1 kernel: printk: console [tty1] enabled
Jun 24 12:44:47 host1 kernel: Calibrating delay loop... 697.95 BogoMIPS (lpj=3489792)
Jun 24 12:44:47 host1 kernel: pid_max: default: 32768 minimum: 301
Jun 24 12:44:47 host1 kernel: Mount-cache hash table entries: 1024 (order: 0, 4096 bytes, linear)
Jun 24 12:44:47 host1 kernel: Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes, linear)
Jun 24 12:44:47 host1 kernel: Disabling memory control group subsystem
Jun 24 12:44:47 host1 kernel: CPU: Testing write buffer coherency: ok
Jun 24 12:44:47 host1 kernel: missing device node for CPU 0
Jun 24 12:44:47 host1 kernel: CPU0: thread -1, cpu 0, socket -1, mpidr 410fb767
Jun 24 12:44:47 host1 kernel: Setting up static identity map for 0x100000 - 0x100054
Jun 24 12:44:47 host1 kernel: rcu: Hierarchical SRCU implementation.
Jun 24 12:44:47 host1 kernel: smp: Bringing up secondary CPUs ...
Jun 24 12:44:47 host1 kernel: smp: Brought up 1 node, 1 CPU
Jun 24 12:44:47 host1 kernel: SMP: Total of 1 processors activated (697.95 BogoMIPS).
Jun 24 12:44:47 host1 kernel: CPU: All CPU(s) started in SVC mode.
Jun 24 12:44:47 host1 kernel: devtmpfs: initialized
Jun 24 12:44:47 host1 kernel: VFP support v0.3: implementor 41 architecture 1 part 20 variant b rev 5
Jun 24 12:44:47 host1 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Jun 24 12:44:47 host1 kernel: futex hash table entries: 256 (order: 2, 16384 bytes, linear)
Jun 24 12:44:47 host1 kernel: xor: measuring software checksum speed
Jun 24 12:44:47 host1 kernel:    arm4regs  :   973.200 MB/sec
Jun 24 12:44:47 host1 kernel:    8regs     :   492.000 MB/sec
Jun 24 12:44:47 host1 kernel:    32regs    :   616.400 MB/sec
Jun 24 12:44:47 host1 kernel: xor: using function: arm4regs (973.200 MB/sec)
Jun 24 12:44:47 host1 kernel: pinctrl core: initialized pinctrl subsystem
Jun 24 12:44:47 host1 kernel: NET: Registered protocol family 16
Jun 24 12:44:47 host1 kernel: DMA: preallocated 1024 KiB pool for atomic coherent allocations
Jun 24 12:44:47 host1 kernel: hw-breakpoint: found 6 breakpoint and 1 watchpoint registers.
Jun 24 12:44:47 host1 kernel: hw-breakpoint: maximum watchpoint size is 4 bytes.
Jun 24 12:44:47 host1 kernel: Serial: AMBA PL011 UART driver
Jun 24 12:44:47 host1 kernel: bcm2835-mbox 2000b880.mailbox: mailbox enabled
Jun 24 12:44:47 host1 kernel: raspberrypi-firmware soc:firmware: Attached to firmware from 2020-07-02 15:01, variant start
Jun 24 12:44:47 host1 kernel: raspberrypi-firmware soc:firmware: Firmware hash is 36c8be9515deddc9d2b1f469374f00d0a2df13f9
Jun 24 12:44:47 host1 kernel: cryptd: max_cpu_qlen set to 1000
Jun 24 12:44:47 host1 kernel: raid6: int32x8  gen()   117 MB/s
Jun 24 12:44:47 host1 kernel: raid6: int32x8  xor()    78 MB/s
Jun 24 12:44:47 host1 kernel: raid6: int32x4  gen()   108 MB/s
Jun 24 12:44:47 host1 kernel: raid6: int32x4  xor()    76 MB/s
Jun 24 12:44:47 host1 kernel: raid6: int32x2  gen()    77 MB/s
Jun 24 12:44:47 host1 kernel: raid6: int32x2  xor()    57 MB/s
Jun 24 12:44:47 host1 kernel: raid6: int32x1  gen()    46 MB/s
Jun 24 12:44:47 host1 kernel: raid6: int32x1  xor()    38 MB/s
Jun 24 12:44:47 host1 kernel: raid6: using algorithm int32x8 gen() 117 MB/s
Jun 24 12:44:47 host1 kernel: raid6: .... xor() 78 MB/s, rmw enabled
Jun 24 12:44:47 host1 kernel: raid6: using intx1 recovery algorithm
Jun 24 12:44:47 host1 kernel: bcm2835-dma 20007000.dma: DMA legacy API manager, dmachans=0x1
Jun 24 12:44:47 host1 kernel: vgaarb: loaded
Jun 24 12:44:47 host1 kernel: SCSI subsystem initialized
Jun 24 12:44:47 host1 kernel: usbcore: registered new interface driver usbfs
Jun 24 12:44:47 host1 kernel: usbcore: registered new interface driver hub
Jun 24 12:44:47 host1 kernel: usbcore: registered new device driver usb
Jun 24 12:44:47 host1 kernel: clocksource: Switched to clocksource timer
Jun 24 12:44:47 host1 kernel: random: fast init done
Jun 24 12:44:47 host1 kernel: VFS: Disk quotas dquot_6.6.0
Jun 24 12:44:47 host1 kernel: VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Jun 24 12:44:47 host1 kernel: FS-Cache: Loaded
Jun 24 12:44:47 host1 kernel: CacheFiles: Loaded
Jun 24 12:44:47 host1 kernel: thermal_sys: Registered thermal governor 'step_wise'
Jun 24 12:44:47 host1 kernel: NET: Registered protocol family 2
Jun 24 12:44:47 host1 kernel: tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
Jun 24 12:44:47 host1 kernel: TCP established hash table entries: 4096 (order: 2, 16384 bytes, linear)
Jun 24 12:44:47 host1 kernel: TCP bind hash table entries: 4096 (order: 3, 32768 bytes, linear)
Jun 24 12:44:47 host1 kernel: TCP: Hash tables configured (established 4096 bind 4096)
Jun 24 12:44:47 host1 kernel: UDP hash table entries: 256 (order: 1, 8192 bytes, linear)
Jun 24 12:44:47 host1 kernel: UDP-Lite hash table entries: 256 (order: 1, 8192 bytes, linear)
Jun 24 12:44:47 host1 kernel: NET: Registered protocol family 1
Jun 24 12:44:47 host1 kernel: RPC: Registered named UNIX socket transport module.
Jun 24 12:44:47 host1 kernel: RPC: Registered udp transport module.
Jun 24 12:44:47 host1 kernel: RPC: Registered tcp transport module.
Jun 24 12:44:47 host1 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module.
Jun 24 12:44:47 host1 kernel: NET: Registered protocol family 44
Jun 24 12:44:47 host1 kernel: PCI: CLS 0 bytes, default 64
Jun 24 12:44:47 host1 kernel: Trying to unpack rootfs image as initramfs...
Jun 24 12:44:47 host1 kernel: Freeing initrd memory: 7420K
Jun 24 12:44:47 host1 kernel: hw perfevents: no irqs for PMU, sampling events not supported
Jun 24 12:44:47 host1 kernel: hw perfevents: enabled with armv6_1176 PMU driver, 3 counters available
Jun 24 12:44:47 host1 kernel: Initialise system trusted keyrings
Jun 24 12:44:47 host1 kernel: workingset: timestamp_bits=14 max_order=17 bucket_order=3
Jun 24 12:44:47 host1 kernel: FS-Cache: Netfs 'nfs' registered for caching
Jun 24 12:44:47 host1 kernel: NFS: Registering the id_resolver key type
Jun 24 12:44:47 host1 kernel: Key type id_resolver registered
Jun 24 12:44:47 host1 kernel: Key type id_legacy registered
Jun 24 12:44:47 host1 kernel: nfs4filelayout_init: NFSv4 File Layout Driver Registering...
Jun 24 12:44:47 host1 kernel: JFS: nTxBlock = 3397, nTxLock = 27176
Jun 24 12:44:47 host1 kernel: SGI XFS with ACLs, security attributes, realtime, no debug enabled
Jun 24 12:44:47 host1 kernel: jitterentropy: Initialization failed with host not compliant with requirements: 2
Jun 24 12:44:47 host1 kernel: async_tx: api initialized (async)
Jun 24 12:44:47 host1 kernel: Key type asymmetric registered
Jun 24 12:44:47 host1 kernel: Asymmetric key parser 'x509' registered
Jun 24 12:44:47 host1 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Jun 24 12:44:47 host1 kernel: io scheduler mq-deadline registered
Jun 24 12:44:47 host1 kernel: io scheduler kyber registered
Jun 24 12:44:47 host1 kernel: io scheduler bfq registered
Jun 24 12:44:47 host1 kernel: bcm2708_fb soc:fb: FB found 1 display(s)
Jun 24 12:44:47 host1 kernel: Console: switching to colour frame buffer device 210x65
Jun 24 12:44:47 host1 kernel: bcm2708_fb soc:fb: Registered framebuffer for display 0, size 1680x1050
Jun 24 12:44:47 host1 kernel: vc-mem: phys_addr:0x00000000 mem_base=0x1ec00000 mem_size:0x20000000(512 MiB)
Jun 24 12:44:47 host1 kernel: vc-sm: Videocore shared memory driver
Jun 24 12:44:47 host1 kernel: gpiomem-bcm2835 20200000.gpiomem: Initialised: Registers at 0x20200000
Jun 24 12:44:47 host1 kernel: loop: module loaded
Jun 24 12:44:47 host1 kernel: Loading iSCSI transport class v2.0-870.
Jun 24 12:44:47 host1 kernel: libphy: Fixed MDIO Bus: probed
Jun 24 12:44:47 host1 kernel: usbcore: registered new interface driver lan78xx
Jun 24 12:44:47 host1 kernel: usbcore: registered new interface driver ax88179_178a
Jun 24 12:44:47 host1 kernel: usbcore: registered new interface driver smsc95xx
Jun 24 12:44:47 host1 kernel: usbcore: registered new interface driver cdc_ncm
Jun 24 12:44:47 host1 kernel: dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Jun 24 12:44:47 host1 kernel: Core Release: 2.80a
Jun 24 12:44:47 host1 kernel: Setting default values for core params
Jun 24 12:44:47 host1 kernel: Finished setting default values for core params
Jun 24 12:44:47 host1 kernel: Using Buffer DMA mode
Jun 24 12:44:47 host1 kernel: Periodic Transfer Interrupt Enhancement - disabled
Jun 24 12:44:47 host1 kernel: Multiprocessor Interrupt Enhancement - disabled
Jun 24 12:44:47 host1 kernel: OTG VER PARAM: 0, OTG VER FLAG: 0
Jun 24 12:44:47 host1 kernel: Dedicated Tx FIFOs mode
Jun 24 12:44:47 host1 kernel: WARN::dwc_otg_hcd_init:1072: FIQ DMA bounce buffers: virt = 97914000 dma = 0x57914000 len=9024
Jun 24 12:44:47 host1 kernel: FIQ FSM acceleration enabled for :
                               Non-periodic Split Transactions
                               Periodic Split Transactions
                               High-Speed Isochronous Endpoints
                               Interrupt/Control Split Transaction hack enabled
Jun 24 12:44:47 host1 kernel: dwc_otg: Microframe scheduler enabled
Jun 24 12:44:47 host1 kernel: WARN::hcd_init_fiq:457: FIQ on core 0
Jun 24 12:44:47 host1 kernel: WARN::hcd_init_fiq:458: FIQ ASM at 80978adc length 36
Jun 24 12:44:47 host1 kernel: WARN::hcd_init_fiq:496: MPHI regs_base at 9c810000
Jun 24 12:44:47 host1 kernel: dwc_otg 20980000.usb: DWC OTG Controller
Jun 24 12:44:47 host1 kernel: dwc_otg 20980000.usb: new USB bus registered, assigned bus number 1
Jun 24 12:44:47 host1 kernel: dwc_otg 20980000.usb: irq 56, io mem 0x00000000
Jun 24 12:44:47 host1 kernel: Init: Port Power? op_state=1
Jun 24 12:44:47 host1 kernel: Init: Power Port (0)
Jun 24 12:44:47 host1 kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.04
Jun 24 12:44:48 host1 kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jun 24 12:44:48 host1 kernel: usb usb1: Product: DWC OTG Controller
Jun 24 12:44:48 host1 kernel: usb usb1: Manufacturer: Linux 5.4.50-1-ARCH dwc_otg_hcd
Jun 24 12:44:48 host1 kernel: usb usb1: SerialNumber: 20980000.usb
Jun 24 12:44:48 host1 kernel: hub 1-0:1.0: USB hub found
Jun 24 12:44:48 host1 kernel: hub 1-0:1.0: 1 port detected
Jun 24 12:44:48 host1 kernel: dwc_otg: FIQ enabled
Jun 24 12:44:48 host1 kernel: dwc_otg: NAK holdoff enabled
Jun 24 12:44:48 host1 kernel: dwc_otg: FIQ split-transaction FSM enabled
Jun 24 12:44:48 host1 kernel: Module dwc_common_port init
Jun 24 12:44:48 host1 kernel: usbcore: registered new interface driver uas
Jun 24 12:44:48 host1 kernel: usbcore: registered new interface driver usb-storage
Jun 24 12:44:48 host1 kernel: usbcore: registered new interface driver ums-alauda
Jun 24 12:44:48 host1 kernel: usbcore: registered new interface driver ums-cypress
Jun 24 12:44:48 host1 kernel: usbcore: registered new interface driver ums-datafab
Jun 24 12:44:48 host1 kernel: usbcore: registered new interface driver ums_eneub6250
Jun 24 12:44:48 host1 kernel: usbcore: registered new interface driver ums-freecom
Jun 24 12:44:48 host1 kernel: usbcore: registered new interface driver ums-isd200
Jun 24 12:44:48 host1 kernel: usbcore: registered new interface driver ums-jumpshot
Jun 24 12:44:48 host1 kernel: usbcore: registered new interface driver ums-karma
Jun 24 12:44:48 host1 kernel: usbcore: registered new interface driver ums-onetouch
Jun 24 12:44:48 host1 kernel: usbcore: registered new interface driver ums-realtek
Jun 24 12:44:48 host1 kernel: usbcore: registered new interface driver ums-sddr09
Jun 24 12:44:48 host1 kernel: usbcore: registered new interface driver ums-sddr55
Jun 24 12:44:48 host1 kernel: usbcore: registered new interface driver ums-usbat
Jun 24 12:44:48 host1 kernel: mousedev: PS/2 mouse device common for all mice
Jun 24 12:44:48 host1 kernel: bcm2835-wdt bcm2835-wdt: Broadcom BCM2835 watchdog timer
Jun 24 12:44:48 host1 kernel: device-mapper: uevent: version 1.0.3
Jun 24 12:44:48 host1 kernel: device-mapper: ioctl: 4.41.0-ioctl (2019-09-16) initialised: dm-devel@redhat.com
Jun 24 12:44:48 host1 kernel: Indeed it is in host mode hprt0 = 00021501
Jun 24 12:44:48 host1 kernel: device-mapper: multipath round-robin: version 1.2.0 loaded
Jun 24 12:44:48 host1 kernel: device-mapper: multipath queue-length: version 0.2.0 loaded
Jun 24 12:44:48 host1 kernel: device-mapper: multipath service-time: version 0.3.0 loaded
Jun 24 12:44:48 host1 kernel: device-mapper: raid: Loading target version 1.14.0
Jun 24 12:44:48 host1 kernel: bcm2835-cpufreq: min=700000 max=1000000
Jun 24 12:44:48 host1 kernel: sdhci: Secure Digital Host Controller Interface driver
Jun 24 12:44:48 host1 kernel: sdhci: Copyright(c) Pierre Ossman
Jun 24 12:44:48 host1 kernel: sdhost-bcm2835 20202000.mmc: could not get clk, deferring probe
Jun 24 12:44:48 host1 kernel: Error: Driver 'sdhost-bcm2835' is already registered, aborting...
Jun 24 12:44:48 host1 kernel: sdhci-pltfm: SDHCI platform and OF driver helper
Jun 24 12:44:48 host1 kernel: ledtrig-cpu: registered to indicate activity on CPUs
Jun 24 12:44:48 host1 kernel: hidraw: raw HID events driver (C) Jiri Kosina
Jun 24 12:44:48 host1 kernel: usbcore: registered new interface driver usbhid
Jun 24 12:44:48 host1 kernel: usbhid: USB HID core driver
Jun 24 12:44:48 host1 kernel: vchiq: vchiq_init_state: slot_zero = (ptrval)
Jun 24 12:44:48 host1 kernel: [vc_sm_connected_init]: start
Jun 24 12:44:48 host1 kernel: [vc_sm_connected_init]: end - returning 0
Jun 24 12:44:48 host1 kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver
Jun 24 12:44:48 host1 kernel: [vc_sm_connected_init]: start
Jun 24 12:44:48 host1 kernel: [vc_sm_connected_init]: installed successfully
Jun 24 12:44:48 host1 kernel: Initializing XFRM netlink socket
Jun 24 12:44:48 host1 kernel: NET: Registered protocol family 17
Jun 24 12:44:48 host1 kernel: Key type dns_resolver registered
Jun 24 12:44:48 host1 kernel: Registering SWP/SWPB emulation handler
Jun 24 12:44:48 host1 kernel: registered taskstats version 1
Jun 24 12:44:48 host1 kernel: Loading compiled-in X.509 certificates
Jun 24 12:44:48 host1 kernel: Key type ._fscrypt registered
Jun 24 12:44:48 host1 kernel: usb 1-1: new high-speed USB device number 2 using dwc_otg
Jun 24 12:44:48 host1 kernel: Key type .fscrypt registered
Jun 24 12:44:48 host1 kernel: Indeed it is in host mode hprt0 = 00001101
Jun 24 12:44:48 host1 kernel: Btrfs loaded, crc32c=crc32c-generic
Jun 24 12:44:48 host1 kernel: Key type encrypted registered
Jun 24 12:44:48 host1 kernel: uart-pl011 20201000.serial: cts_event_workaround enabled
Jun 24 12:44:48 host1 kernel: 20201000.serial: ttyAMA0 at MMIO 0x20201000 (irq = 81, base_baud = 0) is a PL011 rev2
Jun 24 12:44:48 host1 kernel: usb 1-1: New USB device found, idVendor=05e3, idProduct=0610, bcdDevice=92.24
Jun 24 12:44:48 host1 kernel: usb 1-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Jun 24 12:44:48 host1 kernel: usb 1-1: Product: USB2.0 Hub
Jun 24 12:44:48 host1 kernel: usb 1-1: Manufacturer: GenesysLogic
Jun 24 12:44:48 host1 kernel: hub 1-1:1.0: USB hub found
Jun 24 12:44:48 host1 kernel: hub 1-1:1.0: 4 ports detected
Jun 24 12:44:48 host1 kernel: printk: console [ttyAMA0] enabled
Jun 24 12:44:48 host1 kernel: KGDB: Registered I/O driver kgdboc
Jun 24 12:44:48 host1 kernel: bcm2835-power bcm2835-power: Broadcom BCM2835 power domains driver
Jun 24 12:44:48 host1 kernel: sdhost: log_buf @ (ptrval) (57913000)
Jun 24 12:44:48 host1 kernel: mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
Jun 24 12:44:48 host1 kernel: of_cfs_init
Jun 24 12:44:48 host1 kernel: of_cfs_init: OK
Jun 24 12:44:48 host1 kernel: Freeing unused kernel memory: 1024K
Jun 24 12:44:48 host1 kernel: Run /init as init process
Jun 24 12:44:48 host1 kernel: mmc0: host does not support reading read-only switch, assuming write-enable
Jun 24 12:44:48 host1 kernel: mmc0: new high speed SDHC card at address 0001
Jun 24 12:44:48 host1 kernel: usb 1-1.1: new low-speed USB device number 3 using dwc_otg
Jun 24 12:44:48 host1 kernel: mmcblk0: mmc0:0001 00000 14.6 GiB
Jun 24 12:44:48 host1 kernel:  mmcblk0: p1 p2
Jun 24 12:44:48 host1 kernel: usb 1-1.1: New USB device found, idVendor=046a, idProduct=0021, bcdDevice= 0.20
Jun 24 12:44:48 host1 kernel: usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Jun 24 12:44:48 host1 kernel: input: HID 046a:0021 as /devices/platform/soc/20980000.usb/usb1/1-1/1-1.1/1-1.1:1.0/0003:046A:0021.0001/input/input0
Jun 24 12:44:48 host1 kernel: hid-generic 0003:046A:0021.0001: input,hidraw0: USB HID v1.11 Keyboard [HID 046a:0021] on usb-20980000.usb-1.1/input0
Jun 24 12:44:48 host1 kernel: input: HID 046a:0021 Consumer Control as /devices/platform/soc/20980000.usb/usb1/1-1/1-1.1/1-1.1:1.1/0003:046A:0021.0002/input/input1
Jun 24 12:44:48 host1 kernel: input: HID 046a:0021 System Control as /devices/platform/soc/20980000.usb/usb1/1-1/1-1.1/1-1.1:1.1/0003:046A:0021.0002/input/input2
Jun 24 12:44:48 host1 kernel: hid-generic 0003:046A:0021.0002: input,hidraw1: USB HID v1.11 Device [HID 046a:0021] on usb-20980000.usb-1.1/input1
Jun 24 12:44:48 host1 kernel: usb 1-1.4: new high-speed USB device number 4 using dwc_otg
Jun 24 12:44:48 host1 kernel: usb 1-1.4: New USB device found, idVendor=0bda, idProduct=8179, bcdDevice= 0.00
Jun 24 12:44:48 host1 kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Jun 24 12:44:48 host1 kernel: usb 1-1.4: Product: 802.11n NIC
Jun 24 12:44:48 host1 kernel: usb 1-1.4: Manufacturer: Realtek
Jun 24 12:44:48 host1 kernel: usb 1-1.4: SerialNumber: 00E04C0001
Jun 24 12:44:48 host1 kernel: EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Jun 24 12:44:48 host1 systemd[1]: System time before build time, advancing clock.
Jun 24 12:44:48 host1 kernel: NET: Registered protocol family 10
Jun 24 12:44:48 host1 kernel: Segment Routing with IPv6
Jun 24 12:44:48 host1 systemd[1]: systemd 245.6-8-arch running in system mode. (+PAM +AUDIT -SELINUX -IMA -APPARMOR +SMACK -SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=hybrid)
Jun 24 12:44:48 host1 systemd[1]: Detected architecture arm.
Jun 24 12:44:48 host1 systemd[1]: Set hostname to <host1>.
Jun 24 12:44:48 host1 kernel: uart-pl011 20201000.serial: no DMA platform data
Jun 24 12:44:48 host1 kernel: random: systemd: uninitialized urandom read (16 bytes read)
Jun 24 12:44:48 host1 systemd[1]: Created slice system-getty.slice.
Jun 24 12:44:48 host1 kernel: random: systemd: uninitialized urandom read (16 bytes read)
Jun 24 12:44:48 host1 systemd[1]: Created slice system-modprobe.slice.
Jun 24 12:44:48 host1 kernel: random: systemd: uninitialized urandom read (16 bytes read)
Jun 24 12:44:48 host1 systemd[1]: Created slice system-serial\x2dgetty.slice.
Jun 24 12:44:48 host1 systemd[1]: Created slice system-wpa_supplicant.slice.
Jun 24 12:44:48 host1 systemd[1]: Created slice User and Session Slice.
Jun 24 12:44:48 host1 systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
Jun 24 12:44:48 host1 systemd[1]: Started Forward Password Requests to Wall Directory Watch.
Jun 24 12:44:48 host1 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
Jun 24 12:44:48 host1 systemd[1]: Reached target Local Encrypted Volumes.
Jun 24 12:44:48 host1 systemd[1]: Reached target Paths.
Jun 24 12:44:48 host1 systemd[1]: Reached target Remote File Systems.
Jun 24 12:44:48 host1 systemd[1]: Reached target Slices.
Jun 24 12:44:48 host1 systemd[1]: Reached target Swap.
Jun 24 12:44:48 host1 systemd[1]: Listening on Device-mapper event daemon FIFOs.
Jun 24 12:44:48 host1 systemd[1]: Listening on Process Core Dump Socket.
Jun 24 12:44:48 host1 systemd[1]: Listening on initctl Compatibility Named Pipe.
Jun 24 12:44:48 host1 systemd[1]: Condition check resulted in Journal Audit Socket being skipped.
Jun 24 12:44:48 host1 systemd[1]: Listening on Journal Socket (/dev/log).
Jun 24 12:44:48 host1 systemd[1]: Listening on Journal Socket.
Jun 24 12:44:48 host1 systemd[1]: Listening on Network Service Netlink Socket.
Jun 24 12:44:48 host1 systemd[1]: Listening on udev Control Socket.
Jun 24 12:44:48 host1 systemd[1]: Listening on udev Kernel Socket.
Jun 24 12:44:48 host1 systemd[1]: Condition check resulted in Huge Pages File System being skipped.
Jun 24 12:44:48 host1 systemd[1]: Mounting POSIX Message Queue File System...
Jun 24 12:44:48 host1 systemd[1]: Mounting Kernel Debug File System...
Jun 24 12:44:48 host1 systemd[1]: Mounting Kernel Trace File System...
Jun 24 12:44:48 host1 systemd[1]: Mounting Temporary Directory (/tmp)...
Jun 24 12:44:48 host1 systemd[1]: Starting Create list of static device nodes for the current kernel...
Jun 24 12:44:48 host1 systemd[1]: Starting Load Kernel Module drm...
Jun 24 12:44:48 host1 systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped.
Jun 24 12:44:48 host1 systemd[1]: Starting Load Kernel Modules...
Jun 24 12:44:48 host1 systemd[1]: Starting Remount Root and Kernel File Systems...
Jun 24 12:44:48 host1 systemd[1]: Starting udev Coldplug all Devices...
Jun 24 12:44:48 host1 systemd[1]: Mounted POSIX Message Queue File System.
Jun 24 12:44:48 host1 kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned.
Jun 24 12:44:48 host1 systemd[1]: Mounted Kernel Debug File System.
Jun 24 12:44:48 host1 systemd[1]: Mounted Kernel Trace File System.
Jun 24 12:44:48 host1 systemd[1]: Mounted Temporary Directory (/tmp).
Jun 24 12:44:48 host1 systemd[1]: Finished Create list of static device nodes for the current kernel.
Jun 24 12:44:48 host1 systemd[1]: modprobe@drm.service: Succeeded.
Jun 24 12:44:48 host1 systemd[1]: Finished Load Kernel Module drm.
Jun 24 12:44:48 host1 systemd[1]: Finished Load Kernel Modules.
Jun 24 12:44:48 host1 systemd[1]: Finished Remount Root and Kernel File Systems.
Jun 24 12:44:48 host1 systemd[1]: Condition check resulted in FUSE Control File System being skipped.
Jun 24 12:44:48 host1 systemd[1]: Mounting Kernel Configuration File System...
Jun 24 12:44:48 host1 systemd[1]: Condition check resulted in First Boot Wizard being skipped.
Jun 24 12:44:48 host1 systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped.
Jun 24 12:44:48 host1 systemd[1]: Starting Load/Save Random Seed...
Jun 24 12:44:48 host1 systemd[1]: Starting Apply Kernel Variables...
Jun 24 12:44:48 host1 systemd[1]: Condition check resulted in Create System Users being skipped.
Jun 24 12:44:48 host1 systemd[1]: Starting Create Static Device Nodes in /dev...
Jun 24 12:44:48 host1 systemd[1]: Mounted Kernel Configuration File System.
Jun 24 12:44:48 host1 systemd[1]: Finished Apply Kernel Variables.
Jun 24 12:44:48 host1 systemd[1]: Finished Create Static Device Nodes in /dev.
Jun 24 12:44:48 host1 systemd[1]: Reached target Local File Systems (Pre).
Jun 24 12:44:48 host1 systemd[1]: Condition check resulted in Virtual Machine and Container Storage (Compatibility) being skipped.
Jun 24 12:44:48 host1 systemd[1]: Started Entropy Daemon based on the HAVEGE algorithm.
Jun 24 12:44:48 host1 systemd[1]: Starting Journal Service...
Jun 24 12:44:48 host1 systemd[1]: Starting udev Kernel Device Manager...
Jun 24 12:44:48 host1 systemd[1]: Finished udev Coldplug all Devices.
Jun 24 12:44:48 host1 systemd-journald[174]: Journal started
Jun 24 12:44:48 host1 systemd-journald[174]: Runtime Journal (/run/log/journal/372f250ad26941e49c70474649e18705) is 2.6M, max 21.2M, 18.6M free.
Jun 24 12:44:48 host1 systemd-modules-load[163]: Inserted module 'snd_bcm2835'
Jun 24 12:44:48 host1 systemd-random-seed[168]: Kernel entropy pool is not initialized yet, waiting until it is.
Jun 24 12:44:48 host1 systemd[1]: Started Journal Service.
Jun 24 12:44:48 host1 systemd-sysctl[169]: Not setting net/ipv4/conf/all/rp_filter (explicit setting exists).
Jun 24 12:44:48 host1 systemd-sysctl[169]: Not setting net/ipv4/conf/default/rp_filter (explicit setting exists).
Jun 24 12:44:48 host1 systemd-sysctl[169]: Not setting net/ipv4/conf/all/accept_source_route (explicit setting exists).
Jun 24 12:44:48 host1 systemd-sysctl[169]: Not setting net/ipv4/conf/default/accept_source_route (explicit setting exists).
Jun 24 12:44:48 host1 systemd-sysctl[169]: Not setting net/ipv4/conf/all/promote_secondaries (explicit setting exists).
Jun 24 12:44:48 host1 systemd-sysctl[169]: Not setting net/ipv4/conf/default/promote_secondaries (explicit setting exists).
Jun 24 12:44:48 host1 systemd[1]: Starting Flush Journal to Persistent Storage...
Jun 24 12:44:48 host1 systemd[1]: Started udev Kernel Device Manager.
Jun 24 12:44:48 host1 haveged[173]: haveged: command socket is listening at fd 3
Jun 24 12:44:48 host1 systemd[1]: Starting Network Service...
Jun 24 12:44:48 host1 systemd-journald[174]: Time spent on flushing to /var/log/journal/372f250ad26941e49c70474649e18705 is 413.732ms for 346 entries.
Jun 24 12:44:48 host1 systemd-journald[174]: System Journal (/var/log/journal/372f250ad26941e49c70474649e18705) is 296.0M, max 1.4G, 1.1G free.
Jun 24 12:44:50 host1 systemd[1]: Finished Flush Journal to Persistent Storage.
Jun 24 12:44:52 host1 systemd-networkd[181]: Enumeration completed
Jun 24 12:44:52 host1 systemd[1]: Started Network Service.
Jun 24 12:44:54 host1 kernel: mc: Linux media interface: v0.10
Jun 24 12:44:54 host1 kernel: bcm2835-rng 20104000.rng: hwrng registered
Jun 24 12:44:54 host1 systemd[1]: Found device /dev/ttyAMA0.
Jun 24 12:44:55 host1 kernel: videodev: Linux video capture interface: v2.00
Jun 24 12:44:55 host1 kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Jun 24 12:44:55 host1 kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Jun 24 12:44:55 host1 kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned.
Jun 24 12:44:56 host1 kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned.
Jun 24 12:44:56 host1 kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned.
Jun 24 12:44:56 host1 kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned.
Jun 24 12:44:56 host1 kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13
Jun 24 12:44:56 host1 systemd[1]: Found device /dev/mmcblk0p1.
Jun 24 12:44:56 host1 kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10
Jun 24 12:44:56 host1 systemd[1]: Mounting /boot...
Jun 24 12:44:56 host1 kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14
Jun 24 12:44:56 host1 kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode
Jun 24 12:44:57 host1 kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11
Jun 24 12:44:57 host1 kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode
Jun 24 12:44:57 host1 kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12
Jun 24 12:44:57 host1 kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp
Jun 24 12:44:57 host1 kernel: FAT-fs (mmcblk0p1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Jun 24 12:44:57 host1 kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15
Jun 24 12:44:57 host1 systemd[1]: Mounted /boot.
Jun 24 12:44:57 host1 systemd[1]: Reached target Local File Systems.
Jun 24 12:44:57 host1 systemd[1]: Condition check resulted in Rebuild Dynamic Linker Cache being skipped.
Jun 24 12:44:57 host1 systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped.
Jun 24 12:44:57 host1 systemd[1]: Starting Create Volatile Files and Directories...
Jun 24 12:44:58 host1 systemd[1]: Finished Create Volatile Files and Directories.
Jun 24 12:44:58 host1 systemd[1]: Condition check resulted in Rebuild Journal Catalog being skipped.
Jun 24 12:44:58 host1 kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16
Jun 24 12:44:58 host1 kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller
Jun 24 12:44:58 host1 systemd[1]: Starting Network Name Resolution...
Jun 24 12:44:58 host1 systemd[1]: Starting Network Time Synchronization...
Jun 24 12:44:58 host1 systemd[1]: Condition check resulted in Update is Completed being skipped.
Jun 24 12:44:58 host1 systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Jun 24 12:44:59 host1 kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
Jun 24 12:44:59 host1 kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller
Jun 24 12:44:59 host1 systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Jun 24 12:44:59 host1 systemd-udevd[186]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jun 24 12:44:59 host1 systemd[1]: Finished Update UTMP about System Boot/Shutdown.
Jun 24 12:44:59 host1 kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Jun 24 12:44:59 host1 kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller
Jun 24 12:45:00 host1 kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller
Jun 24 12:45:00 host1 kernel: lib80211: common routines for IEEE802.11 drivers
Jun 24 12:45:00 host1 kernel: lib80211_crypt: registered algorithm 'NULL'
Jun 24 12:45:00 host1 kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp
Jun 24 12:45:02 host1 kernel: r8188eu: module is from the staging directory, the quality is unknown, you have been warned.
Jun 24 12:45:02 host1 kernel: Chip Version Info: CHIP_8188E_Normal_Chip_TSMC_D_CUT_1T1R_RomVer(0)
Jun 24 12:45:02 host1 kernel: random: crng init done
Jun 24 12:45:02 host1 kernel: random: 7 urandom warning(s) missed due to ratelimiting
Jun 24 12:45:02 host1 systemd[1]: Finished Load/Save Random Seed.
Jun 24 12:45:02 host1 systemd[1]: Condition check resulted in Store a System Token in an EFI Variable being skipped.
Jun 24 12:45:04 host1 systemd-resolved[198]: Positive Trust Anchors:
Jun 24 12:45:04 host1 systemd-resolved[198]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Jun 24 12:45:04 host1 systemd-resolved[198]: Negative trust anchors: 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test
Jun 24 12:45:04 host1 systemd-timesyncd[199]: System clock time unset or jumped backwards, restoring from recorded timestamp: Tue 2020-07-14 15:21:08 UTC
Jul 14 15:21:08 host1 systemd[1]: Started Network Time Synchronization.
Jul 14 15:21:08 host1 systemd[1]: Reached target System Initialization.
Jul 14 15:21:08 host1 systemd[1]: Started Daily Cleanup of Temporary Directories.
Jul 14 15:21:08 host1 kernel: usbcore: registered new interface driver r8188eu
Jul 14 15:21:08 host1 systemd[1]: Reached target System Time Set.
Jul 14 15:21:08 host1 systemd[1]: Reached target System Time Synchronized.
Jul 14 15:21:08 host1 systemd[1]: Started Daily verification of password and group files.
Jul 14 15:21:08 host1 systemd[1]: Reached target Timers.
Jul 14 15:21:09 host1 systemd[1]: Listening on D-Bus System Message Bus Socket.
Jul 14 15:21:09 host1 systemd[1]: Reached target Sockets.
Jul 14 15:21:09 host1 systemd[1]: Reached target Basic System.
Jul 14 15:21:09 host1 systemd[1]: Started D-Bus System Message Bus.
Jul 14 15:21:09 host1 systemd[1]: Condition check resulted in SSH Key Generation being skipped.
Jul 14 15:21:09 host1 systemd[1]: Starting Login Service...
Jul 14 15:21:12 host1 systemd-udevd[186]: Using default interface naming scheme 'v245'.
Jul 14 15:21:12 host1 systemd-resolved[198]: Using system hostname 'host1'.
Jul 14 15:21:12 host1 systemd-udevd[184]: cfg80211: Process '/usr/bin/set-wireless-regdom' failed with exit code 1.
Jul 14 15:21:12 host1 systemd[1]: Started Network Name Resolution.
Jul 14 15:21:12 host1 systemd[1]: Reached target Host and Network Name Lookups.
Jul 14 15:21:12 host1 systemd-udevd[186]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable.
Jul 14 15:21:13 host1 systemd-logind[216]: Watching system buttons on /dev/input/event0 (HID 046a:0021)
Jul 14 15:21:13 host1 systemd-logind[216]: Watching system buttons on /dev/input/event1 (HID 046a:0021 Consumer Control)
Jul 14 15:21:13 host1 systemd-logind[216]: Watching system buttons on /dev/input/event2 (HID 046a:0021 System Control)
Jul 14 15:21:13 host1 systemd-logind[216]: New seat seat0.
Jul 14 15:21:13 host1 systemd[1]: Started Login Service.
Jul 14 15:21:13 host1 systemd-networkd[181]: wlan0: Failed
Jul 14 15:21:13 host1 systemd[1]: Found device RTL8188EUS 802.11n Wireless Network Adapter.
Jul 14 15:21:13 host1 systemd[1]: Started WPA supplicant daemon (interface-specific version).
Jul 14 15:21:14 host1 systemd[1]: Reached target Network.
Jul 14 15:21:14 host1 systemd[1]: Started OpenSSH Daemon.
Jul 14 15:21:14 host1 wpa_supplicant[221]: Successfully initialized wpa_supplicant
Jul 14 15:21:14 host1 systemd[1]: Starting Permit User Sessions...
Jul 14 15:21:14 host1 wpa_supplicant[221]: rfkill: Cannot get wiphy information
Jul 14 15:21:14 host1 systemd[1]: Finished Permit User Sessions.
Jul 14 15:21:14 host1 systemd[1]: Started Getty on tty1.
Jul 14 15:21:14 host1 systemd[1]: Started Serial Getty on ttyAMA0.
Jul 14 15:21:14 host1 systemd[1]: Reached target Login Prompts.
Jul 14 15:21:14 host1 systemd[1]: Reached target Multi-User System.
Jul 14 15:21:15 host1 systemd[1]: Reached target Graphical Interface.
Jul 14 15:21:15 host1 systemd[1]: Startup finished in 12.581s (kernel) + 32.210s (userspace) = 44.791s.
Jul 14 15:21:16 host1 kernel: MAC Address = 7c:8b:ca:X
Jul 14 15:21:16 host1 systemd-networkd[181]: wlan0: Link UP
Jul 14 15:21:16 host1 wpa_supplicant[221]: ioctl[SIOCSIWAP]: Operation not permitted
Jul 14 15:21:16 host1 wpa_supplicant[221]: ioctl[SIOCSIWENCODEEXT]: Invalid argument
Jul 14 15:21:16 host1 wpa_supplicant[221]: ioctl[SIOCSIWENCODEEXT]: Invalid argument
Jul 14 15:21:16 host1 sshd[222]: Server listening on 0.0.0.0 port 22.
Jul 14 15:21:16 host1 sshd[222]: Server listening on :: port 22.
Jul 14 15:21:17 host1 wpa_supplicant[221]: wlan0: Trying to associate with 80:20:da:X (SSID='Network' freq=2447 MHz)
Jul 14 15:21:17 host1 wpa_supplicant[221]: Failed to add supported operating classes IE
Jul 14 15:21:17 host1 wpa_supplicant[221]: wlan0: Association request to the driver failed
Jul 14 15:21:17 host1 kernel: R8188EU: assoc success
Jul 14 15:21:17 host1 wpa_supplicant[221]: wlan0: Associated with 80:20:da:6e:72:6f
Jul 14 15:21:17 host1 wpa_supplicant[221]: wlan0: WPA: Key negotiation completed with 80:20:da:X [PTK=CCMP GTK=TKIP]
Jul 14 15:21:17 host1 wpa_supplicant[221]: wlan0: CTRL-EVENT-CONNECTED - Connection to 80:20:da:X completed [id=0 id_str=]
Jul 14 15:21:17 host1 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Jul 14 15:21:17 host1 systemd-networkd[181]: wlan0: Gained carrier
Jul 14 15:21:17 host1 systemd-networkd[181]: Could not process link message, ignoring: No such device
Jul 14 15:21:29 host1 haveged[173]: haveged: ver: 1.9.13; arch: generic; vend: ; build: (gcc 9.3.0 CTV); collect: 128K
Jul 14 15:21:29 host1 haveged[173]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14748/63356
Jul 14 15:21:29 host1 haveged[173]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B):  last entropy estimate 7.99986
Jul 14 15:21:29 host1 haveged[173]: haveged: fills: 0, generated: 0
Jul 14 15:24:05 host1 login[224]: pam_unix(login:auth): authentication failure; logname=LOGIN uid=0 euid=0 tty=tty1 ruser= rhost=  user=user
Jul 14 15:24:06 host1 login[224]: FAILED LOGIN 1 FROM tty1 FOR user, Authentication failure
Jul 14 15:24:12 host1 login[224]: pam_unix(login:session): session opened for user user by LOGIN(uid=0)
Jul 14 15:24:12 host1 systemd[1]: Created slice User Slice of UID 1001.
Jul 14 15:24:12 host1 systemd[1]: Starting User Runtime Directory /run/user/1001...
Jul 14 15:24:12 host1 systemd-logind[216]: New session 1 of user user.
Jul 14 15:24:12 host1 systemd[1]: Finished User Runtime Directory /run/user/1001.
Jul 14 15:24:12 host1 systemd[1]: Starting User Manager for UID 1001...
Jul 14 15:24:12 host1 systemd[236]: pam_warn(systemd-user:setcred): function=[pam_sm_setcred] flags=0x8002 service=[systemd-user] terminal=[] user=[user] ruser=[<unknown>] rhost=[<unknown>]
Jul 14 15:24:12 host1 systemd[236]: pam_unix(systemd-user:session): session opened for user user by (uid=0)
Jul 14 15:24:13 host1 systemd[236]: Reached target Paths.
Jul 14 15:24:13 host1 systemd[236]: Reached target Timers.
Jul 14 15:24:13 host1 systemd[236]: Starting D-Bus User Message Bus Socket.
Jul 14 15:24:13 host1 systemd[236]: Listening on GnuPG network certificate management daemon.
Jul 14 15:24:13 host1 systemd[236]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
Jul 14 15:24:13 host1 systemd[236]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
Jul 14 15:24:13 host1 systemd[236]: Listening on GnuPG cryptographic agent (ssh-agent emulation).
Jul 14 15:24:13 host1 systemd[236]: Listening on GnuPG cryptographic agent and passphrase cache.
Jul 14 15:24:13 host1 systemd[236]: Listening on p11-kit server.
Jul 14 15:24:13 host1 systemd[236]: Listening on D-Bus User Message Bus Socket.
Jul 14 15:24:13 host1 systemd[236]: Reached target Sockets.
Jul 14 15:24:13 host1 systemd[236]: Reached target Basic System.
Jul 14 15:24:13 host1 systemd[1]: Started User Manager for UID 1001.
Jul 14 15:24:13 host1 systemd[236]: Reached target Main User Target.
Jul 14 15:24:13 host1 systemd[236]: Startup finished in 866ms.
Jul 14 15:24:13 host1 systemd[1]: Started Session 1 of user user.
Jul 14 15:24:14 host1 login[224]: LOGIN ON tty1 BY user
Jul 14 15:24:23 host1 sudo[251]: user : TTY=tty1 ; PWD=/home/user ; USER=root ; COMMAND=/usr/bin/dhcpcd
Jul 14 15:24:23 host1 sudo[251]: pam_unix(sudo:session): session opened for user root by user(uid=0)
Jul 14 15:24:23 host1 dhcpcd[256]: dhcpcd-9.1.4 starting
Jul 14 15:24:23 host1 dhcpcd[259]: dev: loaded udev
Jul 14 15:24:23 host1 dhcpcd[258]: DUID 00:01:00:01:26:70:10:a4:7c:8b:ca:13:9d:b1
Jul 14 15:24:23 host1 kernel: 8021q: 802.1Q VLAN Support v1.8
Jul 14 15:24:23 host1 dhcpcd[258]: wlan0: IAID ca:13:9d:b1
Jul 14 15:24:23 host1 dhcpcd[258]: wlan0: rebinding lease of 192.168.1.37
Jul 14 15:24:23 host1 dhcpcd[258]: wlan0: soliciting an IPv6 router
Jul 14 15:24:23 host1 dhcpcd[258]: wlan0: probing address 192.168.1.37/24
Jul 14 15:24:28 host1 dhcpcd[258]: wlan0: leased 192.168.1.37 for 86400 seconds
Jul 14 15:24:28 host1 dhcpcd[258]: wlan0: adding route to 192.168.1.0/24
Jul 14 15:24:28 host1 dhcpcd[258]: wlan0: adding default route via 192.168.1.1

Offline

#4 2020-07-14 18:27:22

seth
Member
From: Won't reply 2 private help req
Registered: 2012-09-03
Posts: 77,764

Re: [SOLVED] Systemd-networkd cant bring up wifi interface

Jun 24 12:45:02 host1 kernel: r8188eu: module is from the staging directory, the quality is unknown, you have been warned.
…
Jul 14 15:21:17 host1 systemd-networkd[181]: Could not process link message, ignoring: No such device

Smells like https://github.com/systemd/systemd/issues/16160 - does a late "networkctl reload" work for you as well?

Online

#5 2020-07-14 21:06:25

exoyds
Member
Registered: 2020-07-14
Posts: 3

Re: [SOLVED] Systemd-networkd cant bring up wifi interface

I see that my google-fu has failed, that issue looks like exactly what my problem is!

"networkctl reload" works perfectly too! From this I assume I will have to wait until that commit makes it into the repos, or maybe have a go at packaging it myself.

Thank you so much! smile

Offline

#6 2020-07-15 06:00:55

seth
Member
From: Won't reply 2 private help req
Registered: 2012-09-03
Posts: 77,764

Re: [SOLVED] Systemd-networkd cant bring up wifi interface

\o/

Please always remember to mark resolved threads by editing your initial posts subject - so others will know that there's no task left, but maybe a solution to find.
Thanks.

Online

Board footer

Powered by FluxBB