Bug#935653: [unattended-upgrades] /usr/bin/unattended-upgrade hogging cpu

[Thibaut Girka]

I have the same issue

Running `/usr/bin/unattended-upgrade -v -d --download-only` manually shows that
it is trying to solve dependencies somehow and keeps failing at finding
something it is satisfied with. Here is an extract:

[…]
Checking: evolution-common ([, 
, ])
pkg libebook-1.2-19 now marked delete
sanity check failed for: {'evolution=3.34.0-2', 'evolution-plugins=3.34.0-2', 
'evolution-data-server=3.34.1-1', 'libedataserverui-1.2-2=3.34.1-1', 
'libevolution=3.34.0-2', 'libebook-1.2-20=3.34.1-1', 
'libedata-cal-2.0-1=3.34.1-1', 'libebook-1.2-19=3.30.5-1.1', 
'libedata-book-1.2-25=3.30.5-1.1', 'libebackend-1.2-10=3.34.1-1', 
'dino-im-common=0.0.git20191002.7adb0e8-1', 'libedataserver-1.2-24=3.34.1-1', 
'evolution-common=3.34.0-2', 'folks-common=0.11.4-1.2', 
'libfolks25=0.11.4-1.2', 'evolution-data-server-common=3.34.1-1', 
'libedata-book-1.2-26=3.34.1-1', 'dino-im=0.0.git20191002.7adb0e8-1', 
'libedata-cal-1.2-29=3.30.5-1.1', 'libcamel-1.2-62=3.34.1-1', 
'libfolks-eds25=0.11.4-1.2'}
falling back to adjusting checkinstall's dependencies recursively
falling back to adjusting dino-im's dependencies recursively
falling back to adjusting dino-im-common's dependencies recursively
Checking: evolution-data-server ([, 
])
pkg libebook-1.2-19 now marked delete
sanity check failed for: {'evolution=3.34.0-2', 'evolution-plugins=3.34.0-2', 
'evolution-data-server=3.34.1-1', 'libedataserverui-1.2-2=3.34.1-1', 
'libevolution=3.34.0-2', 'libebook-1.2-20=3.34.1-1', 
'libedata-cal-2.0-1=3.34.1-1', 'libebook-1.2-19=3.30.5-1.1', 
'libedata-book-1.2-25=3.30.5-1.1', 'libebackend-1.2-10=3.34.1-1', 
'dino-im-common=0.0.git20191002.7adb0e8-1', 'libedataserver-1.2-24=3.34.1-1', 
'evolution-common=3.34.0-2', 'folks-common=0.11.4-1.2', 
'libfolks25=0.11.4-1.2', 'evolution-data-server-common=3.34.1-1', 
'libedata-book-1.2-26=3.34.1-1', 'dino-im=0.0.git20191002.7adb0e8-1', 
'libedata-cal-1.2-29=3.30.5-1.1', 'libcamel-1.2-62=3.34.1-1', 
'libfolks-eds25=0.11.4-1.2'}
falling back to adjusting checkinstall's dependencies recursively
falling back to adjusting dino-im's dependencies recursively
falling back to adjusting dino-im-common's dependencies recursively
Checking: evolution-data-server-common ([, , , , , ])
Checking: evolution-plugins ([])
pkg libebook-1.2-19 now marked delete
sanity check failed for: {'evolution=3.34.0-2', 'evolution-plugins=3.34.0-2', 
'evolution-data-server=3.34.1-1', 'libedataserverui-1.2-2=3.34.1-1', 
'libevolution=3.34.0-2', 'libebook-1.2-20=3.34.1-1', 
'libedata-cal-2.0-1=3.34.1-1', 'libebook-1.2-19=3.30.5-1.1', 
'libedata-book-1.2-25=3.30.5-1.1', 'libebackend-1.2-10=3.34.1-1', 
'dino-im-common=0.0.git20191002.7adb0e8-1', 'libedataserver-1.2-24=3.34.1-1', 
'evolution-common=3.34.0-2', 'folks-common=0.11.4-1.2', 
'libfolks25=0.11.4-1.2', 'evolution-data-server-common=3.34.1-1', 
'libedata-book-1.2-26=3.34.1-1', 'dino-im=0.0.git20191002.7adb0e8-1', 
'libedata-cal-1.2-29=3.30.5-1.1', 'libcamel-1.2-62=3.34.1-1', 
'libfolks-eds25=0.11.4-1.2'}
[…]

Bug#935653: [unattended-upgrades] /usr/bin/unattended-upgrade hogging cpu

[Riccardo Magliocchetti]

Package: unattended-upgrades
Version: 1.14
Severity: normal

--- Please enter the report below this line. ---

Hello,

I have /usr/bin/python3 /usr/bin/unattended-upgrade using 100% of a core calling 
stat in a very tight loop for no apparent good reason. It does so by holding the 
/var/lib/dpkg/lock-frontend lock.


Even after a kill -9, a new process shows the same behaviour.

Stracing it looks like it's in a loop calling stat for files that does not 
exists:

sudo strace -c -p 6778
strace: Process 6778 attached
strace: [ Process PID=6778 runs in x32 mode. ]
strace: [ Process PID=6778 runs in 64 bit mode. ]
^Cstrace: Process 6778 detached
% time seconds  usecs/call callserrors syscall
-- --- --- - - 
100,000,147692   1 77789 57944 stat
-- --- --- - - 
100.000,147692 77789 57944 total

Excerpt on actual calls:

stat("/var/lib/apt/lists/ftp.de.debian.org_debian_dists_sid_contrib_i18n_Translation-en", 
{st_mode=S_IFREG|0644, st_size=208649, ...}) = 0
stat("/var/lib/apt/lists/ftp.de.debian.org_debian_dists_sid_contrib_i18n_Translation-it", 
0x7ffd7bd40c80) = -1 ENOENT (File o directory non esistente)
stat("/var/lib/apt/lists/ftp.de.debian.org_debian_dists_sid_contrib_i18n_Translation-it.xz", 
0x7ffd7bd40c80) = -1 ENOENT (File o directory non esistente)
stat("/var/lib/apt/lists/ftp.de.debian.org_debian_dists_sid_contrib_i18n_Translation-it.bz2", 
0x7ffd7bd40c80) = -1 ENOENT (File o directory non esistente)
stat("/var/lib/apt/lists/ftp.de.debian.org_debian_dists_sid_contrib_i18n_Translation-it.lzma", 
0x7ffd7bd40c80) = -1 ENOENT (File o directory non esistente)
stat("/var/lib/apt/lists/ftp.de.debian.org_debian_dists_sid_contrib_i18n_Translation-it.gz", 
0x7ffd7bd40c80) = -1 ENOENT (File o directory non esistente)
stat("/var/lib/apt/lists/ftp.de.debian.org_debian_dists_sid_contrib_i18n_Translation-it.lz4", 
0x7ffd7bd40c80) = -1 ENOENT (File o directory non esistente)
stat("/var/lib/apt/lists/ftp.de.debian.org_debian_dists_sid_contrib_i18n_Translation-it.zst", 
0x7ffd7bd40c80) = -1 ENOENT (File o directory non esistente)

...


Thanks

--
Riccardo Magliocchetti
@rmistaken

http://menodizero.it