agn453
Posts: 4
Joined: Sun Nov 03, 2019 12:00 am

dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Sun Nov 03, 2019 1:31 am

On my Raspberry Pi 3B running -

[email protected]:~ $ uname -a
Linux pi1 4.19.75-v7+ #1270 SMP Tue Sep 24 18:45:11 BST 2019 armv7l GNU/Linux

Latest update to dhcpcd5 (1:8.1.1-1+rpt2) over (1:7.0.8-0.1+rpt1) with unmodified /etc/dhcpcd.conf goes into 100% cpu and both Ethernet and wlan interfaces drop their IPv4 and IPv6 addresses.

I'm running on a dual-stack IPv4/IPv6 configuration. 192.168.x.x IPv4 addresses are served via DHCP from another Pi running isc-dhcpd-4.4.1 and IPv6 addresses are from my gateway router via multicast Router Advertisements. Nothing has changed with my network configuration. Everything was working prior to the dhcpcd upgrade resulting from a "sudo apt-get update && sudo apt-get upgrade" yesterday.

On boot-up addresses for both Ethernet and wlan are obtained and the 100% cpu use by dhcpcd appears to be triggered upon lease-time expiry (in my case after 30 minutes).

I added a "debug" line to /etc/dhcpcd.conf for extra syslog output and a "sudo journalctl -u dhcpcd" command gives the attached output (gzip'ed so I could attach it and with my IPv6 addresses sanitised).

Restarting gets dhcpcd going via "sudo /etc/init.d/dhcpcd restart" but the 100% cpu reappears after a while.

I tried forcing a reinstallation of dhcpcd5 and no change.

I did notice in /var/log/dpkg.log a "status half-configured" status -

[email protected]:/var/log $ grep dhcpcd dpkg.log
2019-11-03 09:17:16 upgrade dhcpcd5:armhf 1:8.1.1-1+rpt2 1:8.1.1-1+rpt2
2019-11-03 09:17:16 status half-configured dhcpcd5:armhf 1:8.1.1-1+rpt2
2019-11-03 09:17:16 status unpacked dhcpcd5:armhf 1:8.1.1-1+rpt2
2019-11-03 09:17:16 status half-installed dhcpcd5:armhf 1:8.1.1-1+rpt2
2019-11-03 09:17:17 status unpacked dhcpcd5:armhf 1:8.1.1-1+rpt2
2019-11-03 09:17:17 configure dhcpcd5:armhf 1:8.1.1-1+rpt2 <none>
2019-11-03 09:17:17 status unpacked dhcpcd5:armhf 1:8.1.1-1+rpt2
2019-11-03 09:17:17 status half-configured dhcpcd5:armhf 1:8.1.1-1+rpt2
2019-11-03 09:17:23 status installed dhcpcd5:armhf 1:8.1.1-1+rpt2

Any ideas?

Tony
Attachments
dhcpcd.txt.gz
dhcpcd logging output
(3.91 KiB) Downloaded 20 times

agn453
Posts: 4
Joined: Sun Nov 03, 2019 12:00 am

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Sun Nov 03, 2019 3:43 am

A bit of digging and I found this regarding high cpu usage with dhcpcd 8.1.1 -

https://roy.marples.name/archives/dhcpc ... 02668.html

Sounds like I'm not the only one!

agn453
Posts: 4
Joined: Sun Nov 03, 2019 12:00 am

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Sun Nov 03, 2019 4:34 am

I just did a

[email protected]:~ $ sudo systemctl restart dhcpcd
Warning: The unit file, source configuration file or drop-ins of dhcpcd.service changed on disk. Run 'systemctl daemon-reload' to reload units.
[email protected]:~ $ sudo systemctl daemon-reload
[email protected]:~ $ sudo systemctl restart dhcpcd

and waited a lease time interval. So far so good - dhcpcd hasn't (yet) gone back into the 100% cpu condition.

Tony

tomrobbins1945
Posts: 1
Joined: Mon Nov 04, 2019 3:59 am

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Mon Nov 04, 2019 4:09 am

Same issue on a 3 B.
I have Buster running without this issue on both a 2 B and a 4 B. I have another 3 B and a 3 B+ that I will "upgrade" to Buster and report back.

Tom

User avatar
meinside
Posts: 7
Joined: Mon Apr 23, 2012 4:04 am
Location: South Korea
Contact: Website

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Mon Nov 04, 2019 4:25 am

I'm experiencing the same issue on my Raspberry Pi 4.

It begins to consume 100% cpu in about an hour, then becomes unresponsive (I didn't know it was dropping the interface, I'm running it as headless...) after about two hours.

My solution to this is exactly the same: I just restart (+ daemon-reload) the dhcpcd service,

but I have to do this on every reboot and it is very annoying.


Is there any workaround or fix for this?

Do I have to wait for the fix for dhcpcd?

ShiftPlusOne
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 6120
Joined: Fri Jul 29, 2011 5:36 pm
Location: The unfashionable end of the western spiral arm of the Galaxy

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Mon Nov 04, 2019 7:09 am

Alright, we'll roll back to an older version of dhcpcd.

Are you all using a stock, unmodified dhcpcd.conf?

moveax
Posts: 1
Joined: Mon Nov 04, 2019 9:16 am

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Mon Nov 04, 2019 9:22 am

I'm experiencing the same issue on a 4 B - stock, unmodified version of dhcpd.conf, fully updated version of Buster.

Thanks!

scottsweb
Posts: 5
Joined: Mon Nov 16, 2015 11:45 am

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Mon Nov 04, 2019 9:22 am

Just came here to report what is most likely the same issue. I have spent since last week trying to track down random crashes of my Raspberry Pi 4. There was nothing super obvious in the logs but from monitoring CPU and temperature I could see them both climb after about half a day of running to the point where the Pi fell off the network and I could no longer SSH into it. It required me pulling the plug to get it back, only to have it happen again and again.

This morning I noticed the CPU starting to climb and managed to login before a full lock up. dhcpcd was using 100% CPU and it led me to this forum post.

Version:

Code: Select all

[email protected]:~ $ dhcpcd --version
dhcpcd 8.1.1
Copyright (c) 2006-2019 Roy Marples
Compiled in features: INET ARP ARPing IPv4LL INET6 DHCPv6 AUTH
Fix?

Running the recommend commnads above did seem to bring it back under control (at least for now):

Code: Select all

[email protected]:~ $ sudo systemctl restart dhcpcd
Warning: The unit file, source configuration file or drop-ins of dhcpcd.service changed on disk. Run 'systemctl daemon-reload' to reload units.
[email protected]:~ $ sudo systemctl daemon-reload
[email protected]:~ $ sudo systemctl restart dhcpcd
Logs across this time

Code: Select all

Nov 04 08:00:00 bonsai dhcpcd[521]: veth9a2491a: waiting for carrier
Nov 04 08:00:00 bonsai dhcpcd[521]: veth4ec97b3: IAID 5f:81:31:61
Nov 04 08:00:00 bonsai dhcpcd[521]: veth4ec97b3: adding address fe80::35b4:a429:32b1:8374
Nov 04 08:00:00 bonsai dhcpcd[521]: veth9a2491a: carrier acquired
Nov 04 08:00:00 bonsai dhcpcd[521]: veth9a2491a: IAID 3c:2e:99:6d
Nov 04 08:00:00 bonsai dhcpcd[521]: veth9a2491a: adding address fe80::8305:e739:2af2:51ed
Nov 04 08:00:00 bonsai dhcpcd[521]: veth4ec97b3: soliciting a DHCP lease
Nov 04 08:00:00 bonsai dhcpcd[521]: veth9a2491a: soliciting a DHCP lease
Nov 04 08:00:00 bonsai dhcpcd[521]: veth9a2491a: soliciting an IPv6 router
Nov 04 08:00:01 bonsai dhcpcd[521]: veth4ec97b3: soliciting an IPv6 router
Nov 04 08:00:01 bonsai dhcpcd[521]: veth9a2491a: carrier lost
Nov 04 08:00:01 bonsai dhcpcd[521]: veth9a2491a: deleting address fe80::8305:e739:2af2:51ed
Nov 04 08:00:01 bonsai dhcpcd[521]: veth9a2491a: removing interface
Nov 04 08:00:01 bonsai dhcpcd[521]: veth4ec97b3: carrier lost
Nov 04 08:00:01 bonsai dhcpcd[521]: veth4ec97b3: deleting address fe80::35b4:a429:32b1:8374
Nov 04 08:00:01 bonsai dhcpcd[521]: veth4ec97b3: carrier acquired
Nov 04 08:00:01 bonsai dhcpcd[521]: veth4ec97b3: IAID 5f:81:31:61
Nov 04 08:00:01 bonsai dhcpcd[521]: veth4ec97b3: adding address fe80::35b4:a429:32b1:8374
Nov 04 08:00:01 bonsai dhcpcd[521]: veth4ec97b3: soliciting a DHCP lease
Nov 04 08:00:02 bonsai dhcpcd[521]: veth4ec97b3: soliciting an IPv6 router
Nov 04 08:00:06 bonsai dhcpcd[521]: veth4ec97b3: probing for an IPv4LL address
Nov 04 08:18:42 bonsai systemd[1]: Stopping dhcpcd on all interfaces...
Nov 04 08:18:42 bonsai dhcpcd[16201]: sending signal TERM to pid 521
Nov 04 08:18:42 bonsai dhcpcd[16201]: waiting for pid 521 to exit
Nov 04 08:18:42 bonsai dhcpcd[16201]: sending signal TERM to pid 521
Nov 04 08:18:42 bonsai dhcpcd[16201]: waiting for pid 521 to exit
Nov 04 08:18:52 bonsai dhcpcd[16201]: pid 521 failed to exit
Nov 04 08:18:52 bonsai dhcpcd[16201]: pid 521 failed to exit
Nov 04 08:18:52 bonsai systemd[1]: dhcpcd.service: Control process exited, code=exited, status=1/FAILURE
Nov 04 08:20:22 bonsai systemd[1]: dhcpcd.service: State 'stop-sigterm' timed out. Killing.
Nov 04 08:20:22 bonsai systemd[1]: dhcpcd.service: Killing process 521 (dhcpcd) with signal SIGKILL.
Nov 04 08:20:23 bonsai systemd[1]: dhcpcd.service: Main process exited, code=killed, status=9/KILL
Nov 04 08:20:23 bonsai systemd[1]: dhcpcd.service: Failed with result 'exit-code'.
Nov 04 08:20:23 bonsai systemd[1]: Stopped dhcpcd on all interfaces.
Nov 04 08:20:23 bonsai systemd[1]: Starting dhcpcd on all interfaces...
Nov 04 08:20:23 bonsai dhcpcd[16689]: main: control_open: Connection refused
Nov 04 08:20:23 bonsai dhcpcd[16689]: main: control_open: Connection refused
Nov 04 08:20:23 bonsai dhcpcd[16689]: dev: loaded udev
Nov 04 08:20:23 bonsai dhcpcd[16689]: wlan0: starting wpa_supplicant
Nov 04 08:20:23 bonsai dhcpcd[16689]: DUID 00:01:00:01:24:9e:78:09:dc:a6:32:07:01:6b
Nov 04 08:20:23 bonsai dhcpcd[16689]: eth0: IAID 32:07:01:6a
Nov 04 08:20:23 bonsai dhcpcd[16689]: wlan0: waiting for carrier
Nov 04 08:20:23 bonsai dhcpcd[16689]: vethd20ed18: IAID 6b:1c:33:06
Nov 04 08:20:23 bonsai dhcpcd[16689]: veth61740de: IAID 85:76:eb:49
Nov 04 08:20:23 bonsai dhcpcd[16689]: vethea9d9cb: IAID 7e:3e:5c:e7
Nov 04 08:20:23 bonsai dhcpcd[16689]: veth98ebf56: IAID 94:3a:e0:f1
Nov 04 08:20:23 bonsai dhcpcd[16689]: vethbb2561b: IAID 9e:47:20:7a
Nov 04 08:20:23 bonsai dhcpcd[16689]: veth6f362db: IAID 48:a2:e2:23
Nov 04 08:20:23 bonsai dhcpcd[16689]: veth46c9de0: IAID 81:14:1b:5d
Nov 04 08:20:23 bonsai dhcpcd[16689]: veth4dbae3d: IAID 3c:da:0e:37
Nov 04 08:20:23 bonsai dhcpcd[16689]: veth4ec97b3: IAID 5f:81:31:61
Nov 04 08:20:23 bonsai dhcpcd[16689]: veth46c9de0: soliciting a DHCP lease
Nov 04 08:20:23 bonsai dhcpcd[16689]: vethd20ed18: soliciting a DHCP lease
Nov 04 08:20:23 bonsai dhcpcd[16689]: veth98ebf56: soliciting an IPv6 router
Nov 04 08:20:23 bonsai dhcpcd[16689]: veth61740de: soliciting an IPv6 router
Nov 04 08:20:23 bonsai dhcpcd[16689]: vethbb2561b: soliciting an IPv6 router
Nov 04 08:20:24 bonsai dhcpcd[16689]: veth4dbae3d: soliciting a DHCP lease
Nov 04 08:20:24 bonsai dhcpcd[16689]: veth98ebf56: soliciting a DHCP lease
Nov 04 08:20:24 bonsai dhcpcd[16689]: vethbb2561b: soliciting a DHCP lease
Nov 04 08:20:24 bonsai dhcpcd[16689]: vethea9d9cb: soliciting a DHCP lease
Nov 04 08:20:24 bonsai dhcpcd[16689]: veth4ec97b3: soliciting a DHCP lease
Nov 04 08:20:24 bonsai dhcpcd[16689]: veth6f362db: soliciting a DHCP lease
Nov 04 08:20:24 bonsai dhcpcd[16689]: veth4ec97b3: soliciting an IPv6 router
Nov 04 08:20:24 bonsai dhcpcd[16689]: veth4dbae3d: soliciting an IPv6 router
Nov 04 08:20:24 bonsai dhcpcd[16689]: veth61740de: soliciting a DHCP lease
Nov 04 08:20:24 bonsai dhcpcd[16689]: veth46c9de0: soliciting an IPv6 router
Nov 04 08:20:24 bonsai dhcpcd[16689]: veth6f362db: soliciting an IPv6 router
Nov 04 08:20:24 bonsai dhcpcd[16689]: eth0: rebinding lease of 192.168.11.3
Nov 04 08:20:24 bonsai dhcpcd[16689]: eth0: soliciting an IPv6 router
Nov 04 08:20:24 bonsai dhcpcd[16689]: vethd20ed18: soliciting an IPv6 router
Nov 04 08:20:24 bonsai dhcpcd[16689]: vethea9d9cb: soliciting an IPv6 router
Nov 04 08:20:24 bonsai dhcpcd[16689]: eth0: leased 192.168.11.3 for 86400 seconds
Nov 04 08:20:24 bonsai dhcpcd[16689]: eth0: adding route to 192.168.11.0/24
Nov 04 08:20:24 bonsai dhcpcd[16689]: eth0: adding default route via 192.168.11.1
Nov 04 08:20:24 bonsai dhcpcd[16689]: forked to background, child pid 16742
Nov 04 08:20:24 bonsai systemd[1]: Started dhcpcd on all interfaces.
I am running an unmodified dhcpcd.conf file.

So I am +1-ing to roll this back to a previous version. Let me know if I can provide any more information

ShiftPlusOne
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 6120
Joined: Fri Jul 29, 2011 5:36 pm
Location: The unfashionable end of the western spiral arm of the Galaxy

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Mon Nov 04, 2019 10:13 am

If anybody who is experiencing the issue is familiar with gdb, it may be worth installing dhcpcd5-dbgsym, attaching to the pid and seeing what it's doing. Might help fix the issue upstream.

cjan
Posts: 761
Joined: Sun May 06, 2012 12:00 am

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Mon Nov 04, 2019 10:35 am

no such issue here, Pi2 & EW-7811Un.

ztxdk
Posts: 2
Joined: Mon May 21, 2012 7:41 pm

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Mon Nov 04, 2019 3:58 pm

Same issue here on a pi 4.
Tried the different stuff listed here in the thread to no avail. No errors show up but after some time the network dies. I managed to catch dhcpd using 100% cpu before it died by chance..
Mine runs with no screen so kind of a bummer..

Regards
Martin

agn453
Posts: 4
Joined: Sun Nov 03, 2019 12:00 am

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Tue Nov 05, 2019 12:36 am

I see my Raspberry Pi 3B+ also shows symptoms. These clear after restarting dhcpcd - but if I reboot it they're back at lease renewal time.

I'm not too familiar with gdb but the following is a backtrace of the process in 100% cpu after installing the debug symbols.

If there's particular debugging commands I can try, get back to me with them.

Code: Select all

[email protected]:~ $ ps -ef | grep dhcpcd
root       367     1  0 11:20 ?        00:00:00 /sbin/dhcpcd -q -b
pi        1174  1056  0 11:27 pts/1    00:00:00 grep --color=auto dhcpcd
[email protected]:~ $ sudo gdb -p 367
GNU gdb (Raspbian 8.2.1-2) 8.2.1
Copyright (C) 2018 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.
Type "show copying" and "show warranty" for details.
This GDB was configured as "arm-linux-gnueabihf".
Type "show configuration" for configuration details.
For bug reporting instructions, please see:
<http://www.gnu.org/software/gdb/bugs/>.
Find the GDB manual and other documentation resources online at:
    <http://www.gnu.org/software/gdb/documentation/>.

For help, type "help".
Type "apropos word" to search for commands related to "word".
Attaching to process 367
Reading symbols from /sbin/dhcpcd5...Reading symbols from /usr/lib/debug/.build-id/2d/79cf5ea6f2f5a9286f8037799a997af3f750c8.debug...done.
done.
Reading symbols from /usr/lib/arm-linux-gnueabihf/libarmmem-v7l.so...(no debugging symbols found)...done.
Reading symbols from /lib/arm-linux-gnueabihf/libdl.so.2...Reading symbols from /usr/lib/debug/.build-id/bc/c9ee6666973f3f41da5bdf8c8d7c299e4a09a2.debug...done.
done.
Reading symbols from /lib/arm-linux-gnueabihf/libc.so.6...Reading symbols from /usr/lib/debug/.build-id/ef/dd27c16f5283e5c53dcbd1bbc3ef136e312d1b.debug...done.
done.
Reading symbols from /lib/ld-linux-armhf.so.3...Reading symbols from /usr/lib/debug/.build-id/fb/85e699c11db06c7b24f74de2cdada3146442a8.debug...done.
done.
Reading symbols from /lib/arm-linux-gnueabihf/dhcpcd/dev/udev.so...Reading symbols from /usr/lib/debug/.build-id/d7/b755d779135c9c606bce31664c8b5491622edf.debug...done.
done.
Reading symbols from /lib/arm-linux-gnueabihf/libudev.so.1...(no debugging symbols found)...done.
Reading symbols from /lib/arm-linux-gnueabihf/librt.so.1...Reading symbols from /usr/lib/debug/.build-id/1d/5428c68f929c6b4c0b781a608fc95ccb886efb.debug...done.
done.
Reading symbols from /lib/arm-linux-gnueabihf/libpthread.so.0...Reading symbols from /usr/lib/debug/.build-id/79/58164ddcdf86b06e4a06700f80a4655a80c40e.debug...done.
done.
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/arm-linux-gnueabihf/libthread_db.so.1".
0x0002fdc4 in ipv4_iffindaddr ([email protected]=0xe05e78, 
    [email protected]=0xdfd460, [email protected]=0x0) at ipv4.c:131
131	ipv4.c: No such file or directory.
(gdb) bt
#0  0x0002fdc4 in ipv4_iffindaddr ([email protected]=0xe05e78, 
    [email protected]=0xdfd460, [email protected]=0x0) at ipv4.c:131
#1  0x0003234c in arp_announceaddr (ctx=<optimized out>, ia=0xdfd460)
    at arp.c:544
#2  0x00030c84 in ipv4_applyaddr ([email protected]=0xe045c8) at ipv4.c:808
#3  0x0002c664 in dhcp_bind (ifp=0xe045c8) at dhcp.c:2258
#4  0x0002c998 in dhcp_arp_bind (ifp=<optimized out>) at dhcp.c:2427
#5  0x0002ea08 in dhcp_handledhcp ([email protected]=0xe045c8, 
    [email protected]=0x7e98d234, [email protected]=300, from=0x1, 
    [email protected]=0x7e98d200) at dhcp.c:3253
#6  0x0002f4f0 in dhcp_redirect_dhcp ([email protected]=0xe05e78, 
    [email protected]=0x7e98d234, [email protected]=300, 
    from=0x7e98d200, [email protected]=0x332aa8c0) at dhcp.c:2841
#7  0x0002e39c in dhcp_handledhcp (ifp=0xe05e78, bootp=0x7e98d234, 
    bootp_len=300, from=0x332aa8c0) at dhcp.c:2885
#8  0x0002f3dc in dhcp_readudp (ctx=<optimized out>, ifp=0xe05e78)
    at dhcp.c:3511
#9  0x0001afa4 in eloop_start (eloop=0xdf5608, signals=0x7e98fb9c, 
    [email protected]=0x7e98fb94) at eloop.c:979
#10 0x00016004 in main (argc=<optimized out>, argv=<optimized out>)
    at dhcpcd.c:2104
(gdb) det
Detaching from program: /sbin/dhcpcd5, process 367
[Inferior 1 (process 367) detached]
(gdb) quit
[email protected]:~ $ sudo systemctl restart dhcpcd
Tony

ZIn
Posts: 7
Joined: Tue Feb 27, 2018 9:04 pm

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Tue Nov 05, 2019 11:00 am

It seems to do something even weirder for me, I normally x windows to my raspberry 3 to run mathematica in its own window on a debian desktop (ssh -fX [email protected] nice -n 5 /usr/bin/mathematica) which works well. However even when dhcpcd doesn't clog the pi so that it won't respond to pings the throughput is atrocious. I'm on the same ethernet switch, so there's no network latency or throttling. While normally it's not very snappy, but good enough to solve a few integrals, currently I'm only get 1 Mbit/s throughput so the screen updates are horrible to use. The CPU is idling on the pi, and nothing else computer/switch has changed so I guess that it is the dhcpcd breaking.

@ShiftPlusOne
Alright, we'll roll back to an older version of dhcpcd.
Are you all using a stock, unmodified dhcpcd.conf?

Will that be automatic with the apt-get dist-upgrade or do we have to do somthing special?

ShiftPlusOne
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 6120
Joined: Fri Jul 29, 2011 5:36 pm
Location: The unfashionable end of the western spiral arm of the Galaxy

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Tue Nov 05, 2019 11:24 am

It will be automatic. Sorry I didn't do it yesterday. First thing today.

ZIn
Posts: 7
Joined: Tue Feb 27, 2018 9:04 pm

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Tue Nov 05, 2019 1:26 pm

@ShiftPlusOne
I ran
apt-get update ; apt-get dist-upgrade -y
and got this:
E: Release file for http://archive.raspberrypi.org/debian/d ... /InRelease is not valid yet (invalid for another 1h 27min 58s). Updates for this repository will not be applied.
Is this the soon to be released update?

trejan
Posts: 1106
Joined: Tue Jul 02, 2019 2:28 pm

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Tue Nov 05, 2019 1:48 pm

ZIn wrote:
Tue Nov 05, 2019 1:26 pm
@ShiftPlusOne
I ran
apt-get update ; apt-get dist-upgrade -y
and got this:
E: Release file for http://archive.raspberrypi.org/debian/d ... /InRelease is not valid yet (invalid for another 1h 27min 58s). Updates for this repository will not be applied.
Is this the soon to be released update?
Is the time on your Pi correct?

ZIn
Posts: 7
Joined: Tue Feb 27, 2018 9:04 pm

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Tue Nov 05, 2019 2:01 pm

@trejan
Just checked, yes it is currently correct. But whatever the problem was it is solved now and the dhcpcd is reverted:
dhcpcd --version
dhcpcd 7.0.8
Copyright (c) 2006-2018 Roy Marples
Compiled in features: INET ARP ARPing IPv4LL INET6 DHCPv6 AUTH

However the remote X-windows (or whatever it is called in this new century) still is only about 1Mbit/s and refreshes are horrible. Anybody know which board/index I should post in to ask what is going on?

ZIn
Posts: 7
Joined: Tue Feb 27, 2018 9:04 pm

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Tue Nov 05, 2019 2:24 pm

@ShiftPlusOne
There is still something strange going on. Two pi's on the same gigabit ethernet switch, no load on either the rapbian one has problems with network after the the dhcpcd was updated (and still there after it is downgraded). When I ping them:
raspberry pi 2 running OSMC:
--- 192.168.1.177 ping statistics ---
101 packets transmitted, 101 received, 0% packet loss, time 100181ms
rtt min/avg/max/mdev = 1.100/1.902/2.358/0.137 ms

raspberry pi 3 running stock raspbian:
--- 192.168.1.231 ping statistics ---
101 packets transmitted, 91 received, 9% packet loss, time 100374ms
rtt min/avg/max/mdev = 8.133/18.023/99.952/15.156 ms


When I do scp from the raspbian p I get:
scp [email protected]:Videos/test.mp4 .
test.mp4 0% 144KB 28.3KB/s 10:20:45 ETA

It used to be about 11 MB/s before the dhcpcd was modified (and the problem is stil there after reversion). Any ideas?

ShiftPlusOne
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 6120
Joined: Fri Jul 29, 2011 5:36 pm
Location: The unfashionable end of the western spiral arm of the Galaxy

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Tue Nov 05, 2019 2:37 pm

The 'new' dhcpcd package is identical to the one before the bad update. It only had a package version bump.

ZIn
Posts: 7
Joined: Tue Feb 27, 2018 9:04 pm

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Tue Nov 05, 2019 2:42 pm

ShiftPlusOne wrote:
Tue Nov 05, 2019 2:37 pm
The 'new' dhcpcd package is identical to the one before the bad update. It only had a package version bump.
My network has gone back to dialup since then however. It's possible that because it crashed a few times (and so I had to powercycle it) that it's done something horrible to the file system. Any easy way of checking integrity (disk and file) that you can think of?
Ta

ShiftPlusOne
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 6120
Joined: Fri Jul 29, 2011 5:36 pm
Location: The unfashionable end of the western spiral arm of the Galaxy

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Tue Nov 05, 2019 2:48 pm

debsums can be used to check integrity of files installed through dpkg. fsck wouldn't hurt either.

ZIn
Posts: 7
Joined: Tue Feb 27, 2018 9:04 pm

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Tue Nov 05, 2019 3:00 pm

ShiftPlusOne wrote:
Tue Nov 05, 2019 2:48 pm
debsums can be used to check integrity of files installed through dpkg. fsck wouldn't hurt either.
Thanks for the reply, I didn't need this eventually. This is strange one, it seems that the ethernet cable was not pushed in properly and that caused a a very slow connection (I've never seen that before, normally it's either working or not). For example now:

scp [email protected]:Videos/test.mp4 .
test.mp4 12% 133MB 11.1MB/s 01:20 ETA


I can only think that it was pushed such that only some of the pins connected and it fell back to 100 base T or even 10 base T - is that possible?

No matter it's working now and I can get back to my Padé approximants. Thanks for the help.

ShiftPlusOne
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 6120
Joined: Fri Jul 29, 2011 5:36 pm
Location: The unfashionable end of the western spiral arm of the Galaxy

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Tue Nov 05, 2019 4:04 pm

Looks like the CPU usage fix may have been fixed upstream (along with a few others)

https://roy.marples.name/cgit/dhcpcd.gi ... 278e2237ca

If people on the mailing list report that the fix works, I'll make another attempt.

trejan
Posts: 1106
Joined: Tue Jul 02, 2019 2:28 pm

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Tue Nov 05, 2019 4:10 pm

ZIn wrote:
Tue Nov 05, 2019 3:00 pm
I can only think that it was pushed such that only some of the pins connected and it fell back to 100 base T or even 10 base T - is that possible?
It is possible. 1000BASE-T needs all 4 pairs to work but 100BASE-T only wants 2 of the 4. If there was a bad connection on those other 2 pairs then it might have negotiated only 100BASE-T speeds.

If it ever happens again, run "sudo mii-tool eth0" and it'll say what the current link speed is. Nope. Ignore this. Read what rpdom wrote below!

Code: Select all

$ sudo mii-tool eth0
eth0: negotiated 1000baseT-HD flow-control, link ok
Last edited by trejan on Tue Nov 05, 2019 6:53 pm, edited 1 time in total.

User avatar
rpdom
Posts: 15913
Joined: Sun May 06, 2012 5:17 am
Location: Chelmsford, Essex, UK

Re: dhcpcd5 1:8.1.1-1+rpt2 - 100% cpu, interface addresses drop

Tue Nov 05, 2019 6:29 pm

trejan wrote:
Tue Nov 05, 2019 4:10 pm
ZIn wrote:
Tue Nov 05, 2019 3:00 pm
I can only think that it was pushed such that only some of the pins connected and it fell back to 100 base T or even 10 base T - is that possible?
It is possible. 1000BASE-T needs all 4 pairs to work but 100BASE-T only wants 2 of the 4. If there was a bad connection on those other 2 pairs then it might have negotiated only 100BASE-T speeds.

If it ever happens again, run "sudo mii-tool eth0" and it'll say what the current link speed is.

Code: Select all

$ sudo mii-tool eth0
eth0: negotiated 1000baseT-HD flow-control, link ok
I don't trust mii-tool. This is what it reports on a Pi 1B+ (with 100Mb Ethernet)

Code: Select all

eth0: negotiated 1000baseT-HD flow-control, link ok
which is clearly wrong. The link is not 1000Mb or Half-Duplex.

I use ethtool which reports lots of things, including:

Code: Select all

	Speed: 100Mb/s
	Duplex: Full
on that Pi, and

Code: Select all

	Speed: 1000Mb/s
	Duplex: Full
on my Pi 3B+, on which ironically mii-tool works correctly.

Return to “Troubleshooting”