Timeshift fails to make snapshots

Hi all.

It looks like no one else is suffering from a failing timeshift?

Since a couple of days timeshift fails to make a snapshot, not with autosnap nor manually.
It starts to run and in the end it tells me that a snapshot was made, but it is not listed.

This is the latest log.

[13:30:44] Logboekbestand van sessie: /var/log/timeshift/2022-04-21_13-30-44_gui.log
[13:30:44] Distributie: EndeavourOS rolling (rolling)
[13:30:44] DIST_ID: EndeavourOS
[13:30:44] Main: check_dependencies()
[13:30:44] Main: add_default_exclude_entries()
[13:30:44] Main: add_default_exclude_entries(): exit
[13:30:44] update_partitions()
[13:30:44] Device: get_disk_space_using_df(): 2
[13:30:44] Device: get_mounted_filesystems_using_mtab(): 2
[13:30:44] Device: get_filesystems(): 6
[13:30:44] partition list updated
[13:30:44] detect_system_devices()
[13:30:44] /boot/efi is toegewezen aan apparaat: /dev/nvme0n1p1, UUID=2218-9BA3
[13:30:44] / is toegewezen aan apparaat: /dev/nvme0n1p2, UUID=180cdfdd-3557-4ce8-bfcc-c5abc43b2883
[13:30:44] Searching subvolume for system at path: /
[13:30:44] Users: richard root
[13:30:44] Encrypted home users: 
[13:30:44] Encrypted home dirs:

[13:30:44] Encrypted private dirs:

[13:30:44] Main: load_app_config()
[13:30:44] App-instellingen geladen: /etc/timeshift/timeshift.json
[13:30:44] IconManager: init()
[13:30:44] bin_path: /usr/bin/timeshift-gtk
[13:30:44] found images directory: /usr/share/timeshift/images
[13:30:44] Main(): ok
[13:30:44] Main: initialize_repo()
[13:30:44] backup_uuid=180cdfdd-3557-4ce8-bfcc-c5abc43b2883
[13:30:44] backup_parent_uuid=
[13:30:44] Setting snapshot device from config file
[13:30:44] repo: creating from uuid
[13:30:44] SnapshotRepo: from_uuid(): RSYNC
[13:30:44] uuid=180cdfdd-3557-4ce8-bfcc-c5abc43b2883
[13:30:44] SnapshotRepo: init_from_device()
[13:30:44] 
[13:30:44] SnapshotRepo: unlock_and_mount_devices()
[13:30:44] device=/dev/nvme0n1p2
[13:30:44] SnapshotRepo: unlock_and_mount_device()
[13:30:44] device=/dev/nvme0n1p2
[13:30:44] Device: get_mounted_filesystems_using_mtab(): 2
[13:30:44] ------------------
[13:30:44] arg=180cdfdd-3557-4ce8-bfcc-c5abc43b2883, device=/dev/nvme0n1p2
[13:30:44] /run/timeshift/backup
[13:30:44] /
[13:30:44] ------------------
[13:30:44] 
/dev/nvme0n1p2 is mounted at: /run/timeshift/backup, options: rw,relatime

[13:30:44] SnapshotRepo: load_snapshots()
[13:30:44] loading snapshots from '/run/timeshift/backup/timeshift/snapshots': 3 found
[13:30:44] SnapshotRepo: unlock_and_mount_device(): exit
[13:30:44] Gekozen momentopname-apparaat: /dev/nvme0n1p2
[13:30:44] Vrije ruimte: 65,0 GB
[13:30:44] SnapshotRepo: check_status()
[13:30:44] SnapshotRepo: available()
[13:30:44] is_available: ok
[13:30:44] SnapshotRepo: has_snapshots()
[13:30:44] SnapshotRepo: has_space()
[13:30:44] Device: get_disk_space_using_df(): 1
[13:30:44] Momentopname-apparaat: '/dev/nvme0n1p2'
[13:30:44] Locatie van momentopname: /run/timeshift/backup
[13:30:44] Oké
[13:30:44] 3 momentopnamen, 65,0 GB vrij
[13:30:44] Toestand: HAS_SNAPSHOTS_HAS_SPACE
[13:30:44] 
[13:30:44] SnapshotRepo: check_status(): exit
[13:30:44] SnapshotRepo: init_from_device(): exit
[13:30:44] SnapshotRepo: from_uuid(): exit
[13:30:44] Main: initialize_repo(): exit
[13:30:44] MainWindow: MainWindow()
[13:30:44] SnapshotListBox: SnapshotListBox()
[13:30:44] SnapshotListBox: SnapshotListBox(): exit
[13:30:44] MainWindow: MainWindow(): exit
[13:30:44] MainWindow(): init_delayed()
[13:30:44] SnapshotRepo: available()
[13:30:44] is_available: ok
[13:30:44] SnapshotRepo: available()
[13:30:44] is_available: ok
[13:30:44] SnapshotRepo: load_snapshots()
[13:30:44] loading snapshots from '/run/timeshift/backup/timeshift/snapshots': 3 found
[13:30:44] SnapshotRepo: check_status()
[13:30:44] SnapshotRepo: available()
[13:30:44] is_available: ok
[13:30:44] SnapshotRepo: has_snapshots()
[13:30:44] SnapshotRepo: has_space()
[13:30:44] Device: get_disk_space_using_df(): 1
[13:30:44] Momentopname-apparaat: '/dev/nvme0n1p2'
[13:30:44] Locatie van momentopname: /run/timeshift/backup
[13:30:44] Oké
[13:30:44] 3 momentopnamen, 65,0 GB vrij
[13:30:44] Toestand: HAS_SNAPSHOTS_HAS_SPACE
[13:30:44] 
[13:30:44] SnapshotRepo: check_status(): exit
[13:30:44] SnapshotRepo: has_snapshots()
[13:30:44] SnapshotRepo: has_snapshots()
[13:30:44] MainWindow(): init_delayed(): exit
[13:30:46] SnapshotRepo: available()
[13:30:46] is_available: ok
[13:30:46] SnapshotRepo: has_space()
[13:30:46] Device: get_disk_space_using_df(): 1
[13:30:46] BackupWindow: BackupWindow()
[13:30:46] EstimateBox: EstimateBox()
[13:30:46] EstimateBox: EstimateBox(): exit
[13:30:46] BackupDeviceBox: BackupDeviceBox()
[13:30:46] BackupDeviceBox: BackupDeviceBox(): exit
[13:30:46] BackupBox: BackupBox()
[13:30:46] BackupBox: BackupBox(): exit
[13:30:46] BackupFinishBox: BackupFinishBox()
[13:30:46] BackupFinishBox: BackupFinishBox(): exit
[13:30:46] BackupWindow: BackupWindow(): exit
[13:30:46] SnapshotRepo: available()
[13:30:46] is_available: ok
[13:30:46] SnapshotRepo: has_space()
[13:30:46] Device: get_disk_space_using_df(): 1
[13:30:46] 
[13:30:46] page: 2
[13:30:46] Main: create_snapshot()
[13:30:46] SnapshotRepo: has_space()
[13:30:46] Device: get_disk_space_using_df(): 1
[13:30:46] Main: backup_and_rotate()
[13:30:46] SnapshotRepo: available()
[13:30:46] is_available: ok
[13:30:46] SnapshotRepo: has_space()
[13:30:46] Device: get_disk_space_using_df(): 1
[13:30:46] ------------------------------------------------------------------------------
[13:30:46] Nieuwe momentopname maken...(RSYNC)
[13:30:46] Opslaan op apparaat: /dev/nvme0n1p2, aangekoppeld op pad: /run/timeshift/backup
[13:30:46] Koppelen vanuit momentopname: 2022-04-19_10-24-02
[13:30:46] Main: save_exclude_list_for_backup()
[13:30:46] Main: create_exclude_list_for_backup()
[13:30:46] Main: create_exclude_list_for_backup(): exit
[13:30:46] Bestanden synchroniseren met rsync...
[13:30:46] RsyncTask:execute()
[13:30:46] rsync -aii --recursive --verbose --delete --force --stats --sparse --delete-excluded --link-dest='/run/timeshift/backup/timeshift/snapshots/2022-04-19_10-24-02/localhost/' --log-file='/run/timeshift/backup/timeshift/snapshots/2022-04-21_13-30-46/rsync-log' --exclude-from='/run/timeshift/backup/timeshift/snapshots/2022-04-21_13-30-46/exclude.list' --delete-excluded '/' '/run/timeshift/backup/timeshift/snapshots/2022-04-21_13-30-46/localhost/'
[13:30:46] RsyncTask:prepare(): saved: /tmp/xZfELrdq/2022-04-21_13-30-46/script.sh
[13:30:46] AsyncTask: child_pid: 11651
[13:31:01] AsyncTask: finish(): enter
[13:31:01] AsyncTask: finish(): enter
[13:31:01] exit_code: 0
[13:31:01] exit_code: 0
[13:31:01] E: rsync meldde een fout
[13:31:01] E: Kon nieuwe momentopname niet maken
[13:31:01] Kon momentopname niet maken
[13:31:01] ------------------------------------------------------------------------------
[13:31:01] SnapshotRepo: load_snapshots()
[13:31:01] loading snapshots from '/run/timeshift/backup/timeshift/snapshots': 3 found
[13:31:01] Symbolische koppelingen bijgewerkt
[13:31:01] 
[13:31:01] page: 3
[13:31:02] SnapshotRepo: available()
[13:31:02] is_available: ok
[13:31:02] SnapshotRepo: load_snapshots()
[13:31:02] loading snapshots from '/run/timeshift/backup/timeshift/snapshots': 3 found
[13:31:02] SnapshotRepo: check_status()
[13:31:02] SnapshotRepo: available()
[13:31:02] is_available: ok
[13:31:02] SnapshotRepo: has_snapshots()
[13:31:02] SnapshotRepo: has_space()
[13:31:02] Device: get_disk_space_using_df(): 1
[13:31:02] Momentopname-apparaat: '/dev/nvme0n1p2'
[13:31:02] Locatie van momentopname: /run/timeshift/backup
[13:31:02] Oké
[13:31:02] 3 momentopnamen, 63,9 GB vrij
[13:31:02] Toestand: HAS_SNAPSHOTS_HAS_SPACE
[13:31:02] 
[13:31:02] SnapshotRepo: check_status(): exit
[13:31:02] SnapshotRepo: has_snapshots()
[13:31:02] SnapshotRepo: has_snapshots()
[13:31:09] SnapshotRepo: available()
[13:31:09] is_available: ok
[13:31:09] SnapshotRepo: has_space()
[13:31:09] Device: get_disk_space_using_df(): 1
[13:31:09] exit_app()
[13:31:09] Main: save_app_config()
[13:31:09] SnapshotRepo: available()
[13:31:09] is_available: ok
[13:31:09] App-instellingen opgeslagen: /etc/timeshift/timeshift.json
[13:31:09] crontab -l
[13:31:09] Kon crontab niet lezen
[13:31:09] crontab -l
[13:31:09] Kon crontab niet lezen
[13:31:09] unmount_target_device()
[13:31:09] clean_logs()
[13:31:09] rm -rf '/tmp/xZfELrdq'

I’ve reinstalled timeshift to no avail.
First timeshift-bin and later timeshift.

1 Like

It looks like rsync is failing.

Is there sufficient space available on the target device?

Think so.

Bestandssysteem Grootte Gebruikt Besch Geb% Aangekoppeld op
dev                7,5G        0  7,5G   0% /dev
run                7,6G     1,7M  7,6G   1% /run
/dev/nvme0n1p2     225G     166G   48G  78% /
tmpfs              7,6G        0  7,6G   0% /dev/shm
/dev/nvme0n1p1     511M      36M  476M   7% /boot/efi
tmpfs              7,6G      44K  7,6G   1% /tmp
tmpfs              1,6G      72K  1,6G   1% /run/user/1000

I just removed a snapshot, that went fine, but a new one failed again.
Funny thing is that timeshift thinks the new snapshop was made just fine, but it is not listed.

Rsync was updated a while ago.
2022-04-18 19:36 UTC

What if you try to downgrade rsync?

sudo downgrade rsync
6 Likes

Yes, that did the trick.
Hmm, I wonder why no one else is complaining about this…

yep, same here …
backup tools timeshift, backintime etc. - incompatibility with rsync 3.2.4

details:
https://bbs.archlinux.org/viewtopic.php?pid=2032506#p2032506

temporary solution - downgrade rsync to version 3.2.3-4

pacman -U https://archive.archlinux.org/packages/r/rsync/rsync-3.2.3-4-x86_64.pkg.tar.zst
3 Likes

You are sooo fast… :slightly_smiling_face:

1 Like

That would be the first time in my life. :rofl:

This topic was automatically closed 2 days after the last reply. New replies are no longer allowed.