UrBackup Server 2.0.21 beta (updated 6x)/Client 2.0.19 beta (updated 6x)

This morning there are two backups hanged on the webui and these messages in urbackup.log :

2016-05-23 06:01:57: ERROR: Error decompressing stream(2): -3 Err: invalid block type
2016-05-23 06:01:58: ERROR: Error decompressing stream(2): -3 Err: invalid distance code
2016-05-23 06:02:01: WARNING: Reading from parent hash file failed (May be caused by a volume with increased size)
2016-05-23 06:02:06: WARNING: Reading from parent hash file failed (May be caused by a volume with increased size)
root@urbackup:~#

And with the 2 other one which continues to backup, after a while, urbackup crash :

[54795.076257] image backup wr[10722]: segfault at 7f28564a8de9 ip 00000000004f6e6a sp 00007f1facd24a30 error 4 in urbackupsrv[400000+63b000]

Got another new bug, webui doesn’t refresh correctly the progress bar :

Client view

Server view

And sometimes the client progress bar go back to 0% for few seconds :

Regards,

1 Like

Uroni - if symlinks are only for file backups, and a user is only doing image backups, then maybe you can suppress the message if it doesn’t affect them?

Have a new crash today while backuping an internet client on a fresh new install (incremental file backup) :

[84127.730550] traps: fbackup main[2869] trap divide error ip:6f112c sp:7f997b7ef940 error:0 in urbackupsrv[400000+63c000]

In /var/log/urbackup.log :

2016-05-25 11:16:08: Connecting to target service...
2016-05-25 11:16:08: Established internet connection. Service=0
2016-05-25 11:16:08: Scanning for changed hard links on volume of "Users"...
2016-05-25 11:16:08: Following symbolic link at "C:\Users\All Users" to "C:\ProgramData" confirms symlink backup target ".symlink_ProgramData" to "C:\ProgramData"
2016-05-25 11:16:08: Indexing of "Users" done. 21 filesystem lookups 353 db lookups and 15 db updates
2016-05-25 11:16:08: CLIENTEXT-7: Doing backup with hashed transfer...
2016-05-25 11:16:08: CLIENTEXT-7: Connecting to client...
2016-05-25 11:16:08: Authed+capa for client 'CLIENTEXT-7' (token auth) - 1 spare connections
2016-05-25 11:16:08: Connecting to target service...
2016-05-25 11:16:08: Established internet connection. Service=1
2016-05-25 11:16:09: Authed+capa for client 'CLIENTEXT-7' (token auth) - 1 spare connections
2016-05-25 11:16:09: Connecting to target service...
2016-05-25 11:16:09: Established internet connection. Service=1
2016-05-25 11:16:09: CLIENTEXT-7: Loading file list...
2016-05-25 11:16:09: Flushing FileClient...
2016-05-25 11:16:09: Authed+capa for client 'CLIENTEXT-7' (token auth) - 1 spare connections
2016-05-25 11:16:10: CLIENTEXT-7 Starting incremental backup...
2016-05-25 11:16:10: CLIENTEXT-7: Calculating file tree differences...
2016-05-25 11:16:10: CLIENTEXT-7: Creating snapshot...
2016-05-25 11:16:10: Flushing FileClient...
2016-05-25 11:16:10: CLIENTEXT-7: Deleting files in snapshot... (51)
2016-05-25 11:16:11: CLIENTEXT-7: Deleting files in hash snapshot...
2016-05-25 11:16:11: Connecting to target service...
2016-05-25 11:16:11: Established internet connection. Service=1
2016-05-25 11:16:11: Flushing FileClient...
2016-05-25 11:16:11: CLIENTEXT-7: Calculating tree difference size...
2016-05-25 11:16:11: CLIENTEXT-7: Linking unchanged and loading new files...

Webui “show logs” output :

25/05/16 11:39  	DEBUG  	Reflink copying is enabled
25/05/16 11:39  	DEBUG  	Reflink copying is enabled
25/05/16 11:39  	INFO  	Starting incremental file backup...
25/05/16 11:39  	DEBUG  	CLIENTEXT-7: Doing backup with hashes...
25/05/16 11:39  	DEBUG  	CLIENTEXT-7: Doing backup with intra file diffs...
25/05/16 11:39  	DEBUG  	CLIENTEXT-7: Connecting for filelist...
25/05/16 11:39  	DEBUG  	CLIENTEXT-7: Waiting for filelist
25/05/16 11:41  	INFO  	Scanning for changed hard links on volume of "Users"...
25/05/16 11:41  	INFO  	Following symbolic link at "C:\Users\All Users" to "C:\ProgramData" confirms symlink backup target ".symlink_ProgramData" to "C:\ProgramData"
25/05/16 11:41  	INFO  	Indexing of "Users" done. 8 filesystem lookups 366 db lookups and 7 db updates
25/05/16 11:41  	DEBUG  	CLIENTEXT-7: Doing backup with hashed transfer...
25/05/16 11:41  	INFO  	CLIENTEXT-7: Loading file list...
25/05/16 11:41  	DEBUG  	CLIENTEXT-7 Starting incremental backup...
25/05/16 11:41  	INFO  	CLIENTEXT-7: Calculating file tree differences...
25/05/16 11:41  	INFO  	CLIENTEXT-7: Creating snapshot...
25/05/16 11:41  	INFO  	CLIENTEXT-7: Deleting files in snapshot... (52)
25/05/16 11:41  	INFO  	CLIENTEXT-7: Deleting files in hash snapshot...

I try to restart server and launch incremental backup 3 times : same error.

[84127.730550] traps: fbackup main[2869] trap divide error ip:6f112c sp:7f997b7ef940 error:0 in urbackupsrv[400000+63c000]
[85635.619176] traps: fbackup main[3053] trap divide error ip:6f112c sp:7f70227ed940 error:0 in urbackupsrv[400000+63c000]
[85915.448355] traps: fbackup main[3128] trap divide error ip:6f112c sp:7fbd3b7ef940 error:0 in urbackupsrv[400000+63c000]
[86199.425573] traps: fbackup main[3206] trap divide error ip:6f112c sp:7f2fa5fec940 error:0 in urbackupsrv[400000+63c000]

Then i’ve launch a full file backup => completed successfully.
But incremental file backup still failed after full file backup :

[86764.637826] traps: fbackup main[3288] trap divide error ip:6f112c sp:7f41f67ed940 error:0 in urbackupsrv[400000+63c000]

Regards,

Unfortunately I cannot get the location where this happens. Are you using the debian package?

To help me find the error location you can either:

  • Use the debian package and enable core file generation (ulimit -c unlimited) and send me the core file the Linux kernel produces
  • Build the server from source, run it in gdb (gdb --args urbackupsrv run -v debug) and send me the output of bt once it has the error

Thanks!

Ok, got it now. Used the wrong command. If your minimal number of incremental file backups for that client is zero the issue should be fixed with the next version.

You’re right :

Thanks !

Regards,