Moin,
ich habe zwei Synologie 1511+, eine möchte ich auf die andere per Time Backup sichern. Das haute auch schon mal hin, aber jetzt schlägt jedes Backup fehl, jede Syncronisierung oder andere RSync-Sicherung. Es liegt an den Snapshots, die am Anfang der Sicherung nicht erstellt werden können. (22 Uhr)
Da scheinen wohl snapshots korrupt oder was auch immer zu sein, das sagt zumindest der zu sichernde Server:
Oct 6 22:00:12 FILESRV4 kernel: [531465.170903] connection7:0: ping timeout of 5 secs expired, recv timeout 5, last rx 4826135827, last ping 4826140827, now 4826145827
Oct 6 22:00:22 FILESRV4 [DEBUG]: /tmp/timebkptmpexec-7784dV[3787]: suspending snapshot origin [/dev/mapper/vol1-origin] ...
Oct 6 22:00:22 FILESRV4 kernel: [531475.481450] sd 15:0:0:0: [isda] Asking for cache data failed
Oct 6 22:00:22 FILESRV4 kernel: [531475.487341] sd 15:0:0:0: [isda] Assuming drive cache: write through
Oct 6 22:00:22 FILESRV4 kernel: [531475.535956] sd 15:0:0:0: [isda] Asking for cache data failed
Oct 6 22:00:22 FILESRV4 kernel: [531475.541806] sd 15:0:0:0: [isda] Assuming drive cache: write through
Oct 6 22:00:22 FILESRV4 [DEBUG]: /tmp/timebkptmpexec-7784dV[3787]: creating snapshot [/dev/md2] -> [vol1-snap0] ...
Oct 6 22:00:22 FILESRV4 [DEBUG]: /tmp/timebkptmpexec-7784dV[3787]: resuming snapshot origin [/dev/mapper/vol1-origin] ...
Oct 6 22:00:22 FILESRV4 kernel: [531475.660614] device-mapper: snapshots: Invalidating snapshot: Unable to allocate exception.
Oct 6 22:00:22 FILESRV4 kernel: [531475.692788] Buffer I/O error on device dm-1, logical block 0
Oct 6 22:00:22 FILESRV4 kernel: [531475.698794] Buffer I/O error on device dm-1, logical block 1
Oct 6 22:00:22 FILESRV4 kernel: [531475.704754] Buffer I/O error on device dm-1, logical block 2
Oct 6 22:00:22 FILESRV4 kernel: [531475.710712] Buffer I/O error on device dm-1, logical block 3
Oct 6 22:00:22 FILESRV4 kernel: [531475.716647] Buffer I/O error on device dm-1, logical block 0
Oct 6 22:00:22 FILESRV4 timebkp: [3783]BK_ERR:failed while mounting snapshot [/dev/mapper/vol1-snap0] on mount_point [/tmp/timebkp_3783/volume1]
Oct 6 22:00:22 FILESRV4 [DEBUG]: /tmp/timebkptmpexec-HG5gls[4095]: removeing snapshot [vol1-snap0]
Oct 6 22:00:22 FILESRV4 [DEBUG]: /tmp/timebkptmpexec-HG5gls[4095]: iscsi target [iqn.2000-01.com.synology:timebkp-target-FILESRV4_0011320D06DB-vol1-snap0'] logout
Oct 6 22:00:22 FILESRV4 [DEBUG]: /tmp/timebkptmpexec-HG5gls[4095]: removing iscsi target [iqn.2000-01.com.synology:timebkp-target-FILESRV4_0011320D06DB-vol1-snap0]
Oct 6 22:00:23 FILESRV4 timebkp: [3783]BK_WARN:creating snapshot of volume1 failed
Oct 6 22:00:23 FILESRV4 timebkp: [3783]BK_WARN:no snapshot has been created
Oct 6 22:10:06 FILESRV4 rsync: io timeout after 601 seconds when processing (@app/configbackup.dss) -- exiting
Oct 6 22:10:06 FILESRV4 synonetbkp: netbkp_rsync_execv.c:103 Failed to execute rsync command. source=[/volume1/@tmp/@app], target=[admin@172.24.1.28::NetBackup/FILESRV4_0011320D06DB/], ret=30
Oct 6 22:10:06 FILESRV4 synonetbkp: backup_utils.c:512 Input bad parameter.
Oct 6 22:10:06 FILESRV4 synonetbkp: backup_utils.c:574 File lock failed. [/tmp/backup/share_working.list]
Auf dem Backupserver steht folgendes im Message-Log:
Oct 6 22:00:02 kernel: [529928.950560] iSCSI - Discovery session from [127.0.0.1]
Oct 6 22:00:02 kernel: [529929.277085] iSCSI - Client [iqn.2005-03.org.open-iscsi:9fa9b1f2219] logged in from [127.0.0.1] to [127.0.0.1:12345]
Oct 6 22:00:23 kernel: [529950.402296] rx_data() returned an error.
Oct 6 22:00:23 kernel: [529950.406423] iSCSI - Login negotiation failed from [127.0.0.1]
Oct 6 22:10:06 rsyncd[12481]: io timeout after 600 seconds when processing () -- exiting
Oct 6 22:10:06 rsyncd[12476]: rsync error: timeout in data send/receive (code 30) at io.c(254) [receiver=3.0.4]
Oct 6 22:10:06 rsyncd[12476]: rsync error: rsync service is no running (code 43) at io.c(682) [generator=3.0.4]
In der Timebkp.log vom zu sichernden Server steht bei jedem Backupversuch drin: "failure to create snapshot".
das sieht dann so aus:
{INFO}{1317300117}{FS4BS5}{Task [FS4BS5] is creating backup version [20110929-1441].}
{ERR}{1317300139}{FS4BS5}{Task [FS4BS5] has failed to backup version [20110929-1441] due to [failure to create snapshot].}
{INFO}{1317301201}{FS4BS5}{Task [FS4BS5] is creating backup version [20110929-1500].}
{ERR}{1317301223}{FS4BS5}{Task [FS4BS5] has failed to backup version [20110929-1500] due to [failure to create snapshot].}
{INFO}{1317301560}{FS4BS5}{Task [FS4BS5] is creating backup version [20110929-1505].}
{ERR}{1317301582}{FS4BS5}{Task [FS4BS5] has failed to backup version [20110929-1505] due to [failure to create snapshot].}
{INFO}{1317302276}{FS4BS5}{Task [FS4BS5] is creating backup version [20110929-1517].}
{ERR}{1317302276}{FS4BS5}{Task [FS4BS5] has failed to backup version [20110929-1517] due to [failure to create snapshot].}
{INFO}{1317302336}{FS4BS5}{Task [FS4BS5] is creating backup version [20110929-1517].}
{ERR}{1317302336}{FS4BS5}{Task [FS4BS5] has failed to backup version [20110929-1517] due to [failure to create snapshot].}
{INFO}{1317304114}{FS4BS5}{Task [FS4BS5] is creating backup version [20110929-1547].}
{ERR}{1317304114}{FS4BS5}{Task [FS4BS5] has failed to backup version [20110929-1547] due to [failure to create snapshot].}
Liegt denn der Fehler auf der Daten- oder auf dem Backupsyno? An der Anmeldung kann es doch nicht liegen, obwohl es im Log steht.
Gruss Fab
ich habe zwei Synologie 1511+, eine möchte ich auf die andere per Time Backup sichern. Das haute auch schon mal hin, aber jetzt schlägt jedes Backup fehl, jede Syncronisierung oder andere RSync-Sicherung. Es liegt an den Snapshots, die am Anfang der Sicherung nicht erstellt werden können. (22 Uhr)
Da scheinen wohl snapshots korrupt oder was auch immer zu sein, das sagt zumindest der zu sichernde Server:
Oct 6 22:00:12 FILESRV4 kernel: [531465.170903] connection7:0: ping timeout of 5 secs expired, recv timeout 5, last rx 4826135827, last ping 4826140827, now 4826145827
Oct 6 22:00:22 FILESRV4 [DEBUG]: /tmp/timebkptmpexec-7784dV[3787]: suspending snapshot origin [/dev/mapper/vol1-origin] ...
Oct 6 22:00:22 FILESRV4 kernel: [531475.481450] sd 15:0:0:0: [isda] Asking for cache data failed
Oct 6 22:00:22 FILESRV4 kernel: [531475.487341] sd 15:0:0:0: [isda] Assuming drive cache: write through
Oct 6 22:00:22 FILESRV4 kernel: [531475.535956] sd 15:0:0:0: [isda] Asking for cache data failed
Oct 6 22:00:22 FILESRV4 kernel: [531475.541806] sd 15:0:0:0: [isda] Assuming drive cache: write through
Oct 6 22:00:22 FILESRV4 [DEBUG]: /tmp/timebkptmpexec-7784dV[3787]: creating snapshot [/dev/md2] -> [vol1-snap0] ...
Oct 6 22:00:22 FILESRV4 [DEBUG]: /tmp/timebkptmpexec-7784dV[3787]: resuming snapshot origin [/dev/mapper/vol1-origin] ...
Oct 6 22:00:22 FILESRV4 kernel: [531475.660614] device-mapper: snapshots: Invalidating snapshot: Unable to allocate exception.
Oct 6 22:00:22 FILESRV4 kernel: [531475.692788] Buffer I/O error on device dm-1, logical block 0
Oct 6 22:00:22 FILESRV4 kernel: [531475.698794] Buffer I/O error on device dm-1, logical block 1
Oct 6 22:00:22 FILESRV4 kernel: [531475.704754] Buffer I/O error on device dm-1, logical block 2
Oct 6 22:00:22 FILESRV4 kernel: [531475.710712] Buffer I/O error on device dm-1, logical block 3
Oct 6 22:00:22 FILESRV4 kernel: [531475.716647] Buffer I/O error on device dm-1, logical block 0
Oct 6 22:00:22 FILESRV4 timebkp: [3783]BK_ERR:failed while mounting snapshot [/dev/mapper/vol1-snap0] on mount_point [/tmp/timebkp_3783/volume1]
Oct 6 22:00:22 FILESRV4 [DEBUG]: /tmp/timebkptmpexec-HG5gls[4095]: removeing snapshot [vol1-snap0]
Oct 6 22:00:22 FILESRV4 [DEBUG]: /tmp/timebkptmpexec-HG5gls[4095]: iscsi target [iqn.2000-01.com.synology:timebkp-target-FILESRV4_0011320D06DB-vol1-snap0'] logout
Oct 6 22:00:22 FILESRV4 [DEBUG]: /tmp/timebkptmpexec-HG5gls[4095]: removing iscsi target [iqn.2000-01.com.synology:timebkp-target-FILESRV4_0011320D06DB-vol1-snap0]
Oct 6 22:00:23 FILESRV4 timebkp: [3783]BK_WARN:creating snapshot of volume1 failed
Oct 6 22:00:23 FILESRV4 timebkp: [3783]BK_WARN:no snapshot has been created
Oct 6 22:10:06 FILESRV4 rsync: io timeout after 601 seconds when processing (@app/configbackup.dss) -- exiting
Oct 6 22:10:06 FILESRV4 synonetbkp: netbkp_rsync_execv.c:103 Failed to execute rsync command. source=[/volume1/@tmp/@app], target=[admin@172.24.1.28::NetBackup/FILESRV4_0011320D06DB/], ret=30
Oct 6 22:10:06 FILESRV4 synonetbkp: backup_utils.c:512 Input bad parameter.
Oct 6 22:10:06 FILESRV4 synonetbkp: backup_utils.c:574 File lock failed. [/tmp/backup/share_working.list]
Auf dem Backupserver steht folgendes im Message-Log:
Oct 6 22:00:02 kernel: [529928.950560] iSCSI - Discovery session from [127.0.0.1]
Oct 6 22:00:02 kernel: [529929.277085] iSCSI - Client [iqn.2005-03.org.open-iscsi:9fa9b1f2219] logged in from [127.0.0.1] to [127.0.0.1:12345]
Oct 6 22:00:23 kernel: [529950.402296] rx_data() returned an error.
Oct 6 22:00:23 kernel: [529950.406423] iSCSI - Login negotiation failed from [127.0.0.1]
Oct 6 22:10:06 rsyncd[12481]: io timeout after 600 seconds when processing () -- exiting
Oct 6 22:10:06 rsyncd[12476]: rsync error: timeout in data send/receive (code 30) at io.c(254) [receiver=3.0.4]
Oct 6 22:10:06 rsyncd[12476]: rsync error: rsync service is no running (code 43) at io.c(682) [generator=3.0.4]
In der Timebkp.log vom zu sichernden Server steht bei jedem Backupversuch drin: "failure to create snapshot".
das sieht dann so aus:
{INFO}{1317300117}{FS4BS5}{Task [FS4BS5] is creating backup version [20110929-1441].}
{ERR}{1317300139}{FS4BS5}{Task [FS4BS5] has failed to backup version [20110929-1441] due to [failure to create snapshot].}
{INFO}{1317301201}{FS4BS5}{Task [FS4BS5] is creating backup version [20110929-1500].}
{ERR}{1317301223}{FS4BS5}{Task [FS4BS5] has failed to backup version [20110929-1500] due to [failure to create snapshot].}
{INFO}{1317301560}{FS4BS5}{Task [FS4BS5] is creating backup version [20110929-1505].}
{ERR}{1317301582}{FS4BS5}{Task [FS4BS5] has failed to backup version [20110929-1505] due to [failure to create snapshot].}
{INFO}{1317302276}{FS4BS5}{Task [FS4BS5] is creating backup version [20110929-1517].}
{ERR}{1317302276}{FS4BS5}{Task [FS4BS5] has failed to backup version [20110929-1517] due to [failure to create snapshot].}
{INFO}{1317302336}{FS4BS5}{Task [FS4BS5] is creating backup version [20110929-1517].}
{ERR}{1317302336}{FS4BS5}{Task [FS4BS5] has failed to backup version [20110929-1517] due to [failure to create snapshot].}
{INFO}{1317304114}{FS4BS5}{Task [FS4BS5] is creating backup version [20110929-1547].}
{ERR}{1317304114}{FS4BS5}{Task [FS4BS5] has failed to backup version [20110929-1547] due to [failure to create snapshot].}
Liegt denn der Fehler auf der Daten- oder auf dem Backupsyno? An der Anmeldung kann es doch nicht liegen, obwohl es im Log steht.
Gruss Fab
Zuletzt bearbeitet: