[Bug 1222674] New: BTRFS Snapshots failing since kernel 6.8.4rc1, still working on 6.8.2
https://bugzilla.suse.com/show_bug.cgi?id=1222674 Bug ID: 1222674 Summary: BTRFS Snapshots failing since kernel 6.8.4rc1, still working on 6.8.2 Classification: openSUSE Product: openSUSE Tumbleweed Version: Current Hardware: Other OS: Other Status: NEW Severity: Normal Priority: P5 - None Component: Kernel Assignee: kernel-bugs@opensuse.org Reporter: pallaswept@proton.me QA Contact: qa-bugs@suse.de Target Milestone: --- Found By: --- Blocker: --- I just noticed I don't have a single snapshot from the last 3 days (they normally are taken hourly). Looking at "what changed?" I notice that's when I updated my kernel, and it's the only change I can see that would be relevant. I rebooted, and selected the old kernel from GRUB, and snapshots work fine. Reboot into 6.8.4 again, can't snapshot. More detail: Manual snapshots will work, but not if given a cleanup schedule, ie: sudo snapper create #works sudo snapper create -c timeline #fails Accordingly, it's unsurprising that scheduled snapshots with snapper fail with the same error as the manual snapshot, since it creates snapshots with the cleanup set. The logs show the following errors:
2024-04-11 19:28:52 MIL libsnapper(12199) Snapshot.cc(read):344 - found 95 snapshots 2024-04-11 19:28:52 WAR libsnapper(12199) FileUtils.cc(SDir):88 - THROW: open failed path://.snapshots/9878 errno:2 (No such file or directory) 2024-04-11 19:28:52 WAR libsnapper(12199) Btrfs.cc(checkSnapshot):490 - CAUGHT: open failed path://.snapshots/9878 errno:2 (No such file or directory) 2024-04-11 19:28:52 ERR libsnapper(12199) Btrfs.cc(createSnapshot):328 - create snapshot failed, btrfs_util_create_snapshot_fd2() failed, errno:2 (No such file or directory) 2024-04-11 19:28:52 WAR libsnapper(12199) Btrfs.cc(createSnapshot):329 - THROW: create snapshot failed 2024-04-11 19:28:52 WAR libsnapper(12199) Snapshot.cc(createHelper):780 - CAUGHT: create snapshot failed 2024-04-11 19:28:52 WAR libsnapper(12199) Snapshot.cc(createHelper):785 - RETHROW: create snapshot failed 2024-04-11 19:28:52 WAR libsnapper(12199) Client.cc(dispatch):1983 - CAUGHT: create snapshot failed
In this example, the last snapshot already existing was 9877, and it would have been creating 9878, but the directory does not exist before or after the command. If I create a manual snapshot with no cleanup set, or reboot into kernel 6.8.2, the snapshot will work, and become 9878. The failure of the snapshot causes the snapper-timeline.service to exit, also. It does not provide any information in its logs. Please let me know if there's anything I can do to help. -- You are receiving this mail because: You are the assignee for the bug.
https://bugzilla.suse.com/show_bug.cgi?id=1222674
https://bugzilla.suse.com/show_bug.cgi?id=1222674#c1
--- Comment #1 from pallas wept
https://bugzilla.suse.com/show_bug.cgi?id=1222674
https://bugzilla.suse.com/show_bug.cgi?id=1222674#c2
--- Comment #2 from pallas wept
https://bugzilla.suse.com/show_bug.cgi?id=1222674
https://bugzilla.suse.com/show_bug.cgi?id=1222674#c3
Ingo Göppert
2024-04-12 11:45:13 MIL libsnapper(26360) snapperd.cc(main):283 - Requesting DBus name 2024-04-12 11:45:13 MIL libsnapper(26360) snapperd.cc(main):298 - Loading snapper configs 2024-04-12 11:45:13 MIL libsnapper(26360) Snapper.cc(getConfigs):355 - Snapper get-configs 2024-04-12 11:45:13 MIL libsnapper(26360) Snapper.cc(getConfigs):356 - libsnapper version 0.10.7 2024-04-12 11:45:13 MIL libsnapper(26360) AsciiFile.cc(reload):922 - loading file /etc/sysconfig/snapper 2024-04-12 11:45:13 MIL libsnapper(26360) AsciiFile.cc(get_value):1078 - key:SNAPPER_CONFIGS value:root 2024-04-12 11:45:13 MIL libsnapper(26360) AsciiFile.cc(reload):922 - loading file /etc/snapper/configs/root 2024-04-12 11:45:13 MIL libsnapper(26360) AsciiFile.cc(get_value):1078 - key:SUBVOLUME value:/ 2024-04-12 11:45:13 MIL libsnapper(26360) AsciiFile.cc(get_value):1078 - key:ALLOW_USERS value: 2024-04-12 11:45:13 MIL libsnapper(26360) AsciiFile.cc(get_value):1078 - key:ALLOW_GROUPS value: 2024-04-12 11:45:13 MIL libsnapper(26360) snapperd.cc(main):311 - Listening for method calls and signals 2024-04-12 11:45:13 MIL libsnapper(26360) Snapper.cc(Snapper):97 - Snapper constructor 2024-04-12 11:45:13 MIL libsnapper(26360) Snapper.cc(Snapper):98 - snapper version 0.10.7 2024-04-12 11:45:13 MIL libsnapper(26360) Snapper.cc(Snapper):99 - libsnapper version 7.4.0 2024-04-12 11:45:13 MIL libsnapper(26360) Snapper.cc(Snapper):100 - config_name:root root_prefix:/ disable_filters:false 2024-04-12 11:45:13 MIL libsnapper(26360) AsciiFile.cc(reload):922 - loading file /etc/snapper/configs/root 2024-04-12 11:45:13 MIL libsnapper(26360) AsciiFile.cc(get_value):1078 - key:SUBVOLUME value:/ 2024-04-12 11:45:13 MIL libsnapper(26360) AsciiFile.cc(get_value):1078 - key:FSTYPE value:btrfs 2024-04-12 11:45:13 MIL libsnapper(26360) AsciiFile.cc(get_value):1078 - key:QGROUP value:1/0 2024-04-12 11:45:13 MIL libsnapper(26360) Selinux.cc(_is_selinux_enabled):141 - SELinux support disabled 2024-04-12 11:45:13 MIL libsnapper(26360) AsciiFile.cc(get_value):1078 - key:SYNC_ACL value:no 2024-04-12 11:45:13 MIL libsnapper(26360) Snapper.cc(Snapper):130 - subvolume:/ filesystem:btrfs 2024-04-12 11:45:13 MIL libsnapper(26360) Snapper.cc(loadIgnorePatterns):204 - number of ignore patterns:8 2024-04-12 11:45:13 ERR libsnapper(26360) Snapshot.cc(read):326 - snapshot check failed. not adding snapshot 2941 2024-04-12 11:45:13 ERR libsnapper(26360) Snapshot.cc(read):326 - snapshot check failed. not adding snapshot 2942 2024-04-12 11:45:13 ERR libsnapper(26360) Snapshot.cc(read):326 - snapshot check failed. not adding snapshot 2951 2024-04-12 11:45:13 ERR libsnapper(26360) Snapshot.cc(read):326 - snapshot check failed. not adding snapshot 2952 2024-04-12 11:45:13 ERR libsnapper(26360) Snapshot.cc(read):326 - snapshot check failed. not adding snapshot 2953 2024-04-12 11:45:13 ERR libsnapper(26360) Snapshot.cc(read):326 - snapshot check failed. not adding snapshot 2954 2024-04-12 11:45:13 ERR libsnapper(26360) Snapshot.cc(read):326 - snapshot check failed. not adding snapshot 2961 2024-04-12 11:45:13 ERR libsnapper(26360) Snapshot.cc(read):326 - snapshot check failed. not adding snapshot 2962 2024-04-12 11:45:13 ERR libsnapper(26360) Snapshot.cc(read):326 - snapshot check failed. not adding snapshot 2963 2024-04-12 11:45:13 ERR libsnapper(26360) Snapshot.cc(read):326 - snapshot check failed. not adding snapshot 2964 2024-04-12 11:45:13 MIL libsnapper(26360) Snapshot.cc(read):344 - found 19 snapshots 2024-04-12 11:45:13 WAR libsnapper(26360) FileUtils.cc(SDir):88 - THROW: open failed path://.snapshots/3740 errno:2 (No such file or directory) 2024-04-12 11:45:13 WAR libsnapper(26360) Btrfs.cc(checkSnapshot):490 - CAUGHT: open failed path://.snapshots/3740 errno:2 (No such file or directory) 2024-04-12 11:45:13 ERR libsnapper(26360) Btrfs.cc(createSnapshot):328 - create snapshot failed, btrfs_util_create_snapshot_fd2() failed, errno:2 (No such file or directory) 2024-04-12 11:45:13 WAR libsnapper(26360) Btrfs.cc(createSnapshot):329 - THROW: create snapshot failed 2024-04-12 11:45:13 WAR libsnapper(26360) Snapshot.cc(createHelper):780 - CAUGHT: create snapshot failed 2024-04-12 11:45:13 WAR libsnapper(26360) Snapshot.cc(createHelper):785 - RETHROW: create snapshot failed 2024-04-12 11:45:13 WAR libsnapper(26360) Client.cc(dispatch):1983 - CAUGHT: create snapshot failed 2024-04-12 11:45:43 MIL libsnapper(26360) Snapper.cc(~Snapper):142 - Snapper destructor 2024-04-12 11:46:13 MIL libsnapper(26360) snapperd.cc(main):315 - Exiting -- You are receiving this mail because: You are the assignee for the bug.
https://bugzilla.suse.com/show_bug.cgi?id=1222674
https://bugzilla.suse.com/show_bug.cgi?id=1222674#c7
--- Comment #7 from pallas wept
compile snapper and place an 'errno = 0;' before the btrfs_util_create_snapshot_fd2 in BtrfsUtils.cc?
TL;DR No change. Arvin, I made you a maintainer of https://build.opensuse.org/package/show/home:pallaswept:branches:boo1222674/... if you want to experiment. It just has a single patch file with that one line you asked for. Perhaps of interest: Even successful snapshots generate a (slightly different) error 2. I booted with the modified snapper, tried to snapshot with number cleanup, got the same error, then timeline, then no cleanup (which succeeded). When I checked the logs I saw three sets of errors in spite of only two failures. I ran the third command again, to verify. Logs:
2024-04-13 11:12:16 MIL libsnapper(12132) snapperd.cc(main):283 - Requesting DBus name 2024-04-13 11:12:16 MIL libsnapper(12132) snapperd.cc(main):298 - Loading snapper configs 2024-04-13 11:12:16 MIL libsnapper(12132) Snapper.cc(getConfigs):355 - Snapper get-configs 2024-04-13 11:12:16 MIL libsnapper(12132) Snapper.cc(getConfigs):356 - libsnapper version 0.10.7 2024-04-13 11:12:16 MIL libsnapper(12132) AsciiFile.cc(reload):922 - loading file /etc/sysconfig/snapper 2024-04-13 11:12:16 MIL libsnapper(12132) AsciiFile.cc(get_value):1078 - key:SNAPPER_CONFIGS value:root home 2024-04-13 11:12:16 MIL libsnapper(12132) AsciiFile.cc(reload):922 - loading file /etc/snapper/configs/root 2024-04-13 11:12:16 MIL libsnapper(12132) AsciiFile.cc(get_value):1078 - key:SUBVOLUME value:/ 2024-04-13 11:12:16 MIL libsnapper(12132) AsciiFile.cc(reload):922 - loading file /etc/snapper/configs/home 2024-04-13 11:12:16 MIL libsnapper(12132) AsciiFile.cc(get_value):1078 - key:SUBVOLUME value:/home 2024-04-13 11:12:16 MIL libsnapper(12132) AsciiFile.cc(get_value):1078 - key:ALLOW_USERS value: 2024-04-13 11:12:16 MIL libsnapper(12132) AsciiFile.cc(get_value):1078 - key:ALLOW_GROUPS value: 2024-04-13 11:12:16 MIL libsnapper(12132) AsciiFile.cc(get_value):1078 - key:ALLOW_USERS value: 2024-04-13 11:12:16 MIL libsnapper(12132) AsciiFile.cc(get_value):1078 - key:ALLOW_GROUPS value: 2024-04-13 11:12:16 MIL libsnapper(12132) snapperd.cc(main):311 - Listening for method calls and signals 2024-04-13 11:12:16 MIL libsnapper(12132) Snapper.cc(Snapper):97 - Snapper constructor 2024-04-13 11:12:16 MIL libsnapper(12132) Snapper.cc(Snapper):98 - snapper version 0.10.7 2024-04-13 11:12:16 MIL libsnapper(12132) Snapper.cc(Snapper):99 - libsnapper version 7.4.0 2024-04-13 11:12:16 MIL libsnapper(12132) Snapper.cc(Snapper):100 - config_name:root root_prefix:/ disable_filters:false 2024-04-13 11:12:16 MIL libsnapper(12132) AsciiFile.cc(reload):922 - loading file /etc/snapper/configs/root 2024-04-13 11:12:16 MIL libsnapper(12132) AsciiFile.cc(get_value):1078 - key:SUBVOLUME value:/ 2024-04-13 11:12:16 MIL libsnapper(12132) AsciiFile.cc(get_value):1078 - key:FSTYPE value:btrfs 2024-04-13 11:12:16 MIL libsnapper(12132) AsciiFile.cc(get_value):1078 - key:QGROUP value:1/0 2024-04-13 11:12:16 MIL libsnapper(12132) Selinux.cc(_is_selinux_enabled):141 - SELinux support disabled 2024-04-13 11:12:16 MIL libsnapper(12132) AsciiFile.cc(get_value):1078 - key:SYNC_ACL value:no 2024-04-13 11:12:16 MIL libsnapper(12132) Snapper.cc(Snapper):130 - subvolume:/ filesystem:btrfs 2024-04-13 11:12:16 MIL libsnapper(12132) Snapper.cc(loadIgnorePatterns):204 - number of ignore patterns:8 2024-04-13 11:12:16 MIL libsnapper(12132) Snapshot.cc(read):344 - found 101 snapshots 2024-04-13 11:12:16 WAR libsnapper(12132) Snapper.cc(calculateUsedSpace):928 - THROW: quota rescan or sync failed 2024-04-13 11:12:16 WAR libsnapper(12132) Client.cc(dispatch):2049 - CAUGHT: quota rescan or sync failed 2024-04-13 11:12:31 WAR libsnapper(12132) FileUtils.cc(SDir):88 - THROW: open failed path://.snapshots/9902 errno:2 (No such file or directory) 2024-04-13 11:12:31 WAR libsnapper(12132) Btrfs.cc(checkSnapshot):490 - CAUGHT: open failed path://.snapshots/9902 errno:2 (No such file or directory) 2024-04-13 11:12:31 ERR libsnapper(12132) Btrfs.cc(createSnapshot):328 - create snapshot failed, btrfs_util_create_snapshot_fd2() failed, errno:2 (No such file or directory) 2024-04-13 11:12:31 WAR libsnapper(12132) Btrfs.cc(createSnapshot):329 - THROW: create snapshot failed 2024-04-13 11:12:31 WAR libsnapper(12132) Snapshot.cc(createHelper):780 - CAUGHT: create snapshot failed 2024-04-13 11:12:31 WAR libsnapper(12132) Snapshot.cc(createHelper):785 - RETHROW: create snapshot failed 2024-04-13 11:12:31 WAR libsnapper(12132) Client.cc(dispatch):1983 - CAUGHT: create snapshot failed 2024-04-13 11:12:38 WAR libsnapper(12132) FileUtils.cc(SDir):88 - THROW: open failed path://.snapshots/9902 errno:2 (No such file or directory) 2024-04-13 11:12:38 WAR libsnapper(12132) Btrfs.cc(checkSnapshot):490 - CAUGHT: open failed path://.snapshots/9902 errno:2 (No such file or directory) 2024-04-13 11:12:38 ERR libsnapper(12132) Btrfs.cc(createSnapshot):328 - create snapshot failed, btrfs_util_create_snapshot_fd2() failed, errno:2 (No such file or directory) 2024-04-13 11:12:38 WAR libsnapper(12132) Btrfs.cc(createSnapshot):329 - THROW: create snapshot failed 2024-04-13 11:12:38 WAR libsnapper(12132) Snapshot.cc(createHelper):780 - CAUGHT: create snapshot failed 2024-04-13 11:12:38 WAR libsnapper(12132) Snapshot.cc(createHelper):785 - RETHROW: create snapshot failed 2024-04-13 11:12:38 WAR libsnapper(12132) Client.cc(dispatch):1983 - CAUGHT: create snapshot failed 2024-04-13 11:12:42 WAR libsnapper(12132) FileUtils.cc(SDir):88 - THROW: open failed path://.snapshots/9902 errno:2 (No such file or directory) 2024-04-13 11:12:42 WAR libsnapper(12132) Btrfs.cc(checkSnapshot):490 - CAUGHT: open failed path://.snapshots/9902 errno:2 (No such file or directory) 2024-04-13 11:12:42 MIL libsnapper(12132) SystemCmd.cc(SystemCmd):48 - constructor SystemCmd: /usr/lib/snapper/plugins/grub --refresh 2024-04-13 11:12:43 MIL libsnapper(12132) SystemCmd.cc(execute):180 - stopwatch 1.568772s for "/usr/lib/snapper/plugins/grub --refresh" 2024-04-13 11:12:43 MIL libsnapper(12132) SystemCmd.cc(execute):194 - system() Returns:0 2024-04-13 11:13:13 MIL libsnapper(12132) Snapper.cc(~Snapper):142 - Snapper destructor 2024-04-13 11:13:43 MIL libsnapper(12132) snapperd.cc(main):315 - Exiting 2024-04-13 11:15:00 MIL libsnapper(15146) snapperd.cc(main):283 - Requesting DBus name 2024-04-13 11:15:00 MIL libsnapper(15146) snapperd.cc(main):298 - Loading snapper configs 2024-04-13 11:15:00 MIL libsnapper(15146) Snapper.cc(getConfigs):355 - Snapper get-configs 2024-04-13 11:15:00 MIL libsnapper(15146) Snapper.cc(getConfigs):356 - libsnapper version 0.10.7 2024-04-13 11:15:00 MIL libsnapper(15146) AsciiFile.cc(reload):922 - loading file /etc/sysconfig/snapper 2024-04-13 11:15:00 MIL libsnapper(15146) AsciiFile.cc(get_value):1078 - key:SNAPPER_CONFIGS value:root home 2024-04-13 11:15:00 MIL libsnapper(15146) AsciiFile.cc(reload):922 - loading file /etc/snapper/configs/root 2024-04-13 11:15:00 MIL libsnapper(15146) AsciiFile.cc(get_value):1078 - key:SUBVOLUME value:/ 2024-04-13 11:15:00 MIL libsnapper(15146) AsciiFile.cc(reload):922 - loading file /etc/snapper/configs/home 2024-04-13 11:15:00 MIL libsnapper(15146) AsciiFile.cc(get_value):1078 - key:SUBVOLUME value:/home 2024-04-13 11:15:00 MIL libsnapper(15146) AsciiFile.cc(get_value):1078 - key:ALLOW_USERS value: 2024-04-13 11:15:00 MIL libsnapper(15146) AsciiFile.cc(get_value):1078 - key:ALLOW_GROUPS value: 2024-04-13 11:15:00 MIL libsnapper(15146) AsciiFile.cc(get_value):1078 - key:ALLOW_USERS value: 2024-04-13 11:15:00 MIL libsnapper(15146) AsciiFile.cc(get_value):1078 - key:ALLOW_GROUPS value: 2024-04-13 11:15:00 MIL libsnapper(15146) snapperd.cc(main):311 - Listening for method calls and signals 2024-04-13 11:15:00 MIL libsnapper(15146) Snapper.cc(Snapper):97 - Snapper constructor 2024-04-13 11:15:00 MIL libsnapper(15146) Snapper.cc(Snapper):98 - snapper version 0.10.7 2024-04-13 11:15:00 MIL libsnapper(15146) Snapper.cc(Snapper):99 - libsnapper version 7.4.0 2024-04-13 11:15:00 MIL libsnapper(15146) Snapper.cc(Snapper):100 - config_name:root root_prefix:/ disable_filters:false 2024-04-13 11:15:00 MIL libsnapper(15146) AsciiFile.cc(reload):922 - loading file /etc/snapper/configs/root 2024-04-13 11:15:00 MIL libsnapper(15146) AsciiFile.cc(get_value):1078 - key:SUBVOLUME value:/ 2024-04-13 11:15:00 MIL libsnapper(15146) AsciiFile.cc(get_value):1078 - key:FSTYPE value:btrfs 2024-04-13 11:15:00 MIL libsnapper(15146) AsciiFile.cc(get_value):1078 - key:QGROUP value:1/0 2024-04-13 11:15:00 MIL libsnapper(15146) Selinux.cc(_is_selinux_enabled):141 - SELinux support disabled 2024-04-13 11:15:00 MIL libsnapper(15146) AsciiFile.cc(get_value):1078 - key:SYNC_ACL value:no 2024-04-13 11:15:00 MIL libsnapper(15146) Snapper.cc(Snapper):130 - subvolume:/ filesystem:btrfs 2024-04-13 11:15:00 MIL libsnapper(15146) Snapper.cc(loadIgnorePatterns):204 - number of ignore patterns:8 2024-04-13 11:15:00 MIL libsnapper(15146) Snapshot.cc(read):344 - found 102 snapshots 2024-04-13 11:15:00 WAR libsnapper(15146) FileUtils.cc(SDir):88 - THROW: open failed path://.snapshots/9903 errno:2 (No such file or directory) 2024-04-13 11:15:00 WAR libsnapper(15146) Btrfs.cc(checkSnapshot):490 - CAUGHT: open failed path://.snapshots/9903 errno:2 (No such file or directory) 2024-04-13 11:15:00 MIL libsnapper(15146) SystemCmd.cc(SystemCmd):48 - constructor SystemCmd: /usr/lib/snapper/plugins/grub --refresh 2024-04-13 11:15:02 MIL libsnapper(15146) SystemCmd.cc(execute):180 - stopwatch 1.518764s for "/usr/lib/snapper/plugins/grub --refresh" 2024-04-13 11:15:02 MIL libsnapper(15146) SystemCmd.cc(execute):194 - system() Returns:0 -- You are receiving this mail because: You are the assignee for the bug.
https://bugzilla.suse.com/show_bug.cgi?id=1222674
https://bugzilla.suse.com/show_bug.cgi?id=1222674#c8
--- Comment #8 from pallas wept
https://bugzilla.suse.com/show_bug.cgi?id=1222674
https://bugzilla.suse.com/show_bug.cgi?id=1222674#c9
--- Comment #9 from Ingo Göppert
https://bugzilla.suse.com/show_bug.cgi?id=1222674
https://bugzilla.suse.com/show_bug.cgi?id=1222674#c10
--- Comment #10 from Ingo Göppert
The workaround works for me ;-)
qgroups are not enabled on the system where snapshots are failing. On a system installed some months before qgroups are enabled. Looks like the default settings have been modified in the year 2020.
I mean quotas enabled/disabled... -- You are receiving this mail because: You are the assignee for the bug.
participants (1)
-
bugzilla_noreply@suse.com