2023-07-19 10:11:57: Started connection to SERVICE_COMMANDS
2023-07-19 10:11:57: ClientService cmd: #IfOfADJr37dzzDR1gDYOf#MBR driveletter=_dev_sda2&disk_path=%2Fdev%2Fsda2&image_full=1&running_jobs=1&token=nN5s49CSjUrt9a9w8ukw
2023-07-19 10:11:57: dl_devnum=a2
2023-07-19 10:11:57: gpt_style=true
2023-07-19 10:11:57: GUID partition table found
2023-07-19 10:11:57: GUID partition table size is 16 KB
2023-07-19 10:11:57: rc=0 hasError=true state=0
2023-07-19 10:11:57: SERVICE_COMMANDS finished
2023-07-19 10:11:57: Started connection to SERVICE_COMMANDS
2023-07-19 10:11:57: ClientService cmd: #IfOfADJr37dzzDR1gDYOf#FULL IMAGE letter=/dev/sda2&token=nN5s49CSjUrt9a9w8ukw&bitmap=1&status_id=4&running_jobs=1&zero_skipped=1
2023-07-19 10:11:57: Script "/usr/local/etc/urbackup/preimagebackup" does not exist
2023-07-19 10:11:57: Creating shadowcopy of "/dev/sda2"...
2023-07-19 10:11:57: Snapshot at //.urbackup_snaps/bff03a886a42bc6515059634f61a6c22b4e5d29dce9271c5 was already removed
2023-07-19 10:11:58: dattobd_create_snapshot called as sh -c /usr/local/share/urbackup/dattobd_create_snapshot 06d5c23f897942507d3789441ce141b33991932e9ef714a0 "/" "/dev/sda2" "/dev/sda2" 2>&1
2023-07-19 10:11:58: SNAP_ID=06d5c23f897942507d3789441ce141b33991932e9ef714a0
2023-07-19 10:11:58: SNAP_MOUNTPOINT=/
2023-07-19 10:11:58: SNAP_DEST=/mnt/urbackup_snaps/06d5c23f897942507d3789441ce141b33991932e9ef714a0
2023-07-19 10:11:58: SNAP_MOUNTPOINT_SAN=_
2023-07-19 10:11:58: SNAP_NUM_PATH=/mnt/urbackup_snaps/cbt_info/_-snapdev
2023-07-19 10:11:58: SNAP_COWFILE_PATH=/mnt/urbackup_snaps/cbt_info/_-cowfile
2023-07-19 10:11:58: DEVICE=/dev/sda2
2023-07-19 10:11:58: TYPE=btrfs
2023-07-19 10:11:58: btrfs_create_filesystem_snapshot START
2023-07-19 10:11:58: SNAP_ID=06d5c23f897942507d3789441ce141b33991932e9ef714a0
2023-07-19 10:11:58: SNAP_MOUNTPOINT=/
2023-07-19 10:11:58: SNAP_NAME=/dev/sda2
2023-07-19 10:11:58: SNAP_ORIG_PATH=/dev/sda2
2023-07-19 10:11:58: TYPE == btrfs
2023-07-19 10:11:58: btrfs snapshot command is: btrfs subvolume snapshot -r / //.urbackup_snaps/06d5c23f897942507d3789441ce141b33991932e9ef714a0
2023-07-19 10:11:58: Create a readonly snapshot of '/' in '//.urbackup_snaps/06d5c23f897942507d3789441ce141b33991932e9ef714a0'
2023-07-19 10:11:58: btrfs_create_filesystem_snapshot FINISHED
2023-07-19 10:11:58: exiting with RESULT=0
2023-07-19 10:11:58: Shadowcopy path: //.urbackup_snaps/06d5c23f897942507d3789441ce141b33991932e9ef714a0
2023-07-19 10:11:58: done.
2023-07-19 10:11:58: Disabling CBT on volume "/dev/sda2"
2023-07-19 10:11:58: ERROR: Error reading device file name from //.urbackup_snaps/06d5c23f897942507d3789441ce141b33991932e9ef714a0-dev
2023-07-19 10:11:58: ERROR: Opening filesystem on device failed. Stopping.
2023-07-19 10:11:58: Device file: "//.urbackup_snaps/06d5c23f897942507d3789441ce141b33991932e9ef714a0"
2023-07-19 10:11:58: Sending full image done
2023-07-19 10:11:58: Removing running process (1) id 1 server_id 4 token nN5s49CSjUrt9a9w8ukw action 3
2023-07-19 10:11:58: SERVICE_COMMANDS finished
2023-07-19 10:11:58: Started connection to SERVICE_COMMANDS
2023-07-19 10:11:58: ClientService cmd: #IfOfADJr37dzzDR1gDYOf#2PING RUNNING pc_done=0&status_id=4&speed_bpms=0&total_bytes=-1&done_bytes=0&paused_fb=1#token=nN5s49CSjUrt9a9w8ukw
2023-07-19 10:11:59: Started connection to SERVICE_COMMANDS
2023-07-19 10:11:59: ClientService cmd: #IfOfADJr37dzzDR1gDYOf#2LOGDATA 1689750718 0-1689750717-Starting unscheduled full image backup of volume "/dev/sda2"...
2-1689750718-Request of image backup failed. Reason: Opening filesystem on device failed. Stopping.
0-1689750718-Transferred 749 bytes - Average speed: 72.192 KBit/s
0-1689750718-Time taken for backing up client bogdan-ubuntu: 103ms
2-1689750718-Backup failed

2023-07-19 10:11:59: rc=0 hasError=true state=0
2023-07-19 10:11:59: SERVICE_COMMANDS finished