Public bug reported:
Full log: https://autopkgtest.ubuntu.com/results/autopkgtest-
resolute/resolute/amd64/s/systemd/20251216_115139_34c51@/log.gz
Relevant part:
3950s ――――――――――――――――――――――――――――――――――――― ✀
―――――――――――――――――――――――――――――――――――――
3950s Listing only the last 100 lines from a long log.
3950s [ 18.431235] TEST-72-SYSUPDATE.sh[1196]: Exiting.
3950s [ 18.431489] TEST-72-SYSUPDATE.sh[1196]: Notify message sent to
'@9299265620373147101': "EXIT_STATUS=0"
3950s [ 18.433108] TEST-72-SYSUPDATE.sh[1193]: (sd-import-raw) succeeded.
3950s [ 18.434241] TEST-72-SYSUPDATE.sh[1193]: Successfully acquired
'/var/tmp/test-72-HeZcyn/source/part2-v1.raw.gz'.
3950s [ 18.434520] TEST-72-SYSUPDATE.sh[1193]: \ Acquiring
/var/tmp/test-72-HeZcyn/source/dir-v1 → /var/tmp/test-72-HeZcyn/dirs/dir-v1...
3950s [ 18.434734] TEST-72-SYSUPDATE.sh[1193]: Successfully forked off
'(sd-import-fs)' as PID 1199.
3950s [ 18.436193] TEST-72-SYSUPDATE.sh[1199]: Importing
'/var/tmp/test-72-HeZcyn/source/dir-v1', saving as
'/var/tmp/test-72-HeZcyn/dirs/.#sysupdatedir-v15cc957a78a3b3f0b'.
3950s [ 18.436578] TEST-72-SYSUPDATE.sh[1199]: Operating on image directory
'/var/lib/machines'.
3950s [ 18.436812] TEST-72-SYSUPDATE.sh[1199]: Directory tree
'/var/tmp/test-72-HeZcyn/dirs/.#sysupdatedir-v15cc957a78a3b3f0b' is not
recognizable as OS tree, checking whether to rearrange it.
3950s [ 18.436978] TEST-72-SYSUPDATE.sh[1199]: Directory
'/var/tmp/test-72-HeZcyn/dirs/.#sysupdatedir-v15cc957a78a3b3f0b' does not look
like an OS tree, and has multiple children, leaving as it is.
3950s [ 18.437209] TEST-72-SYSUPDATE.sh[1199]: Failed to set up quota
hierarchy for /var/tmp/test-72-HeZcyn/dirs/.#sysupdatedir-v15cc957a78a3b3f0b,
as directory is not on btrfs or not a subvolume. Ignoring.
3950s [ 18.440707] TEST-72-SYSUPDATE.sh[1199]: Directory
'/var/tmp/test-72-HeZcyn/dirs/.#sysupdatedir-v15cc957a78a3b3f0b successfully
installed. Exiting.
3950s [ 18.440999] TEST-72-SYSUPDATE.sh[1199]: Notify message sent to
'@14844070175299290587': "EXIT_STATUS=0"
3950s [ 18.441323] TEST-72-SYSUPDATE.sh[1193]: (sd-import-fs) succeeded.
3950s [ 18.442461] TEST-72-SYSUPDATE.sh[1193]: Successfully acquired
'/var/tmp/test-72-HeZcyn/source/dir-v1'.
3950s [ 18.444963] TEST-72-SYSUPDATE.sh[1193]: \ Acquiring
/var/tmp/test-72-HeZcyn/source/uki-v1.efi →
/var/tmp/test-72-HeZcyn/xbootldr/EFI/Linux/uki_v1+3-0.efi...
3950s [ 18.446203] TEST-72-SYSUPDATE.sh[1193]: Successfully forked off
'(sd-import-raw)' as PID 1200.
3950s [ 18.447817] TEST-72-SYSUPDATE.sh[1200]: Importing
'/var/tmp/test-72-HeZcyn/source/uki-v1.efi', saving as
'/var/tmp/test-72-HeZcyn/xbootldr/EFI/Linux/.#sysupdateuki_v1+3-0.efie4fe093ef458cccb'.
3950s [ 18.447981] TEST-72-SYSUPDATE.sh[1200]: Detected compression type:
uncompressed
3950s [ 18.448152] TEST-72-SYSUPDATE.sh[1200]: Failed to set file attributes
on
/var/tmp/test-72-HeZcyn/xbootldr/EFI/Linux/.#sysupdateuki_v1+3-0.efie4fe093ef458cccb:
Inappropriate ioctl for device
3950s [ 18.448299] TEST-72-SYSUPDATE.sh[1200]: Couldn't establish reflink,
using copy: Operation not supported
3950s [ 18.448446] TEST-72-SYSUPDATE.sh[1193]: Transfer 4/5 is 100% complete
(80% overall).
3950s [ 18.448581] TEST-72-SYSUPDATE.sh[1200]: Notify message sent to
'@6140757540467500137': "X_IMPORT_PROGRESS=100%"
3950s [ 18.448712] TEST-72-SYSUPDATE.sh[1200]: Imported 100%.
3950s [ 18.451327] TEST-72-SYSUPDATE.sh[1200]: Wrote 6B.
3950s [ 18.451766] TEST-72-SYSUPDATE.sh[1200]: Operation completed
successfully.
3950s [ 18.451899] TEST-72-SYSUPDATE.sh[1200]: Exiting.
3950s [ 18.452046] TEST-72-SYSUPDATE.sh[1200]: Notify message sent to
'@6140757540467500137': "EXIT_STATUS=0"
3950s [ 18.452156] TEST-72-SYSUPDATE.sh[1193]: (sd-import-raw) succeeded.
3950s [ 18.453038] TEST-72-SYSUPDATE.sh[1193]: Successfully acquired
'/var/tmp/test-72-HeZcyn/source/uki-v1.efi'.
3950s [ 18.456048] TEST-72-SYSUPDATE.sh[1193]: \ Acquiring
/var/tmp/test-72-HeZcyn/source/uki-extra-v1.efi →
/var/tmp/test-72-HeZcyn/xbootldr/EFI/Linux/uki_v1.efi.extra.d/extra.addon.efi...
3950s [ 18.456291] TEST-72-SYSUPDATE.sh[1193]: Successfully forked off
'(sd-import-raw)' as PID 1201.
3950s [ 18.462189] TEST-72-SYSUPDATE.sh[1201]: Importing
'/var/tmp/test-72-HeZcyn/source/uki-extra-v1.efi', saving as
'/var/tmp/test-72-HeZcyn/xbootldr/EFI/Linux/uki_v1.efi.extra.d/.#sysupdateextra.addon.eficb53f680a0feb6fe'.
3950s [ 18.463982] TEST-72-SYSUPDATE.sh[1201]: Detected compression type:
uncompressed
3950s [ 18.465301] TEST-72-SYSUPDATE.sh[1201]: Failed to set file attributes
on
/var/tmp/test-72-HeZcyn/xbootldr/EFI/Linux/uki_v1.efi.extra.d/.#sysupdateextra.addon.eficb53f680a0feb6fe:
Inappropriate ioctl for device
3950s [ 18.465693] TEST-72-SYSUPDATE.sh[1201]: Couldn't establish reflink,
using copy: Operation not supported
3950s [ 18.466230] TEST-72-SYSUPDATE.sh[1193]: Transfer 5/5 is 100% complete
(100% overall).
3950s [ 18.466553] TEST-72-SYSUPDATE.sh[1201]: Notify message sent to
'@846560721413451597': "X_IMPORT_PROGRESS=100%"
3950s [ 18.466756] TEST-72-SYSUPDATE.sh[1201]: Imported 100%.
3950s [ 18.467238] TEST-72-SYSUPDATE.sh[1201]: Wrote 6B.
3950s [ 18.467652] TEST-72-SYSUPDATE.sh[1201]: Operation completed
successfully.
3950s [ 18.467877] TEST-72-SYSUPDATE.sh[1201]: Exiting.
3950s [ 18.468488] TEST-72-SYSUPDATE.sh[1201]: Notify message sent to
'@846560721413451597': "EXIT_STATUS=0"
3950s [ 18.468863] TEST-72-SYSUPDATE.sh[1193]: (sd-import-raw) succeeded.
3950s [ 18.469125] TEST-72-SYSUPDATE.sh[1193]: Successfully acquired
'/var/tmp/test-72-HeZcyn/source/uki-extra-v1.efi'.
3950s [ 18.484248] TEST-72-SYSUPDATE.sh[1193]: Successfully installed
'/var/tmp/test-72-HeZcyn/source/part1-v1.raw' (regular-file) as
'/proc/self/fd/3p1' (partition).
3950s [ 18.508148] TEST-72-SYSUPDATE.sh[1193]: Successfully installed
'/var/tmp/test-72-HeZcyn/source/part2-v1.raw.gz' (regular-file) as
'/proc/self/fd/3p3' (partition).
3950s [ 18.514142] TEST-72-SYSUPDATE.sh[1193]: Successfully installed
'/var/tmp/test-72-HeZcyn/source/dir-v1' (directory) as
'/var/tmp/test-72-HeZcyn/dirs/dir-v1' (directory).
3950s [ 18.514878] TEST-72-SYSUPDATE.sh[1193]: Updated symlink
'/var/tmp/test-72-HeZcyn/dirs/current' → 'dir-v1'.
3950s [ 18.517202] TEST-72-SYSUPDATE.sh[1193]: Successfully installed
'/var/tmp/test-72-HeZcyn/source/uki-v1.efi' (regular-file) as
'/var/tmp/test-72-HeZcyn/xbootldr/EFI/Linux/uki_v1+3-0.efi' (regular-file).
3950s [ 18.519045] TEST-72-SYSUPDATE.sh[1193]: Successfully installed
'/var/tmp/test-72-HeZcyn/source/uki-extra-v1.efi' (regular-file) as
'/var/tmp/test-72-HeZcyn/xbootldr/EFI/Linux/uki_v1.efi.extra.d/extra.addon.efi'
(regular-file).
3950s [ 18.519588] TEST-72-SYSUPDATE.sh[1193]: * Successfully installed
update 'v1'.
3950s [ 18.520601] TEST-72-SYSUPDATE.sh[1207]: +
/lib/systemd/systemd-sysupdate --verify=no check-new
3950s [ 18.523137] TEST-72-SYSUPDATE.sh[1208]: Skipping file
'/run/sysupdate.d/99-optional.transfer' with unexpected suffix.
3950s [ 18.523434] TEST-72-SYSUPDATE.sh[1208]: Skipping file
'/run/sysupdate.d/05-fifth.transfer' with unexpected suffix.
3950s [ 18.523681] TEST-72-SYSUPDATE.sh[1208]: Skipping file
'/run/sysupdate.d/04-fourth.transfer' with unexpected suffix.
3950s [ 18.523960] TEST-72-SYSUPDATE.sh[1208]: Skipping file
'/run/sysupdate.d/03-third.transfer' with unexpected suffix.
3950s [ 18.525106] TEST-72-SYSUPDATE.sh[1208]: Skipping file
'/run/sysupdate.d/02-second.transfer' with unexpected suffix.
3950s [ 18.525362] TEST-72-SYSUPDATE.sh[1208]: Skipping file
'/run/sysupdate.d/01-first.transfer' with unexpected suffix.
3950s [ 18.525600] TEST-72-SYSUPDATE.sh[1208]: Skipping file
'/run/sysupdate.d/optional.feature' with unexpected suffix.
3950s [ 18.527868] TEST-72-SYSUPDATE.sh[1208]: Found container virtualization
none.
3950s [ 18.528204] TEST-72-SYSUPDATE.sh[1208]: Resolved $BOOT to
'/var/tmp/test-72-HeZcyn/xbootldr'
3950s [ 18.528478] TEST-72-SYSUPDATE.sh[1208]: Resolved $BOOT to
'/var/tmp/test-72-HeZcyn/xbootldr'
3950s [ 18.528745] TEST-72-SYSUPDATE.sh[1208]: Resolved $BOOT to
'/var/tmp/test-72-HeZcyn/xbootldr'
3950s [ 18.529158] TEST-72-SYSUPDATE.sh[1208]: Discovering installed
instances…
3950s [ 18.529873] TEST-72-SYSUPDATE.sh[1208]: Discovering available
instances…
3950s [ 18.530571] TEST-72-SYSUPDATE.sh[1208]: Determining installed update
sets…
3950s [ 18.531091] TEST-72-SYSUPDATE.sh[1208]: Determining available update
sets…
3950s [ 18.533824] TEST-72-SYSUPDATE.sh[1208]: No candidate found.
3950s [ 18.535437] TEST-72-SYSUPDATE.sh[394]: + verify_version_current
/dev/loop0 4096 v1 1
3950s [ 18.535942] TEST-72-SYSUPDATE.sh[394]: + local version=v1
3950s [ 18.536588] TEST-72-SYSUPDATE.sh[394]: + verify_version /dev/loop0
4096 v1 1
3950s [ 18.536999] TEST-72-SYSUPDATE.sh[394]: + local block_device=/dev/loop0
3950s [ 18.537359] TEST-72-SYSUPDATE.sh[394]: + local sector_size=4096
3950s [ 18.538082] TEST-72-SYSUPDATE.sh[394]: + local version=v1
3950s [ 18.538352] TEST-72-SYSUPDATE.sh[394]: + local part1_number=1
3950s [ 18.538607] TEST-72-SYSUPDATE.sh[394]: + local gpt_reserved_sectors
part2_number part1_offset part2_offset
3950s [ 18.538830] TEST-72-SYSUPDATE.sh[394]: + part2_number=3
3950s [ 18.539246] TEST-72-SYSUPDATE.sh[394]: + gpt_reserved_sectors=256
3950s [ 18.539513] TEST-72-SYSUPDATE.sh[394]: + part1_offset=256
3950s [ 18.540406] TEST-72-SYSUPDATE.sh[394]: + part2_offset=4352
3950s [ 18.542559] TEST-72-SYSUPDATE.sh[1209]: + dd if=/dev/loop0 bs=4096
skip=256 count=2048
3950s [ 18.543525] TEST-72-SYSUPDATE.sh[1210]: + cmp
/var/tmp/test-72-HeZcyn/source/part1-v1.raw
3950s [ 18.543976] TEST-72-SYSUPDATE.sh[1210]:
/var/tmp/test-72-HeZcyn/source/part1-v1.raw - differ: byte 264956, line 1029
3950s [ 18.544873] TEST-72-SYSUPDATE.sh[1209]: dd: IO error: Broken pipe
3950s [ 18.545534] TEST-72-SYSUPDATE.sh[394]: + at_exit
3950s [ 18.547220] TEST-72-SYSUPDATE.sh[394]: + set +e
3950s [FAILED] Failed to start TEST-72-SYSUPDATE.service - TEST-72-SYSUPDATE.
3950s [ 18.548391] TEST-72-SYSUPDATE.sh[1215]: + losetup -n --output NAME
--associated /var/tmp/test-72-HeZcyn/joined.raw
3950s [ 18.549873] TEST-72-SYSUPDATE.sh[1216]: + read -r loop_dev
3950s [ 18.552298] TEST-72-SYSUPDATE.sh[1216]: + losetup --detach /dev/loop0
3950s [ 18.552621] TEST-72-SYSUPDATE.sh[1216]: + read -r loop_dev
3950s [ 18.553204] TEST-72-SYSUPDATE.sh[394]: + rm -rf /var/tmp/test-72-HeZcyn
** Affects: systemd (Ubuntu)
Importance: Medium
Assignee: Nick Rosbrook (enr0n)
Status: Confirmed
** Tags: dcr-incoming
--
You received this bug notification because you are a member of Ubuntu
Bugs, which is subscribed to Ubuntu.
https://bugs.launchpad.net/bugs/2136752
Title:
systemd: TEST-72-SYSUPDATE fails in resolute
To manage notifications about this bug go to:
https://bugs.launchpad.net/ubuntu/+source/systemd/+bug/2136752/+subscriptions
--
ubuntu-bugs mailing list
[email protected]
https://lists.ubuntu.com/mailman/listinfo/ubuntu-bugs
