Code: Select all
[error] Failed to perform backup
[error] XML error: [Error reading Att...
[error] Failed to prepare job
[error] Processing finished with erro...
Code: Select all
[30.05.2019 10:35:50] <140408954984320> cli | Initializing new log filter.
[30.05.2019 10:35:50] <140408954984320> | ====================================================================================
[30.05.2019 10:35:50] <140408954984320> lpb | {
[30.05.2019 10:35:50] <140408954984320> lpb | Veeam Agent for Linux: veeamjobman.
[30.05.2019 10:35:50] <140408954984320> lpb | Version: 3.0.1.1046
[30.05.2019 10:35:50] <140408954984320> lpb | PID: 2378
[30.05.2019 10:35:50] <140408954984320> vmb | hostname: nextcloud
[30.05.2019 10:35:50] <140408954984320> vmb | uname
[30.05.2019 10:35:50] <140408954984320> vmb | sysname : Linux
[30.05.2019 10:35:50] <140408954984320> vmb | release : 4.15.0-50-generic
[30.05.2019 10:35:50] <140408954984320> vmb | version : #54~16.04.1-Ubuntu SMP Wed May 8 15:55:19 UTC 2019
[30.05.2019 10:35:50] <140408954984320> vmb | machine : x86_64
[30.05.2019 10:35:50] <140408954984320> lpb | }
[30.05.2019 10:35:50] <140408954984320> lpbcore| Connecting to veeamservice...
[30.05.2019 10:35:50] <140408954984320> | Configuration load.
[30.05.2019 10:35:50] <140408954984320> | Configuration load. ok.
[30.05.2019 10:35:50] <140408954984320> lpbcore| Connecting to veeamservice... ok.
[30.05.2019 10:35:50] <140408954984320> lpbman | Main thread has started.
[30.05.2019 10:35:50] <140408954984320> lpbcore| No license installed.
[30.05.2019 10:35:50] <140408954984320> lpbcore| LpbManSession: Processing commands.
[30.05.2019 10:35:50] <140408954984320> lpbcore| Sending PID: [2378].
[30.05.2019 10:35:50] <140408954984320> lpbcore| Sending Session UUID: [{a39f79f0-2ca1-4ae7-a25f-48ca9513f86c}].
[30.05.2019 10:35:50] <140408954984320> lpbcore| Waiting for a command.
[30.05.2019 10:35:50] <140408954984320> lpbcore| LpbManSession: Starting backup job.
[30.05.2019 10:35:50] <140408954984320> lpbcore| Job UUID: [{bc9642ab-37c4-463f-b274-85d54331a3d7}] (normal priority).
[30.05.2019 10:35:50] <140408954984320> lpbcore| Is active full? [false].
[30.05.2019 10:35:50] <140408954984320> lpbcore| Is snapshot required? [true].
[30.05.2019 10:35:50] <140408954984320> lpbcore| System information:
[30.05.2019 10:35:50] <140408954984320> lpbcore| Running [lsb_release -a].
[30.05.2019 10:35:50] <140408954984320> lpbcore| Distributor ID: Ubuntu
[30.05.2019 10:35:50] <140408954984320> lpbcore| Description: Ubuntu 16.04.6 LTS
[30.05.2019 10:35:50] <140408954984320> lpbcore| Release: 16.04
[30.05.2019 10:35:50] <140408954984320> lpbcore| Codename: xenial
[30.05.2019 10:35:50] <140408954984320> lpbcore| Running [cat /etc/*release].
[30.05.2019 10:35:50] <140408954984320> lpbcore| DISTRIB_ID=Ubuntu
[30.05.2019 10:35:50] <140408954984320> lpbcore| DISTRIB_RELEASE=16.04
[30.05.2019 10:35:50] <140408954984320> lpbcore| DISTRIB_CODENAME=xenial
[30.05.2019 10:35:50] <140408954984320> lpbcore| DISTRIB_DESCRIPTION="Ubuntu 16.04.6 LTS"
[30.05.2019 10:35:50] <140408954984320> lpbcore| NAME="Ubuntu"
[30.05.2019 10:35:50] <140408954984320> lpbcore| VERSION="16.04.6 LTS (Xenial Xerus)"
[30.05.2019 10:35:50] <140408954984320> lpbcore| ID=ubuntu
[30.05.2019 10:35:50] <140408954984320> lpbcore| ID_LIKE=debian
[30.05.2019 10:35:50] <140408954984320> lpbcore| PRETTY_NAME="Ubuntu 16.04.6 LTS"
[30.05.2019 10:35:50] <140408954984320> lpbcore| VERSION_ID="16.04"
[30.05.2019 10:35:50] <140408954984320> lpbcore| HOME_URL="http://www.ubuntu.com/"
[30.05.2019 10:35:50] <140408954984320> lpbcore| SUPPORT_URL="http://help.ubuntu.com/"
[30.05.2019 10:35:50] <140408954984320> lpbcore| BUG_REPORT_URL="http://bugs.launchpad.net/ubuntu/"
[30.05.2019 10:35:50] <140408954984320> lpbcore| VERSION_CODENAME=xenial
[30.05.2019 10:35:50] <140408954984320> lpbcore| UBUNTU_CODENAME=xenial
[30.05.2019 10:35:50] <140408954984320> lpbcore| Running [lsblk].
[30.05.2019 10:35:50] <140408954984320> lpbcore| NAME MAJ:MIN RM SIZE RO TYPE MOUNTPOINT
[30.05.2019 10:35:50] <140408954984320> lpbcore| sr0 11:0 1 1024M 0 rom
[30.05.2019 10:35:50] <140408954984320> lpbcore| sda 8:0 0 1000G 0 disk
[30.05.2019 10:35:50] <140408954984320> lpbcore| ├─sda2 8:2 0 991.6G 0 part /
[30.05.2019 10:35:50] <140408954984320> lpbcore| ├─sda3 8:3 0 7.9G 0 part [SWAP]
[30.05.2019 10:35:50] <140408954984320> lpbcore| └─sda1 8:1 0 512M 0 part /boot/efi
[30.05.2019 10:35:50] <140408954984320> lpbcore| LpbManSession: Starting backup job. ok.
[30.05.2019 10:35:50] <140408921556736> | Thread started. Thread id: 140408921556736, parent id: 140408954984320, role: Volume backup job execution
[30.05.2019 10:35:50] <140408921556736> lpbcore| BackupJobPerformer: Creating backup.
[30.05.2019 10:35:50] <140408921556736> lpbcore| Job information:
[30.05.2019 10:35:50] <140408921556736> lpbcore| Job name: [Backup-Name]. ID: [{bc9642ab-37c4-463f-b274-85d54331a3d7}].
[30.05.2019 10:35:50] <140408921556736> lpbcore| Job source:
[30.05.2019 10:35:50] <140408921556736> lpbcore| Included [All System] .
[30.05.2019 10:35:50] <140408921556736> lpbcore| Job destination:
[30.05.2019 10:35:50] <140408921556736> lpbcore| Target repository [Repository_1] ID [{34b2397d-78c6-4611-80d7-d5ae7ff7fd76}].
[30.05.2019 10:35:50] <140408921556736> lpbcore| Shared folder repository address: [10.0.0.249:/volume1/Backup].
[30.05.2019 10:35:50] <140408921556736> lpbcore| Job options:
[30.05.2019 10:35:50] <140408921556736> lpbcore| Compression: [Lz4]
[30.05.2019 10:35:50] <140408921556736> lpbcore| Block size: [KbBlockSize1024]
[30.05.2019 10:35:50] <140408921556736> lpbcore| Retention max points: [10].
[30.05.2019 10:35:50] <140408921556736> lpbcore| Pre-freeze: []
[30.05.2019 10:35:50] <140408921556736> lpbcore| Post-thaw: []
[30.05.2019 10:35:50] <140408921556736> lpbcore| Pre-job: []
[30.05.2019 10:35:50] <140408921556736> lpbcore| Post-job: []
[30.05.2019 10:35:50] <140408921556736> lpbcore| IsSnapshotRequired: [true].
[30.05.2019 10:35:50] <140408921556736> lpbcore| Retry count: [0]
[30.05.2019 10:35:50] <140408921556736> lpbcore| Retry delay (ms): [600000]
[30.05.2019 10:35:50] <140408921556736> lpbcore| Indexing: File system indexing is disabled.
[30.05.2019 10:35:50] <140408921556736> lpbcore| Schedule: Enabled; Every Mon, Tue, Wed, Thu, Fri at 06:00.
[30.05.2019 10:35:50] <140408921556736> lpbcore| Active full schedule: Disabled; Every 1 day of every month.
[30.05.2019 10:35:50] <140408921556736> | Creating child process: /usr/sbin/veeamagentid with arguments: /usr/sbin/veeamagentid, --log, /var/log/veeamagentid.log, /usr/sbin/veeamagentid
[30.05.2019 10:35:50] <140408921556736> lpbcore| Creating repository database accessor for local database.
[30.05.2019 10:35:50] <140408921556736> vmb | Found current backup for job, backup id {2cbc837c-801c-425a-9cb8-a3d18b41658f}.
[30.05.2019 10:35:50] <140408921556736> vmb | Reimporting backup [nextcloud Backup-Name/Backup-Name.vbm].
[30.05.2019 10:35:50] <140408921556736> vmb | Backup in repository [{34b2397d-78c6-4611-80d7-d5ae7ff7fd76}].
[30.05.2019 10:35:50] <140408921556736> vmb | Importing backup [nextcloud Backup-Name/Backup-Name.vbm].
[30.05.2019 10:35:50] <140408921556736> vmb | Existing backup record will be removed from the database.
[30.05.2019 10:35:50] <140408921556736> vmb | WARN|OIB [{095175e9-0f7d-4310-94ab-17133f20e6ee}] has no 'product_is_rental_license' flag.
[30.05.2019 10:35:50] <140408921556736> vmb | Importing backup [nextcloud Backup-Name/Backup-Name.vbm]. Failed.
[30.05.2019 10:35:50] <140408921556736> vmb | Reimporting backup [nextcloud Backup-Name/Backup-Name.vbm]. Failed.
[30.05.2019 10:35:50] <140408921556736> lpbcore| BackupJobPerformer: Creating backup. Failed.
[30.05.2019 10:35:50] <140408921556736> vmb | [SessionLog][error] Failed to perform backup.
[30.05.2019 10:35:50] <140408921556736> vmb | [SessionLog][error] XML error: [Error reading Attributes.]. Error code: [7].
[30.05.2019 10:35:50] <140408921556736> vmb | [SessionLog][error] Failed to prepare job.
[30.05.2019 10:35:50] <140408921556736> vmb | [SessionLog][error] Processing finished with errors at 2019-05-30 10:35:50 GMT.
[30.05.2019 10:35:50] <140408921556736> lpbcore| ERR |XML error: [Error reading Attributes.]. Error code: [7].
[30.05.2019 10:35:50] <140408921556736> lpbcore| >> |--tr:Failed to parse XML content. Source content: [<GuestInfo><Property Name="GuestOsName"><Value>Linux nextcloud 4.15.0-42-generic #45~16.04.1-Ubuntu SMP Mon Nov 19 13:02:27 UTC ..., length: 649].
[30.05.2019 10:35:50] <140408921556736> lpbcore| >> |--tr:Unable to convert GuestInfo from Vbm xml string.
[30.05.2019 10:35:50] <140408921556736> lpbcore| >> |--tr:OibSensitiveInfoScope: Unable to find oib sensitive info by id.
[30.05.2019 10:35:50] <140408921556736> lpbcore| >> |--tr:OibScope: Unable to get OIBs by Point id [{f3fb8dbe-06b9-49d5-b0a4-e6566519a07f}].
[30.05.2019 10:35:50] <140408921556736> lpbcore| >> |--tr:Failed to get objects in backup for point.
[30.05.2019 10:35:50] <140408921556736> lpbcore| >> |--tr:Failed to delete backup point {f3fb8dbe-06b9-49d5-b0a4-e6566519a07f}.
[30.05.2019 10:35:50] <140408921556736> lpbcore| >> |--tr:Failed to delete backup {2cbc837c-801c-425a-9cb8-a3d18b41658f}.
[30.05.2019 10:35:50] <140408921556736> lpbcore| >> |Failed to prepare job
[30.05.2019 10:35:50] <140408921556736> lpbcore| >> |Backup job has failed.
[30.05.2019 10:35:50] <140408921556736> lpbcore| >> |An exception was thrown from thread [140408921556736].
[30.05.2019 10:35:50] <140408954984320> | Closing socket device.
[30.05.2019 10:35:50] <140408954984320> lpbcore| LpbManSession: Processing commands. ok.
[30.05.2019 10:35:50] <140408954984320> | Closing socket device.
[30.05.2019 10:35:50] <140408921556736> lpbcore| JOB STATUS: FAILED.
[30.05.2019 10:35:50] <140408921556736> | Thread finished. Role: 'Volume backup job execution'.
[30.05.2019 10:35:50] <140408954984320> | Closing socket device.
[30.05.2019 10:35:50] <140408954984320> | Closing socket device.
[30.05.2019 10:35:50] <140408954984320> lpbman | Application session has been finished.
- ubuntu box is running a a hyper v guest on Server 2012R2
- Backup destination is a Synology NAS via NFS