dhcpcd error after kernel upgrade to 5.0.2 arch1-1

minorutkd · 2019-03-21 03:35:56

After recent kernel upgrade (maybe from 4.X) to 5.0.2 arch1-1, dhcpcd fails to start.

Following is the result of the command "lspci -vvx"

08:00.0 Ethernet controller: Broadcom Inc. and subsidiaries BCM4401-B0 100Base-TX (rev 02)
	Subsystem: Dell BCM4401-B0 100Base-TX
	Control: I/O- Mem+ BusMaster+ SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx-
	Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
	Latency: 64
	Interrupt: pin A routed to IRQ 21
	NUMA node: 0
	Region 0: Memory at c0200000 (32-bit, non-prefetchable) [size=8K]
	Capabilities: <access denied>
	Kernel driver in use: b44
	Kernel modules: b44
00: e4 14 0c 17 06 00 10 00 02 00 00 02 00 40 00 00
10: 00 00 20 c0 00 00 00 00 00 00 00 00 00 00 00 00
20: 00 00 00 00 00 00 00 00 00 00 00 00 28 10 f5 01
30: 00 00 00 00 40 00 00 00 00 00 00 00 0a 01 00 00

Following is a part of the result of the command "journalctl -b 0"

Mar 21 08:58:53 kashiwa systemd[1]: Starting dhcpcd on all interfaces...
Mar 21 08:58:53 kashiwa systemd[1]: Reached target System Time Synchronized.
Mar 21 08:58:53 kashiwa systemd[1]: Started Run system activity accounting tool every 10 minutes.
Mar 21 08:58:53 kashiwa /usr/bin/gpm[344]: *** info [daemon/startup.c(136)]:
Mar 21 08:58:53 kashiwa /usr/bin/gpm[344]: Started gpm successfully. Entered daemon mode.
Mar 21 08:58:53 kashiwa systemd[1]: Started Daily verification of password and group files.
Mar 21 08:58:53 kashiwa systemd[1]: Started Daily rotation of log files.
Mar 21 08:58:53 kashiwa systemd[1]: Started Daily man-db regeneration.
Mar 21 08:58:53 kashiwa audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=gpm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mar 21 08:58:53 kashiwa systemd[1]: Started Discard unused blocks once a week.
Mar 21 08:58:53 kashiwa systemd[1]: Started Generate summary of yesterday's process accounting.
Mar 21 08:58:53 kashiwa systemd[1]: Reached target Timers.
Mar 21 08:58:53 kashiwa systemd[1]: Started Virtual console mouse server.
Mar 21 08:58:54 kashiwa /usr/bin/gpm[344]: *** info [mice.c(1990)]:
Mar 21 08:58:54 kashiwa /usr/bin/gpm[344]: imps2: Auto-detected intellimouse PS/2
Mar 21 08:58:54 kashiwa dhcpcd[343]: dev: loaded udev
Mar 21 08:58:54 kashiwa audit: NETFILTER_CFG table=filter family=2 entries=0
Mar 21 08:58:54 kashiwa nscd[345]: 345 monitoring file `/etc/passwd` (1)
Mar 21 08:58:54 kashiwa nscd[345]: 345 monitoring directory `/etc` (2)
Mar 21 08:58:54 kashiwa nscd[345]: 345 monitoring file `/etc/group` (3)
Mar 21 08:58:54 kashiwa nscd[345]: 345 monitoring directory `/etc` (2)
Mar 21 08:58:54 kashiwa nscd[345]: 345 monitoring file `/etc/hosts` (4)
Mar 21 08:58:54 kashiwa nscd[345]: 345 monitoring directory `/etc` (2)
Mar 21 08:58:54 kashiwa nscd[345]: 345 monitoring file `/etc/resolv.conf` (5)
Mar 21 08:58:54 kashiwa nscd[345]: 345 monitoring directory `/etc` (2)
Mar 21 08:58:54 kashiwa nscd[345]: 345 monitoring file `/etc/services` (6)
Mar 21 08:58:54 kashiwa nscd[345]: 345 monitoring directory `/etc` (2)
Mar 21 08:58:54 kashiwa nscd[345]: 345 disabled inotify-based monitoring for file `/etc/netgroup': そのようなファイルやディレクトリはありません
Mar 21 08:58:54 kashiwa nscd[345]: 345 stat failed for file `/etc/netgroup'; will try again later: そのようなファイルやディレクトリはありません
Mar 21 08:58:54 kashiwa systemd-logind[334]: New seat seat0.
Mar 21 08:58:54 kashiwa systemd-logind[334]: Watching system buttons on /dev/input/event3 (Power Button)
Mar 21 08:58:54 kashiwa systemd-logind[334]: Watching system buttons on /dev/input/event0 (Power Button)
Mar 21 08:58:54 kashiwa systemd-logind[334]: Watching system buttons on /dev/input/event2 (Lid Switch)
Mar 21 08:58:54 kashiwa systemd-logind[334]: Watching system buttons on /dev/input/event1 (Sleep Button)
Mar 21 08:58:54 kashiwa systemd-logind[334]: Watching system buttons on /dev/input/event7 (HID 04d9:1400)
Mar 21 08:58:54 kashiwa systemd-logind[334]: Watching system buttons on /dev/input/event10 (HID 04d9:1400 System Control)
Mar 21 08:58:54 kashiwa systemd-logind[334]: Watching system buttons on /dev/input/event5 (AT Translated Set 2 keyboard)
Mar 21 08:58:54 kashiwa kernel: 8021q: 802.1Q VLAN Support v1.8
Mar 21 08:58:55 kashiwa kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database
Mar 21 08:58:55 kashiwa kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
Mar 21 08:58:55 kashiwa kernel: platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
Mar 21 08:58:55 kashiwa kernel: cfg80211: failed to load regulatory.db
Mar 21 08:58:55 kashiwa dhcpcd[343]: forked to background, child pid 366
Mar 21 08:58:55 kashiwa udisksd[338]: udisks daemon version 2.8.2 starting
Mar 21 08:58:55 kashiwa kernel: BUG: unable to handle kernel NULL pointer dereference at 0000000000000000
Mar 21 08:58:55 kashiwa kernel: #PF error: [normal kernel read fault]
Mar 21 08:58:55 kashiwa kernel: PGD 0 P4D 0 
Mar 21 08:58:55 kashiwa kernel: Oops: 0000 [#1] PREEMPT SMP NOPTI
Mar 21 08:58:55 kashiwa kernel: CPU: 0 PID: 366 Comm: dhcpcd Tainted: G        W         5.0.2-arch1-1-ARCH #1
Mar 21 08:58:55 kashiwa kernel: Hardware name: Dell Inc. Inspiron 1501 /0UW744, BIOS 2.1.0     12/18/2006
Mar 21 08:58:55 kashiwa kernel: RIP: 0010:swiotlb_tbl_map_single+0x120/0x310
Mar 21 08:58:55 kashiwa kernel: Code: 8b 44 24 18 44 8b 4c 24 28 89 cb 45 31 d2 4c 8b 1d f5 3a 77 01 44 89 c7 89 dd 4a 8d 44 25 00 48 21 d0 48 01 f8 49 39 c6 72 0a <45> 39 0c ab 0f 83 cf 00 00 00 42 8d 04 2b 48 89 c3 48 39 c6 41 0f
Mar 21 08:58:55 kashiwa kernel: RSP: 0018:ffffa6a9409fba60 EFLAGS: 00010016
Mar 21 08:58:55 kashiwa kernel: RAX: 0000000000000001 RBX: 0000000000000000 RCX: 0000000000000000
Mar 21 08:58:55 kashiwa kernel: RDX: 00000000001fffff RSI: 0000000000000000 RDI: 0000000000000001
Mar 21 08:58:55 kashiwa kernel: RBP: 0000000000000000 R08: 0000000000000001 R09: 0000000000000001
Mar 21 08:58:55 kashiwa kernel: R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
Mar 21 08:58:55 kashiwa kernel: R13: 0000000000000001 R14: 0000000000200000 R15: 000000000000061e
Mar 21 08:58:55 kashiwa kernel: FS:  00007fe24997d740(0000) GS:ffff97cc75c00000(0000) knlGS:0000000000000000
Mar 21 08:58:55 kashiwa kernel: CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
Mar 21 08:58:55 kashiwa kernel: CR2: 0000000000000000 CR3: 000000006d5a2000 CR4: 00000000000006f0
Mar 21 08:58:55 kashiwa kernel: Call Trace:
Mar 21 08:58:55 kashiwa kernel:  swiotlb_map+0x6c/0x1d0
Mar 21 08:58:55 kashiwa kernel:  dma_direct_map_page+0xc1/0x160
Mar 21 08:58:55 kashiwa kernel:  b44_alloc_rx_skb+0x1ce/0x3e0 [b44]
Mar 21 08:58:55 kashiwa kernel:  b44_init_rings+0xf3/0x180 [b44]
Mar 21 08:58:55 kashiwa kernel:  b44_open+0xf7/0x3e6 [b44]
Mar 21 08:58:55 kashiwa kernel:  __dev_open+0xcd/0x160
Mar 21 08:58:55 kashiwa kernel:  __dev_change_flags+0x183/0x1f0
Mar 21 08:58:55 kashiwa kernel:  dev_change_flags+0x21/0x60
Mar 21 08:58:55 kashiwa kernel:  devinet_ioctl+0x526/0x680
Mar 21 08:58:55 kashiwa kernel:  inet_ioctl+0x97/0x170
Mar 21 08:58:55 kashiwa kernel:  ? lock_page_memcg+0x11/0x80
Mar 21 08:58:55 kashiwa kernel:  ? dev_get_by_name_rcu+0x73/0x90
Mar 21 08:58:55 kashiwa kernel:  ? dev_get_by_name_rcu+0x73/0x90
Mar 21 08:58:55 kashiwa kernel:  sock_do_ioctl+0x43/0x140
Mar 21 08:58:55 kashiwa kernel:  sock_ioctl+0x19e/0x320
Mar 21 08:58:55 kashiwa kernel:  do_vfs_ioctl+0xa4/0x630
Mar 21 08:58:55 kashiwa kernel:  ? handle_mm_fault+0x10a/0x250
Mar 21 08:58:55 kashiwa kernel:  ? syscall_trace_enter+0x1d3/0x2d0
Mar 21 08:58:55 kashiwa kernel:  ksys_ioctl+0x60/0x90
Mar 21 08:58:55 kashiwa kernel:  __x64_sys_ioctl+0x16/0x20
Mar 21 08:58:55 kashiwa kernel:  do_syscall_64+0x5b/0x170
Mar 21 08:58:55 kashiwa kernel:  entry_SYSCALL_64_after_hwframe+0x44/0xa9
Mar 21 08:58:55 kashiwa kernel: RIP: 0033:0x7fe249a7280b
Mar 21 08:58:55 kashiwa kernel: Code: 0f 1e fa 48 8b 05 55 b6 0c 00 64 c7 00 26 00 00 00 48 c7 c0 ff ff ff ff c3 66 0f 1f 44 00 00 f3 0f 1e fa b8 10 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 25 b6 0c 00 f7 d8 64 89 01 48
Mar 21 08:58:55 kashiwa kernel: RSP: 002b:00007ffe1868cfa8 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
Mar 21 08:58:55 kashiwa kernel: RAX: ffffffffffffffda RBX: 000055948af8b6d0 RCX: 00007fe249a7280b
Mar 21 08:58:55 kashiwa kernel: RDX: 00007ffe1868cfb0 RSI: 0000000000008914 RDI: 0000000000000009
Mar 21 08:58:55 kashiwa kernel: RBP: 00007ffe1868cfb0 R08: 00007ffe1868cfbf R09: 00007ffe186a4080
Mar 21 08:58:55 kashiwa kernel: R10: 0000000000002c94 R11: 0000000000000246 R12: 0000000000000041
Mar 21 08:58:55 kashiwa kernel: R13: 00007ffe1868d020 R14: 431bde82d7b634db R15: 000055948af8c9f0
Mar 21 08:58:55 kashiwa kernel: Modules linked in: nf_reject_ipv4 xt_tcpudp cfg80211 xt_conntrack nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 8021q libcrc32c garp mrp stp llc iptable_filter radeon snd_hda_codec_idt snd_hda_codec_generic powernow_k8 joydev snd_hda_codec_hdmi edac_mce_amd snd_hda_intel kvm_amd snd_hda_codec ccp snd_hda_core rng_core snd_hwdep snd_pcm kvm snd_timer irqbypass snd b44 i2c_algo_bit mousedev ttm drm_kms_helper ssb dell_laptop ledtrig_audio mii drm libphy soundcore rfkill pcmcia pcmcia_core dell_wmi wmi_bmof sparse_keymap dell_smbios agpgart syscopyarea sysfillrect dell_wmi_descriptor psmouse dcdbas sysimgblt fb_sys_fops k8temp input_leds pcspkr sp5100_tco ac evdev mac_hid wmi battery i2c_piix4 ip_tables x_tables ext4 crc32c_generic crc16 mbcache jbd2 fscrypto sd_mod hid_generic usbhid hid sr_mod cdrom serio_raw atkbd libps2 ata_generic pata_acpi ahci pata_atiixp libahci sdhci_pci cqhci sdhci libata mmc_core ohci_pci ehci_pci scsi_mod ehci_hcd ohci_hcd i8042 serio
Mar 21 08:58:55 kashiwa kernel: CR2: 0000000000000000
Mar 21 08:58:55 kashiwa kernel: ---[ end trace 421145393c86c63d ]---
Mar 21 08:58:55 kashiwa kernel: RIP: 0010:swiotlb_tbl_map_single+0x120/0x310
Mar 21 08:58:55 kashiwa kernel: Code: 8b 44 24 18 44 8b 4c 24 28 89 cb 45 31 d2 4c 8b 1d f5 3a 77 01 44 89 c7 89 dd 4a 8d 44 25 00 48 21 d0 48 01 f8 49 39 c6 72 0a <45> 39 0c ab 0f 83 cf 00 00 00 42 8d 04 2b 48 89 c3 48 39 c6 41 0f
Mar 21 08:58:55 kashiwa kernel: RSP: 0018:ffffa6a9409fba60 EFLAGS: 00010016
Mar 21 08:58:55 kashiwa kernel: RAX: 0000000000000001 RBX: 0000000000000000 RCX: 0000000000000000
Mar 21 08:58:55 kashiwa kernel: RDX: 00000000001fffff RSI: 0000000000000000 RDI: 0000000000000001
Mar 21 08:58:55 kashiwa kernel: RBP: 0000000000000000 R08: 0000000000000001 R09: 0000000000000001
Mar 21 08:58:55 kashiwa kernel: R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
Mar 21 08:58:55 kashiwa kernel: R13: 0000000000000001 R14: 0000000000200000 R15: 000000000000061e
Mar 21 08:58:55 kashiwa kernel: FS:  00007fe24997d740(0000) GS:ffff97cc75c00000(0000) knlGS:0000000000000000
Mar 21 08:58:55 kashiwa kernel: CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
Mar 21 08:58:55 kashiwa kernel: CR2: 0000000000000000 CR3: 000000006d5a2000 CR4: 00000000000006f0
Mar 21 08:58:55 kashiwa kernel: note: dhcpcd[366] exited with preempt_count 1
Mar 21 08:58:55 kashiwa audit: NETFILTER_CFG table=filter family=2 entries=4
Mar 21 08:58:55 kashiwa systemd[1]: Started Login Service.
Mar 21 08:58:55 kashiwa audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-logind comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mar 21 08:58:55 kashiwa audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=iptables comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mar 21 08:58:55 kashiwa systemd[1]: Started IPv4 Packet Filtering Framework.
Mar 21 08:58:55 kashiwa systemd[1]: Started Name Service Cache Daemon.
Mar 21 08:58:55 kashiwa audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=nscd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mar 21 08:58:55 kashiwa systemd[1]: Started Resets System Activity Logs.
Mar 21 08:58:55 kashiwa audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=sysstat comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mar 21 08:58:55 kashiwa rtkit-daemon[340]: Successfully called chroot.
Mar 21 08:58:55 kashiwa rtkit-daemon[340]: Successfully dropped privileges.
Mar 21 08:58:55 kashiwa rtkit-daemon[340]: Successfully limited resources.
Mar 21 08:58:55 kashiwa rtkit-daemon[340]: Running.
Mar 21 08:58:55 kashiwa rtkit-daemon[340]: Watchdog thread running.
Mar 21 08:58:55 kashiwa rtkit-daemon[340]: Canary thread running.
Mar 21 08:58:55 kashiwa systemd[1]: Started Deferred execution scheduler.
Mar 21 08:58:55 kashiwa audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=atd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
Mar 21 08:58:55 kashiwa systemd[1]: dhcpcd.service: New main PID 366 does not exist or is a zombie.
Mar 21 08:58:55 kashiwa systemd[1]: dhcpcd.service: Failed with result 'protocol'.
Mar 21 08:58:55 kashiwa systemd[1]: Failed to start dhcpcd on all interfaces.
Mar 21 08:58:55 kashiwa audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=dhcpcd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=failed'

seth · 2019-03-21 08:19:30

The b44 kernel module crashes when initializig the interface.
Install the lts kernel to ensure this isn't a HW issue.

Cause is probably https://github.com/torvalds/linux/commi … 6e32b767ea
=> file a bug in case.

dazpoon · 2019-05-03 20:14:09

I have this bug too and already tried several Kernel builds. It appeared with 5.0, also 5.1 builds don't fix this.

It looks like the recent swiotlb changes in dma are causing these problems. I've tried the following patch dma/direct.c:

if (unlikely(!dma_direct_possible(dev, dma_addr, size)) &&
    !swiotlb_map(dev, &phys, &dma_addr, size, dir, attrs)) {
        report_addr(dev, dma_addr, size);
        return DMA_MAPPING_ERROR;
}

When I removed the && swiotlb_map() call, the b44 driver worked. From b44.c the
line of the call is ~684 (I added some debug printk's, so line number
isn't exact):

mapping = dma_map_single(bp->sdev->dma_dev, skb->data,
                         RX_PKT_BUF_SZ,
                         DMA_FROM_DEVICE);


/* Hardware bug work-around, the chip is unable to do PCI DMA
   to/from anything above 1GB  */

Maybe this is related to this behaviour found in https://groups.google.com/forum/#!topic … Ex80ZCue1o

Arch Linux

#1 2019-03-21 03:35:56

dhcpcd error after kernel upgrade to 5.0.2 arch1-1

#2 2019-03-21 08:19:30

Re: dhcpcd error after kernel upgrade to 5.0.2 arch1-1

#3 2019-05-03 20:14:09

Re: dhcpcd error after kernel upgrade to 5.0.2 arch1-1

Board footer