Restore (over 2Tb) gets to 100% then never completes

Hi, trying to restore a 4Tb system (the disk not large enough bug has now been fixed in server version 2.5.34), however it gets to 100%, never completes, doesnt look like its writing any of the EFI / boot volume as the disk isnt bootable. The server shows a restore running the ends the task after 0-2 seconds every 5-10 mins.

Could you please attach some logs, thx

Will setup a restore test again to pull logs from restore client.

We have started to restore, again its not the drive or the system (tested on 2 different drives via 2 connection methods). The restore says 100%, however it appears to just be reading or writing to the drive now with nothing updating on the screen.

Where are the log files you would require from the restore client (bootable USB was used).

The log files are in /root/*.log . You might need to become root via sudo -i

restore_client.zip (3.3 MB)

Thx, it just seems to stop sending. Could you also attach/send the server (debug) log?

Hi

Its installed on a NAS so i would need to know in detail where that log is (unless i can get to it from the GUI)…. to access the NAS directly i have to enable quiet a few security settings to create a loop hole to get in (the back end).

If it is running you can see it live at Logs → Live Log → All clients.
Then it goes to /var/log/urbackup.log

I am told on QNAP (where this app is running) its in a hidden part of the system that cant be accessed with out breaking the OS, am i not able to get to the logs through the front end GUI?

Perhaps you can run the restore again then watch the live log towards the end?

I thought of something… the UrBackup server does a database clean up and update… that will take the whole server offline… should i disable this and try the restore again? For mine its set 1-7/5-8, would this stop the restore connection? I noticed in the live log the client was attempting to reconnect to the server for restore every few mins, so it was trying to re-connect. It seem to get to 100% (its done this twice).

I am doing another restore to a week older backup, and i have moved the database clean up to 3/5-8 giving me a few days window (seems to only take about a day for 2.2Tb restore.

Same issue, stopped the database backup and clean up, restore again says 100%, however doesnt seem to have completed, heres an image of the activities page. Nothing on the LOGS page for the restore, the last entry is the last backup it did, does it show logs for restores?

Can you go and watch the live log?

On the “Activities” tab? it shows up when the main restore was happening, there was no log button though to see it doing anything. All those small ones dont show up, they just show in the history page.

That one

I think i found it, going to start a restore again, do you want the log when it appears to have stopped at 100%?

UPDATE : Its still restoring, appears to be working ok, not yet at 100%, if i click that client in the Live Logs a window opens with this

11/28/25 08:07 INFO No log entries yet

Ifi leave to all clients:

11/28/25 08:07 DEBUG Sending file: /opt/QUrBackup/share/urbackup/www/images/indicator.gif done
11/28/25 08:07 DEBUG Lost channel connection to #Restore##17642824296619. has_error=true
11/28/25 08:07 DEBUG Authed+capa for client ‘dca.griffcomm.ca’ (encrypted-v2, compressed-zstd, token auth) - 1 spare connections
11/28/25 08:07 DEBUG Lost channel connection to #Restore##17642824296619. has_error=true
11/28/25 08:07 DEBUG Lost channel connection to #Restore##17642824296619. has_error=true
11/28/25 08:07 DEBUG Lost channel connection to #Restore##17642824296619. has_error=true
11/28/25 08:07 DEBUG Lost channel connection to #Restore##17642824296619. has_error=true
11/28/25 08:08 DEBUG Lost channel connection to #Restore##17642824296619. has_error=true
11/28/25 08:08 DEBUG Lost channel connection to #Restore##17642824296619. has_error=true
11/28/25 08:08 DEBUG Authed+capa for client ‘dca.griffcomm.ca’ (encrypted-v2, compressed-zstd, token auth) - 1 spare connections
11/28/25 08:08 DEBUG Sending file “/opt/QUrBackup/share/urbackup/www/��6oz”
11/28/25 08:08 DEBUG Sending file “/opt/QUrBackup/share/urbackup/www/���+�/�,�0̨̩����/5S��”
11/28/25 08:08 DEBUG Lost channel connection to #Restore##17642824296619. has_error=true
11/28/25 08:08 DEBUG Lost channel connection to #Restore##17642824296619. has_error=true
11/28/25 08:08 DEBUG Lost channel connection to #Restore##17642824296619. has_error=true
11/28/25 08:08 DEBUG Lost channel connection to #Restore##17642824296619. has_error=true
11/28/25 08:09 DEBUG Lost channel connection to #Restore##17642824296619. has_error=true
11/28/25 08:09 DEBUG Sending file “/opt/QUrBackup/share/urbackup/www/images/indicator.gif”
11/28/25 08:09 DEBUG Sending file: /opt/QUrBackup/share/urbackup/www/images/indicator.gif
11/28/25 08:09 DEBUG Sending file: /opt/QUrBackup/share/urbackup/www/images/indicator.gif done
11/28/25 08:09 DEBUG Authed+capa for client ‘dca.griffcomm.ca’ (encrypted-v2, compressed-zstd, token auth) - 1 spare connections
11/28/25 08:09 DEBUG Lost channel connection to #Restore##17642824296619. has_error=true

Hi, restore on the client is 100%, says its moving 0 bytes, below is the log for ALL clients

11/28/25 14:09 DEBUG Channel message: STARTUP timestamp=1764282429
11/28/25 14:10 DEBUG Channel message: DOWNLOAD IMAGE with_used_bytes=1&img_id=862157241&time=1757696451&mbr=false&offset=3979965100032
11/28/25 14:10 INFO Using volume size 3999582388224 from GPT (image file size 3999582913536)
11/28/25 14:10 WARNING Padding 4096 zero bytes during restore…
11/28/25 14:10 ERROR Error reading from VHD file during restore. Operation now in progress (code: 115)
11/28/25 14:10 DEBUG Lost channel connection to #Restore##17642824296619. has_error=true
11/28/25 14:11 DEBUG Lost channel connection to #Restore##17642824296619. has_error=false
11/28/25 14:12 DEBUG Sending Identity to client “GC-accounts” failed. Retrying soon…
11/28/25 14:12 INFO Sending Identity to client “GC-accounts” failed. Retrying in 10m… (returned “failed”)
11/28/25 14:12 DEBUG Sending Identity to client “GC-dns” failed. Retrying soon…
11/28/25 14:12 INFO Sending Identity to client “GC-dns” failed. Retrying in 10m… (returned “failed”)
11/28/25 14:12 DEBUG Lost channel connection to #Restore##17642824296619. has_error=false
11/28/25 14:13 DEBUG Sending Identity to client “GC-email” failed. Retrying soon…
11/28/25 14:13 INFO Sending Identity to client “GC-email” failed. Retrying in 10m… (returned “failed”)
11/28/25 14:13 DEBUG Lost channel connection to #Restore##17642824296619. has_error=true
11/28/25 14:13 DEBUG Channel message: UPDATE ACCESS KEY
11/28/25 14:13 DEBUG Channel message: STARTUP timestamp=1764282429
11/28/25 14:13 DEBUG Sending file “/opt/QUrBackup/share/urbackup/www/images/indicator.gif”
11/28/25 14:13 DEBUG Sending file: /opt/QUrBackup/share/urbackup/www/images/indicator.gif
11/28/25 14:13 DEBUG Sending file: /opt/QUrBackup/share/urbackup/www/images/indicator.gif done

Unfortunately it doesn’t log the actual error :confused:.

Are you storing as vhdx?

I guess I cannot give you a version with better logging?
Can you run some command line tool on the vhdx in a Linux container?

This could be interesting, i should test this…

The whole backup server is using “Compressed VHDX (Compressed non-standard Virtual HardDisk v2) (beta)” even for the PCs below 2Tb. I might conduct a restore of a PC way below 2Tb to see if that completes ok or if there is an issue with the VHDX Compressed format.

I have 2 other backup servers i am ware about (i deployed) and they use VHD Compressed and ive had restores complete with those (below 2Tb), i will start that test now and report back as it might be the disk format thats creating the issue.

All the servers are installed on QNAP NAS directly and can not be accessed at the backup, items need to be unprotected and creates major issues with the NAS dur to permissions.

Will report back with my findings.