2020-11-26 06:12:06.938591221 Relax-and-Recover 2.5 / Git 2020-11-26 06:12:06.939755892 Running rear recover (PID 393) 2020-11-26 06:12:06.940905105 Command line options: /bin/rear -v recover 2020-11-26 06:12:06.941730016 Using log file: /var/log/rear/rear-snigdhacentos32.log 2020-11-26 06:12:06.943242980 Including /etc/rear/os.conf 2020-11-26 06:12:06.945312604 Including conf/Linux-i386.conf 2020-11-26 06:12:06.946276004 Including conf/GNU/Linux.conf 2020-11-26 06:12:06.951890172 Including /etc/rear/local.conf /etc/rear/local.conf: line 11: /etc/rear/path.txt: No such file or directory /etc/rear/local.conf: line 11: /etc/rear/path.txt: No such file or directory 393: 2020-11-26 06:12:06.954469557 Including /etc/rear/rescue.conf 393: 2020-11-26 06:12:06.956863070 ====================== 393: 2020-11-26 06:12:06.957647339 Running 'init' stage 393: 2020-11-26 06:12:06.958471047 ====================== 393: 2020-11-26 06:12:06.964595968 Including init/default/005_verify_os_conf.sh 393: 2020-11-26 06:12:07.020702925 Including init/default/010_EFISTUB_check.sh 393: 2020-11-26 06:12:07.023232547 Including init/default/010_set_drlm_env.sh 393: 2020-11-26 06:12:07.025319413 Including init/default/030_update_recovery_system.sh 393: 2020-11-26 06:12:07.027444416 Including init/default/050_check_rear_recover_mode.sh 393: 2020-11-26 06:12:07.028301412 Running workflow recover within the ReaR rescue/recovery system 393: 2020-11-26 06:12:07.031686154 Including init/default/950_check_missing_programs.sh 393: 2020-11-26 06:12:07.035854544 Finished running 'init' stage in 1 seconds 393: 2020-11-26 06:12:07.038696414 Using build area '/tmp/rear.9e6jf1d7uJRDoAN' mkdir: created directory '/tmp/rear.9e6jf1d7uJRDoAN/rootfs' mkdir: created directory '/tmp/rear.9e6jf1d7uJRDoAN/tmp' 393: 2020-11-26 06:12:07.040709268 Running recover workflow 393: 2020-11-26 06:12:07.041418956 ====================== 393: 2020-11-26 06:12:07.042248600 Running 'setup' stage 393: 2020-11-26 06:12:07.042949641 ====================== 393: 2020-11-26 06:12:07.048776930 Including setup/default/002_clean_start.sh 393: 2020-11-26 06:12:07.051002185 Including setup/default/005_ssh_agent_start.sh 393: 2020-11-26 06:12:07.053104419 Starting up ssh-agent Agent pid 622 /usr/share/rear/setup/default/005_ssh_agent_start.sh: line 16: /root/.ssh/config: No such file or directory 393: 2020-11-26 06:12:07.058381508 Including setup/default/010_pre_recovery_script.sh 393: 2020-11-26 06:12:07.059096250 Finished running 'setup' stage in 0 seconds 393: 2020-11-26 06:12:07.060029668 ====================== 393: 2020-11-26 06:12:07.060683876 Running 'verify' stage 393: 2020-11-26 06:12:07.061329678 ====================== 393: 2020-11-26 06:12:07.067597498 Including verify/default/020_cciss_scsi_engage.sh 393: 2020-11-26 06:12:07.070318226 Including verify/default/020_translate_url.sh 393: 2020-11-26 06:12:07.072644708 Including verify/default/030_translate_tape.sh 393: 2020-11-26 06:12:07.076103781 Including verify/default/040_validate_variables.sh 393: 2020-11-26 06:12:07.078376601 Including verify/default/050_create_mappings_dir.sh 393: 2020-11-26 06:12:07.080475986 Including verify/RSYNC/default/050_prep_rsync.sh 393: 2020-11-26 06:12:07.084222626 Including verify/GNU/Linux/050_sane_recovery_check.sh 393: 2020-11-26 06:12:07.086678921 Including verify/RSYNC/default/100_check_rsync.sh 393: 2020-11-26 06:12:07.093831363 Skipping ping test 393: 2020-11-26 06:12:07.094845471 Test: rsync --sparse --archive --hard-links --numeric-ids --stats -z --progress --password-file=/etc/rear/rsync_pass rsync://diskimage@192.168.1.123:1873/ 393: 2020-11-26 06:12:07.118141994 Including verify/RSYNC/default/150_check_rsync_protocol_version.sh 393: 2020-11-26 06:12:07.119094536 Remote rsync system (192.168.1.123) uses rsync protocol version 29 (overruled by user) /usr/share/rear/verify/RSYNC/default/150_check_rsync_protocol_version.sh: line 48: [: too many arguments 393: 2020-11-26 06:12:07.120176711 Warning: rsync --fake-super not possible on system (192.168.1.123) (please upgrade rsync to 3.x) 393: 2020-11-26 06:12:07.122659252 Including verify/GNU/Linux/230_storage_and_network_modules.sh 393: 2020-11-26 06:12:07.123701514 Including storage drivers 393: 2020-11-26 06:12:07.128074183 Including network drivers 393: 2020-11-26 06:12:07.132987425 Including crypto drivers 393: 2020-11-26 06:12:07.136092220 Including virtualization drivers 393: 2020-11-26 06:12:07.138811419 Including additional drivers 393: 2020-11-26 06:12:07.142906478 Including verify/GNU/Linux/260_recovery_storage_drivers.sh 393: 2020-11-26 06:12:07.262550749 No driver migration: '/tmp/rear.9e6jf1d7uJRDoAN/tmp/storage_drivers' and '/var/lib/rear/recovery/storage_drivers' are the same 393: 2020-11-26 06:12:07.264729695 Including verify/RSYNC/default/550_check_remote_backup_archive.sh 393: 2020-11-26 06:12:07.265682212 User Name : diskimage 393: 2020-11-26 06:12:07.267084821 Enter your password : 393: 2020-11-26 06:12:10.623747967 Including verify/RSYNC/GNU/Linux/600_check_rsync_xattr.sh 393: 2020-11-26 06:12:10.624587829 Finished running 'verify' stage in 3 seconds 393: 2020-11-26 06:12:10.625267468 ====================== 393: 2020-11-26 06:12:10.625914236 Running 'layout/prepare' stage 393: 2020-11-26 06:12:10.626545096 ====================== 393: 2020-11-26 06:12:10.632957743 Including layout/prepare/default/010_prepare_files.sh 393: 2020-11-26 06:12:10.636929735 Including layout/prepare/GNU/Linux/100_include_partition_code.sh 393: 2020-11-26 06:12:10.645274454 Including layout/prepare/GNU/Linux/110_include_lvm_code.sh 393: 2020-11-26 06:12:10.653130518 Including layout/prepare/GNU/Linux/120_include_raid_code.sh /usr/share/rear/lib/_input-output-functions.sh: line 476: type: mdadm: not found 393: 2020-11-26 06:12:10.655378295 Including layout/prepare/GNU/Linux/131_include_filesystem_code.sh 393: 2020-11-26 06:12:10.660447295 Including layout/prepare/GNU/Linux/133_include_mount_filesystem_code.sh 393: 2020-11-26 06:12:10.663870171 Including layout/prepare/GNU/Linux/135_include_btrfs_subvolumes_generic_code.sh 393: 2020-11-26 06:12:10.666968362 Including layout/prepare/GNU/Linux/136_include_btrfs_subvolumes_SLES_code.sh 393: 2020-11-26 06:12:10.672597830 Including layout/prepare/GNU/Linux/140_include_swap_code.sh 393: 2020-11-26 06:12:10.678429150 Including layout/prepare/GNU/Linux/150_include_drbd_code.sh 393: 2020-11-26 06:12:10.680777861 Including layout/prepare/GNU/Linux/160_include_luks_code.sh 393: 2020-11-26 06:12:10.683411018 Including layout/prepare/GNU/Linux/170_include_hpraid_code.sh /usr/share/rear/lib/_input-output-functions.sh: line 476: type: hpacucli: not found /usr/share/rear/lib/_input-output-functions.sh: line 476: type: hpssacli: not found /usr/share/rear/lib/_input-output-functions.sh: line 476: type: ssacli: not found 393: 2020-11-26 06:12:10.686059957 Including layout/prepare/GNU/Linux/180_include_opaldisk_code.sh 393: 2020-11-26 06:12:10.688736186 Including layout/prepare/default/200_recreate_hpraid.sh 393: 2020-11-26 06:12:10.691613659 Including layout/prepare/GNU/Linux/210_load_multipath.sh 393: 2020-11-26 06:12:10.695103845 Including layout/prepare/default/250_compare_disks.sh 393: 2020-11-26 06:12:10.700163076 Comparing disks 393: 2020-11-26 06:12:10.709296530 Comparing sda 393: 2020-11-26 06:12:10.710167454 Device /sys/block/sda exists 393: 2020-11-26 06:12:10.712175780 Device sda has expected (same) size 536870912000 bytes (will be used for 'recover') 393: 2020-11-26 06:12:10.714297180 Disk configuration looks identical 393: 2020-11-26 06:12:10.716625117 UserInput: called in /usr/share/rear/layout/prepare/default/250_compare_disks.sh line 148 393: 2020-11-26 06:12:10.719029428 UserInput: No choices specified 393: 2020-11-26 06:12:10.720067421 Proceed with 'recover' (yes) otherwise manual disk layout configuration is enforced 393: 2020-11-26 06:12:10.721867757 (default 'yes' timeout 30 seconds) 393: 2020-11-26 06:12:11.716645203 UserInput: 'read' got as user input '' 393: 2020-11-26 06:12:11.719804461 User confirmed to proceed with 'recover' 393: 2020-11-26 06:12:11.722877956 Including layout/prepare/default/270_overrule_migration_mode.sh 393: 2020-11-26 06:12:11.725236112 Including layout/prepare/default/299_custom_partition.sh 393: 2020-11-26 06:12:11.729058989 Including layout/prepare/default/300_map_disks.sh 393: 2020-11-26 06:12:11.731427163 Including layout/prepare/default/310_remove_exclusions.sh 393: 2020-11-26 06:12:11.733619560 Including layout/prepare/default/320_apply_mappings.sh 393: 2020-11-26 06:12:11.736098951 Including layout/prepare/default/420_autoresize_last_partitions.sh 393: 2020-11-26 06:12:11.738989349 Including layout/prepare/default/430_autoresize_all_partitions.sh 393: 2020-11-26 06:12:11.741247772 Including layout/prepare/default/500_confirm_layout_file.sh 393: 2020-11-26 06:12:11.743417704 Including layout/prepare/default/510_list_dependencies.sh 393: 2020-11-26 06:12:11.777828986 Including layout/prepare/default/520_exclude_components.sh 393: 2020-11-26 06:12:11.781309769 Including layout/prepare/default/540_generate_device_code.sh 393: 2020-11-26 06:12:11.789076994 thisdev ************** /dev/sda 393: 2020-11-26 06:12:11.789998511 deps ***************** 393: 2020-11-26 06:12:11.844381006 thisdev ************** /dev/sda1 393: 2020-11-26 06:12:11.845216802 deps ***************** /dev/sda 393: 2020-11-26 06:12:11.855822556 thisdev ************** /dev/sda2 393: 2020-11-26 06:12:11.856677772 deps ***************** /dev/sda 393: 2020-11-26 06:12:11.867321082 thisdev ************** /dev/sda3 393: 2020-11-26 06:12:11.868174658 deps ***************** /dev/sda 393: 2020-11-26 06:12:11.879078723 thisdev ************** /dev/sda4 393: 2020-11-26 06:12:11.879941939 deps ***************** /dev/sda 393: 2020-11-26 06:12:11.890170116 thisdev ************** /dev/sda5 393: 2020-11-26 06:12:11.890988427 deps ***************** /dev/sda 393: 2020-11-26 06:12:11.901382264 thisdev ************** fs:/boot 393: 2020-11-26 06:12:11.902232070 deps ***************** /dev/sda1 393: 2020-11-26 06:12:11.907101752 thisdev ************** fs:/ 393: 2020-11-26 06:12:11.907934454 deps ***************** /dev/sda2 393: 2020-11-26 06:12:11.912128008 Begin create_fs( fs:/ ) 393: 2020-11-26 06:12:11.912948003 Begin fs Deviceo --- / 393: 2020-11-26 06:12:11.913677058 Begin fs Device --- / 393: 2020-11-26 06:12:11.914476372 Grep ---- Data :: ( grep "^fs.* / " "/var/lib/rear/layout/disklayout.conf" ) 393: 2020-11-26 06:12:11.917108376 Begin fs mount --- / 393: 2020-11-26 06:12:11.919773106 Begin generating code to create XFS on /dev/sda2 ... 393: 2020-11-26 06:12:11.922868451 Parsing sda2 mkfs.xfs options from /var/lib/rear/layout/xfs/sda2.xfs 393: 2020-11-26 06:12:12.028020333 Using sda2 mkfs.xfs options: -i size=512 -d agcount=4 -s size=512 -i attr=2 -i projid32bit=1 -m crc=1 -m finobt=0 -b size=4096 -i maxpct=25 -d sunit=0 -d swidth=0 -l version=2 -l lazy-count=1 -n size=4096 -n version=2 -r extsize=4096 393: 2020-11-26 06:12:12.029796063 End of generating code to create XFS on /dev/sda2 393: 2020-11-26 06:12:12.032158172 End fs mount --- / 393: 2020-11-26 06:12:12.033062350 Begin mount_fs( / ) 393: 2020-11-26 06:12:12.036184574 create_fs ---- device --- /dev/sda2 393: 2020-11-26 06:12:12.039454367 create_fs ---- mountPoint --- / 393: 2020-11-26 06:12:12.040362216 Attributes --------- options=rw,relatime,attr2,inode64,noquota 393: 2020-11-26 06:12:12.041190148 name ------------------ options 393: 2020-11-26 06:12:12.042006583 Value ------------------ rw,relatime,attr2,inode64,noquota 393: 2020-11-26 06:12:12.042851000 mountopts -------- rw,relatime,attr2,inode64,noquota 393: 2020-11-26 06:12:12.044053840 End mount_fs( / ) 393: 2020-11-26 06:12:12.044882793 End create_fs( fs:/ ) 393: 2020-11-26 06:12:12.052812487 thisdev ************** fs:/boot 393: 2020-11-26 06:12:12.053664971 deps ***************** /dev/sda1 393: 2020-11-26 06:12:12.058297287 Begin create_fs( fs:/boot ) 393: 2020-11-26 06:12:12.059126251 Begin fs Deviceo --- /boot 393: 2020-11-26 06:12:12.060090383 Begin fs Device --- /boot 393: 2020-11-26 06:12:12.061008701 Grep ---- Data :: ( grep "^fs.* /boot " "/var/lib/rear/layout/disklayout.conf" ) 393: 2020-11-26 06:12:12.063787703 Begin fs mount --- /boot 393: 2020-11-26 06:12:12.066531344 Begin generating code to create XFS on /dev/sda1 ... 393: 2020-11-26 06:12:12.069927758 Parsing sda1 mkfs.xfs options from /var/lib/rear/layout/xfs/sda1.xfs 393: 2020-11-26 06:12:12.180696819 Using sda1 mkfs.xfs options: -i size=512 -d agcount=4 -s size=512 -i attr=2 -i projid32bit=1 -m crc=1 -m finobt=0 -b size=4096 -i maxpct=25 -d sunit=0 -d swidth=0 -l version=2 -l lazy-count=1 -n size=4096 -n version=2 -r extsize=4096 393: 2020-11-26 06:12:12.182100168 End of generating code to create XFS on /dev/sda1 393: 2020-11-26 06:12:12.184357472 End fs mount --- /boot 393: 2020-11-26 06:12:12.185244847 Begin mount_fs( /boot ) 393: 2020-11-26 06:12:12.188395462 create_fs ---- device --- /dev/sda1 393: 2020-11-26 06:12:12.191578731 create_fs ---- mountPoint --- /boot 393: 2020-11-26 06:12:12.192397094 Attributes --------- options=rw,relatime,attr2,inode64,noquota 393: 2020-11-26 06:12:12.193229281 name ------------------ options 393: 2020-11-26 06:12:12.194031087 Value ------------------ rw,relatime,attr2,inode64,noquota 393: 2020-11-26 06:12:12.194881831 mountopts -------- rw,relatime,attr2,inode64,noquota 393: 2020-11-26 06:12:12.196094379 End mount_fs( /boot ) 393: 2020-11-26 06:12:12.196940390 End create_fs( fs:/boot ) 393: 2020-11-26 06:12:12.204533845 thisdev ************** fs:/home 393: 2020-11-26 06:12:12.205386437 deps ***************** /dev/sda5 393: 2020-11-26 06:12:12.210131436 Begin create_fs( fs:/home ) 393: 2020-11-26 06:12:12.210981187 Begin fs Deviceo --- /home 393: 2020-11-26 06:12:12.211814474 Begin fs Device --- /home 393: 2020-11-26 06:12:12.212645109 Grep ---- Data :: ( grep "^fs.* /home " "/var/lib/rear/layout/disklayout.conf" ) 393: 2020-11-26 06:12:12.215212550 Begin fs mount --- /home 393: 2020-11-26 06:12:12.217926611 Begin generating code to create XFS on /dev/sda5 ... 393: 2020-11-26 06:12:12.221769525 Parsing sda5 mkfs.xfs options from /var/lib/rear/layout/xfs/sda5.xfs 393: 2020-11-26 06:12:12.332304311 Using sda5 mkfs.xfs options: -i size=512 -d agcount=4 -s size=512 -i attr=2 -i projid32bit=1 -m crc=1 -m finobt=0 -b size=4096 -i maxpct=25 -d sunit=0 -d swidth=0 -l version=2 -l lazy-count=1 -n size=4096 -n version=2 -r extsize=4096 393: 2020-11-26 06:12:12.333703938 End of generating code to create XFS on /dev/sda5 393: 2020-11-26 06:12:12.335876259 End fs mount --- /home 393: 2020-11-26 06:12:12.336735641 Begin mount_fs( /home ) 393: 2020-11-26 06:12:12.339857643 create_fs ---- device --- /dev/sda5 393: 2020-11-26 06:12:12.343100470 create_fs ---- mountPoint --- /home 393: 2020-11-26 06:12:12.343948115 Attributes --------- options=rw,relatime,attr2,inode64,noquota 393: 2020-11-26 06:12:12.344777689 name ------------------ options 393: 2020-11-26 06:12:12.345616546 Value ------------------ rw,relatime,attr2,inode64,noquota 393: 2020-11-26 06:12:12.346481476 mountopts -------- rw,relatime,attr2,inode64,noquota 393: 2020-11-26 06:12:12.347702515 End mount_fs( /home ) 393: 2020-11-26 06:12:12.348558939 End create_fs( fs:/home ) 393: 2020-11-26 06:12:12.356274035 thisdev ************** fs:/home/osboxes/apps/a\\x20list 393: 2020-11-26 06:12:12.357145472 deps ***************** /dev/sdd1 393: 2020-11-26 06:12:12.362981284 thisdev ************** swap:/dev/sda3 393: 2020-11-26 06:12:12.364155995 deps ***************** /dev/sda3 393: 2020-11-26 06:12:12.376826442 thisdev ************** fs:/home/osboxes/apps/a\\x20list 393: 2020-11-26 06:12:12.377672372 deps ***************** /dev/sdd1 393: 2020-11-26 06:12:12.382324175 Including layout/prepare/default/550_finalize_script.sh 393: 2020-11-26 06:12:12.385377326 Including layout/prepare/default/600_show_unprocessed.sh 393: 2020-11-26 06:12:12.388102720 No code has been generated to recreate fs:/home/osboxes/apps/ax20list (fs) 393: 2020-11-26 06:12:12.389580982 To recreate fs:/home/osboxes/apps/ax20list (fs) manually add code to /var/lib/rear/layout/diskrestore.sh or abort 393: 2020-11-26 06:12:12.395439437 UserInput: called in /usr/share/rear/layout/prepare/default/600_show_unprocessed.sh line 33 393: 2020-11-26 06:12:12.398194759 UserInput: Default input in choices - using choice number 4 as default input 393: 2020-11-26 06:12:12.399415301 Manually add code that recreates fs:/home/osboxes/apps/ax20list (fs) 393: 2020-11-26 06:12:12.400991302 1) View /var/lib/rear/layout/diskrestore.sh 393: 2020-11-26 06:12:12.402395620 2) Edit /var/lib/rear/layout/diskrestore.sh 393: 2020-11-26 06:12:12.403778759 3) Go to Relax-and-Recover shell 393: 2020-11-26 06:12:12.405153944 4) Continue 'rear recover' 393: 2020-11-26 06:12:12.407073312 5) Abort 'rear recover' 393: 2020-11-26 06:12:12.408419539 (default '4' timeout 300 seconds) 393: 2020-11-26 06:12:33.067980148 UserInput: 'read' got as user input '' 393: 2020-11-26 06:12:33.073280117 Including layout/prepare/default/610_exclude_from_restore.sh 393: 2020-11-26 06:12:33.074284246 Finished running 'layout/prepare' stage in 23 seconds 393: 2020-11-26 06:12:33.075066782 ====================== 393: 2020-11-26 06:12:33.075750517 Running 'layout/recreate' stage 393: 2020-11-26 06:12:33.081602918 ====================== 393: 2020-11-26 06:12:33.088487835 Including layout/recreate/default/100_confirm_layout_code.sh 393: 2020-11-26 06:12:33.091117842 Including layout/recreate/default/200_run_layout_code.sh 393: 2020-11-26 06:12:33.093875546 Start system layout restoration. +++ create_component /dev/sda disk +++ local device=/dev/sda +++ local type=disk +++ local touchfile=disk--dev-sda +++ '[' -e /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/disk--dev-sda ']' +++ return 0 +++ Log 'Stop mdadm' +++ echo '393: 2020-11-26 06:12:33.114070566 Stop mdadm' 393: 2020-11-26 06:12:33.114070566 Stop mdadm +++ grep -q md /proc/mdstat +++ Log 'Erasing MBR of disk /dev/sda' +++ echo '393: 2020-11-26 06:12:33.115684801 Erasing MBR of disk /dev/sda' 393: 2020-11-26 06:12:33.115684801 Erasing MBR of disk /dev/sda +++ dd if=/dev/zero of=/dev/sda bs=512 count=1 1+0 records in 1+0 records out 512 bytes (512 B) copied, 0.00198761 s, 258 kB/s +++ sync +++ create_disk_label /dev/sda msdos +++ '[' 0 == 1 ']' +++ local disk=/dev/sda label=msdos +++ [[ -n '' ]] +++ current_disk=/dev/sda +++ [[ -n '' ]] +++ disk_label=msdos +++ LogPrint 'Disk '\''/dev/sda'\'': creating '\''msdos'\'' partition table' +++ Log 'Disk '\''/dev/sda'\'': creating '\''msdos'\'' partition table' +++ echo '393: 2020-11-26 06:12:33.123861925 Disk '\''/dev/sda'\'': creating '\''msdos'\'' partition table' 393: 2020-11-26 06:12:33.123861925 Disk '/dev/sda': creating 'msdos' partition table +++ Print 'Disk '\''/dev/sda'\'': creating '\''msdos'\'' partition table' +++ parted -s /dev/sda mklabel msdos +++ my_udevsettle +++ has_binary udevadm +++ for bin in '$@' +++ type udevadm +++ return 0 +++ udevadm settle +++ return 0 +++ create_disk_partition /dev/sda primary 1 1048576 1074790399 +++ local disk=/dev/sda name=primary number=1 startB=1048576 endB=1074790399 +++ [[ -n /dev/sda ]] +++ [[ /dev/sda != \/\d\e\v\/\s\d\a ]] +++ current_disk=/dev/sda +++ [[ ! -n msdos ]] +++ '[' msdos == msdos ']' +++ [[ 1 -le last_partition_number ]] +++ [[ 0 -eq 0 ]] +++ LogPrint 'Disk '\''/dev/sda'\'': creating partition number 1 with name '\''primary'\''' +++ Log 'Disk '\''/dev/sda'\'': creating partition number 1 with name '\''primary'\''' +++ echo '393: 2020-11-26 06:12:33.139686389 Disk '\''/dev/sda'\'': creating partition number 1 with name '\''primary'\''' 393: 2020-11-26 06:12:33.139686389 Disk '/dev/sda': creating partition number 1 with name 'primary' +++ Print 'Disk '\''/dev/sda'\'': creating partition number 1 with name '\''primary'\''' +++ [[ ! -n 1074790399 ]] +++ parted -s /dev/sda mkpart primary 1048576B 1074790399B +++ my_udevsettle +++ has_binary udevadm +++ for bin in '$@' +++ type udevadm +++ return 0 +++ udevadm settle +++ return 0 +++ last_partition_number=1 +++ return 0 +++ my_udevsettle +++ has_binary udevadm +++ for bin in '$@' +++ type udevadm +++ return 0 +++ udevadm settle +++ return 0 +++ parted -s /dev/sda set 1 boot on +++ my_udevsettle +++ has_binary udevadm +++ for bin in '$@' +++ type udevadm +++ return 0 +++ udevadm settle +++ return 0 +++ create_disk_partition /dev/sda primary 2 1074790400 254477860863 +++ local disk=/dev/sda name=primary number=2 startB=1074790400 endB=254477860863 +++ [[ -n /dev/sda ]] +++ [[ /dev/sda != \/\d\e\v\/\s\d\a ]] +++ current_disk=/dev/sda +++ [[ ! -n msdos ]] +++ '[' msdos == msdos ']' +++ [[ 2 -le last_partition_number ]] +++ [[ 0 -eq 0 ]] +++ LogPrint 'Disk '\''/dev/sda'\'': creating partition number 2 with name '\''primary'\''' +++ Log 'Disk '\''/dev/sda'\'': creating partition number 2 with name '\''primary'\''' +++ echo '393: 2020-11-26 06:12:33.202922465 Disk '\''/dev/sda'\'': creating partition number 2 with name '\''primary'\''' 393: 2020-11-26 06:12:33.202922465 Disk '/dev/sda': creating partition number 2 with name 'primary' +++ Print 'Disk '\''/dev/sda'\'': creating partition number 2 with name '\''primary'\''' +++ [[ ! -n 254477860863 ]] +++ parted -s /dev/sda mkpart primary 1074790400B 254477860863B +++ my_udevsettle +++ has_binary udevadm +++ for bin in '$@' +++ type udevadm +++ return 0 +++ udevadm settle +++ return 0 +++ last_partition_number=2 +++ return 0 +++ create_disk_partition /dev/sda primary 3 254477860864 264141537279 +++ local disk=/dev/sda name=primary number=3 startB=254477860864 endB=264141537279 +++ [[ -n /dev/sda ]] +++ [[ /dev/sda != \/\d\e\v\/\s\d\a ]] +++ current_disk=/dev/sda +++ [[ ! -n msdos ]] +++ '[' msdos == msdos ']' +++ [[ 3 -le last_partition_number ]] +++ [[ 0 -eq 0 ]] +++ LogPrint 'Disk '\''/dev/sda'\'': creating partition number 3 with name '\''primary'\''' +++ Log 'Disk '\''/dev/sda'\'': creating partition number 3 with name '\''primary'\''' +++ echo '393: 2020-11-26 06:12:33.239990157 Disk '\''/dev/sda'\'': creating partition number 3 with name '\''primary'\''' 393: 2020-11-26 06:12:33.239990157 Disk '/dev/sda': creating partition number 3 with name 'primary' +++ Print 'Disk '\''/dev/sda'\'': creating partition number 3 with name '\''primary'\''' +++ [[ ! -n 264141537279 ]] +++ parted -s /dev/sda mkpart primary 254477860864B 264141537279B +++ my_udevsettle +++ has_binary udevadm +++ for bin in '$@' +++ type udevadm +++ return 0 +++ udevadm settle +++ return 0 +++ last_partition_number=3 +++ return 0 +++ create_disk_partition /dev/sda extended 4 264141537280 536870911999 +++ local disk=/dev/sda name=extended number=4 startB=264141537280 endB=536870911999 +++ [[ -n /dev/sda ]] +++ [[ /dev/sda != \/\d\e\v\/\s\d\a ]] +++ current_disk=/dev/sda +++ [[ ! -n msdos ]] +++ '[' msdos == msdos ']' +++ [[ 4 -le last_partition_number ]] +++ [[ 0 -eq 0 ]] +++ LogPrint 'Disk '\''/dev/sda'\'': creating partition number 4 with name '\''extended'\''' +++ Log 'Disk '\''/dev/sda'\'': creating partition number 4 with name '\''extended'\''' +++ echo '393: 2020-11-26 06:12:33.331239972 Disk '\''/dev/sda'\'': creating partition number 4 with name '\''extended'\''' 393: 2020-11-26 06:12:33.331239972 Disk '/dev/sda': creating partition number 4 with name 'extended' +++ Print 'Disk '\''/dev/sda'\'': creating partition number 4 with name '\''extended'\''' +++ [[ ! -n 536870911999 ]] +++ parted -s /dev/sda mkpart extended 264141537280B 536870911999B +++ my_udevsettle +++ has_binary udevadm +++ for bin in '$@' +++ type udevadm +++ return 0 +++ udevadm settle +++ return 0 +++ last_partition_number=4 +++ return 0 +++ create_disk_partition /dev/sda logical 5 264142585856 536870911999 +++ local disk=/dev/sda name=logical number=5 startB=264142585856 endB=536870911999 +++ [[ -n /dev/sda ]] +++ [[ /dev/sda != \/\d\e\v\/\s\d\a ]] +++ current_disk=/dev/sda +++ [[ ! -n msdos ]] +++ '[' msdos == msdos ']' +++ [[ 5 -le last_partition_number ]] +++ [[ 0 -eq 0 ]] +++ LogPrint 'Disk '\''/dev/sda'\'': creating partition number 5 with name '\''logical'\''' +++ Log 'Disk '\''/dev/sda'\'': creating partition number 5 with name '\''logical'\''' +++ echo '393: 2020-11-26 06:12:33.369484608 Disk '\''/dev/sda'\'': creating partition number 5 with name '\''logical'\''' 393: 2020-11-26 06:12:33.369484608 Disk '/dev/sda': creating partition number 5 with name 'logical' +++ Print 'Disk '\''/dev/sda'\'': creating partition number 5 with name '\''logical'\''' +++ [[ ! -n 536870911999 ]] +++ parted -s /dev/sda mkpart logical 264142585856B 536870911999B +++ my_udevsettle +++ has_binary udevadm +++ for bin in '$@' +++ type udevadm +++ return 0 +++ udevadm settle +++ return 0 +++ last_partition_number=5 +++ return 0 +++ sleep 1 +++ partprobe -s /dev/sda /dev/sda: msdos partitions 1 2 3 4 <5> +++ my_udevtrigger +++ has_binary udevadm +++ for bin in '$@' +++ type udevadm +++ return 0 +++ udevadm trigger +++ return 0 +++ my_udevsettle +++ has_binary udevadm +++ for bin in '$@' +++ type udevadm +++ return 0 +++ udevadm settle +++ return 0 +++ delete_dummy_partitions_and_resize_real_ones +++ [[ 0 -eq 0 ]] +++ partitions_to_resize=() +++ current_disk= +++ disk_label= +++ last_partition_number=0 +++ return 0 +++ component_created /dev/sda disk +++ local device=/dev/sda +++ local type=disk +++ local touchfile=disk--dev-sda +++ touch /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/disk--dev-sda +++ create_component /dev/sda1 part +++ local device=/dev/sda1 +++ local type=part +++ local touchfile=part--dev-sda1 +++ '[' -e /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/part--dev-sda1 ']' +++ return 0 +++ component_created /dev/sda1 part +++ local device=/dev/sda1 +++ local type=part +++ local touchfile=part--dev-sda1 +++ touch /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/part--dev-sda1 +++ create_component /dev/sda2 part +++ local device=/dev/sda2 +++ local type=part +++ local touchfile=part--dev-sda2 +++ '[' -e /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/part--dev-sda2 ']' +++ return 0 +++ component_created /dev/sda2 part +++ local device=/dev/sda2 +++ local type=part +++ local touchfile=part--dev-sda2 +++ touch /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/part--dev-sda2 +++ create_component /dev/sda3 part +++ local device=/dev/sda3 +++ local type=part +++ local touchfile=part--dev-sda3 +++ '[' -e /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/part--dev-sda3 ']' +++ return 0 +++ component_created /dev/sda3 part +++ local device=/dev/sda3 +++ local type=part +++ local touchfile=part--dev-sda3 +++ touch /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/part--dev-sda3 +++ create_component /dev/sda4 part +++ local device=/dev/sda4 +++ local type=part +++ local touchfile=part--dev-sda4 +++ '[' -e /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/part--dev-sda4 ']' +++ return 0 +++ component_created /dev/sda4 part +++ local device=/dev/sda4 +++ local type=part +++ local touchfile=part--dev-sda4 +++ touch /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/part--dev-sda4 +++ create_component /dev/sda5 part +++ local device=/dev/sda5 +++ local type=part +++ local touchfile=part--dev-sda5 +++ '[' -e /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/part--dev-sda5 ']' +++ return 0 +++ component_created /dev/sda5 part +++ local device=/dev/sda5 +++ local type=part +++ local touchfile=part--dev-sda5 +++ touch /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/part--dev-sda5 +++ create_component fs:/ fs +++ local device=fs:/ +++ local type=fs +++ local touchfile=fs-fs:- +++ '[' -e /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/fs-fs:- ']' +++ return 0 +++ my_udevsettle +++ has_binary udevadm +++ for bin in '$@' +++ type udevadm +++ return 0 +++ udevadm settle +++ return 0 +++ LogPrint 'Creating filesystem of type xfs with mount point / on /dev/sda2.' +++ Log 'Creating filesystem of type xfs with mount point / on /dev/sda2.' +++ echo '393: 2020-11-26 06:12:37.533674621 Creating filesystem of type xfs with mount point / on /dev/sda2.' 393: 2020-11-26 06:12:37.533674621 Creating filesystem of type xfs with mount point / on /dev/sda2. +++ Print 'Creating filesystem of type xfs with mount point / on /dev/sda2.' +++ wipefs --all --force /dev/sda2 /dev/sda2: 4 bytes were erased at offset 0x00000000 (xfs): 58 46 53 42 +++ mkfs.xfs -f -m uuid=a07bb3e9-eaa4-4930-8772-f473b3600452 -i size=512 -d agcount=4 -s size=512 -i attr=2 -i projid32bit=1 -m crc=1 -m finobt=0 -b size=4096 -i maxpct=25 -d sunit=0 -d swidth=0 -l version=2 -l lazy-count=1 -n size=4096 -n version=2 -r extsize=4096 /dev/sda2 meta-data=/dev/sda2 isize=512 agcount=4, agsize=15466496 blks = sectsz=512 attr=2, projid32bit=1 = crc=1 finobt=0, sparse=0 data = bsize=4096 blocks=61865984, imaxpct=25 = sunit=0 swidth=0 blks naming =version 2 bsize=4096 ascii-ci=0 ftype=1 log =internal log bsize=4096 blocks=30208, version=2 = sectsz=512 sunit=0 blks, lazy-count=1 realtime =none extsz=4096 blocks=0, rtextents=0 +++ LogPrint 'Mounting filesystem /' +++ Log 'Mounting filesystem /' +++ echo '393: 2020-11-26 06:12:38.968000941 Mounting filesystem /' 393: 2020-11-26 06:12:38.968000941 Mounting filesystem / +++ Print 'Mounting filesystem /' +++ mkdir -p /mnt/local/ +++ mount -o rw,relatime,attr2,inode64,noquota /dev/sda2 /mnt/local/ +++ component_created fs:/ fs +++ local device=fs:/ +++ local type=fs +++ local touchfile=fs-fs:- +++ touch /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/fs-fs:- +++ create_component fs:/boot fs +++ local device=fs:/boot +++ local type=fs +++ local touchfile=fs-fs:-boot +++ '[' -e /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/fs-fs:-boot ']' +++ return 0 +++ my_udevsettle +++ has_binary udevadm +++ for bin in '$@' +++ type udevadm +++ return 0 +++ udevadm settle +++ return 0 +++ LogPrint 'Creating filesystem of type xfs with mount point /boot on /dev/sda1.' +++ Log 'Creating filesystem of type xfs with mount point /boot on /dev/sda1.' +++ echo '393: 2020-11-26 06:12:39.235638270 Creating filesystem of type xfs with mount point /boot on /dev/sda1.' 393: 2020-11-26 06:12:39.235638270 Creating filesystem of type xfs with mount point /boot on /dev/sda1. +++ Print 'Creating filesystem of type xfs with mount point /boot on /dev/sda1.' +++ wipefs --all --force /dev/sda1 /dev/sda1: 4 bytes were erased at offset 0x00000000 (xfs): 58 46 53 42 +++ mkfs.xfs -f -m uuid=80621459-42df-40eb-b322-fbec94d045d8 -i size=512 -d agcount=4 -s size=512 -i attr=2 -i projid32bit=1 -m crc=1 -m finobt=0 -b size=4096 -i maxpct=25 -d sunit=0 -d swidth=0 -l version=2 -l lazy-count=1 -n size=4096 -n version=2 -r extsize=4096 /dev/sda1 meta-data=/dev/sda1 isize=512 agcount=4, agsize=65536 blks = sectsz=512 attr=2, projid32bit=1 = crc=1 finobt=0, sparse=0 data = bsize=4096 blocks=262144, imaxpct=25 = sunit=0 swidth=0 blks naming =version 2 bsize=4096 ascii-ci=0 ftype=1 log =internal log bsize=4096 blocks=2560, version=2 = sectsz=512 sunit=0 blks, lazy-count=1 realtime =none extsz=4096 blocks=0, rtextents=0 +++ LogPrint 'Mounting filesystem /boot' +++ Log 'Mounting filesystem /boot' +++ echo '393: 2020-11-26 06:12:39.472662248 Mounting filesystem /boot' 393: 2020-11-26 06:12:39.472662248 Mounting filesystem /boot +++ Print 'Mounting filesystem /boot' +++ mkdir -p /mnt/local/boot +++ mount -o rw,relatime,attr2,inode64,noquota /dev/sda1 /mnt/local/boot +++ component_created fs:/boot fs +++ local device=fs:/boot +++ local type=fs +++ local touchfile=fs-fs:-boot +++ touch /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/fs-fs:-boot +++ create_component fs:/home fs +++ local device=fs:/home +++ local type=fs +++ local touchfile=fs-fs:-home +++ '[' -e /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/fs-fs:-home ']' +++ return 0 +++ my_udevsettle +++ has_binary udevadm +++ for bin in '$@' +++ type udevadm +++ return 0 +++ udevadm settle +++ return 0 +++ LogPrint 'Creating filesystem of type xfs with mount point /home on /dev/sda5.' +++ Log 'Creating filesystem of type xfs with mount point /home on /dev/sda5.' +++ echo '393: 2020-11-26 06:12:39.538449746 Creating filesystem of type xfs with mount point /home on /dev/sda5.' 393: 2020-11-26 06:12:39.538449746 Creating filesystem of type xfs with mount point /home on /dev/sda5. +++ Print 'Creating filesystem of type xfs with mount point /home on /dev/sda5.' +++ wipefs --all --force /dev/sda5 /dev/sda5: 4 bytes were erased at offset 0x00000000 (xfs): 58 46 53 42 +++ mkfs.xfs -f -m uuid=62d9bbd6-579b-4348-b715-183c66984416 -i size=512 -d agcount=4 -s size=512 -i attr=2 -i projid32bit=1 -m crc=1 -m finobt=0 -b size=4096 -i maxpct=25 -d sunit=0 -d swidth=0 -l version=2 -l lazy-count=1 -n size=4096 -n version=2 -r extsize=4096 /dev/sda5 meta-data=/dev/sda5 isize=512 agcount=4, agsize=16646016 blks = sectsz=512 attr=2, projid32bit=1 = crc=1 finobt=0, sparse=0 data = bsize=4096 blocks=66584064, imaxpct=25 = sunit=0 swidth=0 blks naming =version 2 bsize=4096 ascii-ci=0 ftype=1 log =internal log bsize=4096 blocks=32511, version=2 = sectsz=512 sunit=0 blks, lazy-count=1 realtime =none extsz=4096 blocks=0, rtextents=0 +++ LogPrint 'Mounting filesystem /home' +++ Log 'Mounting filesystem /home' +++ echo '393: 2020-11-26 06:12:40.062564764 Mounting filesystem /home' 393: 2020-11-26 06:12:40.062564764 Mounting filesystem /home +++ Print 'Mounting filesystem /home' +++ mkdir -p /mnt/local/home +++ mount -o rw,relatime,attr2,inode64,noquota /dev/sda5 /mnt/local/home +++ component_created fs:/home fs +++ local device=fs:/home +++ local type=fs +++ local touchfile=fs-fs:-home +++ touch /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/fs-fs:-home +++ create_component swap:/dev/sda3 swap +++ local device=swap:/dev/sda3 +++ local type=swap +++ local touchfile=swap-swap:-dev-sda3 +++ '[' -e /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/swap-swap:-dev-sda3 ']' +++ return 0 +++ LogPrint 'Creating swap on /dev/sda3' +++ Log 'Creating swap on /dev/sda3' +++ echo '393: 2020-11-26 06:12:40.221445166 Creating swap on /dev/sda3' 393: 2020-11-26 06:12:40.221445166 Creating swap on /dev/sda3 +++ Print 'Creating swap on /dev/sda3' +++ mkswap -U e7cac23a-f0a2-44b1-af02-eaffd4b8e860 /dev/sda3 mkswap: /dev/sda3: warning: wiping old swap signature. Setting up swapspace version 1, size = 9437180 KiB no label, UUID=e7cac23a-f0a2-44b1-af02-eaffd4b8e860 +++ component_created swap:/dev/sda3 swap +++ local device=swap:/dev/sda3 +++ local type=swap +++ local touchfile=swap-swap:-dev-sda3 +++ touch /tmp/rear.9e6jf1d7uJRDoAN/tmp/touch/swap-swap:-dev-sda3 +++ set +x 393: 2020-11-26 06:12:40.267137187 Disk layout created. 393: 2020-11-26 06:12:40.271025811 Including layout/recreate/default/250_verify_mount.sh 393: 2020-11-26 06:12:40.272032380 Finished running 'layout/recreate' stage in 7 seconds 393: 2020-11-26 06:12:40.272952904 ====================== 393: 2020-11-26 06:12:40.274002110 Running 'restore' stage 393: 2020-11-26 06:12:40.274866091 ====================== 393: 2020-11-26 06:12:40.282009377 Including restore/default/050_remount_async.sh 393: 2020-11-26 06:12:40.284444291 Including restore/RSYNC/default/200_remove_relative_rsync_option.sh Usage: grep [OPTION]... PATTERN [FILE]... Try 'grep --help' for more information. 393: 2020-11-26 06:12:40.289086028 Including restore/RSYNC/default/400_restore_rsync_backup.sh 393: 2020-11-26 06:12:40.290636739 Restoring rsync archive from '192.168.1.123:rsync_backup' 393: 2020-11-26 06:18:47.018164404 Number of symlinks considered: 0 Number of other resources considered: 0 Number of files transferred: 170543 Total file size: 7878180085 bytes Total transferred file size: 6516000181 bytes Literal data: 6516000181 bytes Matched data: 0 bytes File list size: 6511159 File list generation time: 0.782 seconds File list transfer time: 0.000 seconds Total bytes sent: 6002137 Total bytes received: 3226105237 sent 6002137 bytes received 3226105237 bytes 8916158.27 bytes/sec in 366 seconds. 393: 2020-11-26 06:18:47.028017281 Including restore/default/500_selinux_autorelabel.sh 393: 2020-11-26 06:18:47.029476995 Created SELinux /mnt/local/.autorelabel file : after reboot SELinux will relabel all files 393: 2020-11-26 06:18:47.033911656 Including restore/RSYNC/default/800_copy_restore_log.sh gzip: /mnt/local//root/restore-20201126.*.log: No such file or directory 393: 2020-11-26 06:18:47.179755550 Including restore/default/900_create_missing_directories.sh /mnt/local ~ 393: 2020-11-26 06:18:47.181365797 Recreating directories (with permissions) from /var/lib/rear/recovery/directories_permissions_owner_group ~ 393: 2020-11-26 06:18:47.189226315 Including restore/default/990_move_away_restored_files.sh 393: 2020-11-26 06:18:47.326715859 Including restore/default/995_remount_sync.sh 393: 2020-11-26 06:18:47.327651850 Finished running 'restore' stage in 367 seconds 393: 2020-11-26 06:18:47.328928954 ====================== 393: 2020-11-26 06:18:47.329624429 Running 'finalize' stage 393: 2020-11-26 06:18:47.330383286 ====================== 393: 2020-11-26 06:18:47.337444181 Including finalize/default/050_prepare_checks.sh 393: 2020-11-26 06:18:47.341021865 Including finalize/default/110_bind_mount_proc_sys_dev_run.sh /proc is a mountpoint umount: /mnt/local/proc: not mounted /sys is a mountpoint umount: /mnt/local/sys: not mounted /dev is a mountpoint umount: /mnt/local/dev: not mounted /run is a mountpoint umount: /mnt/local/run: not mounted 393: 2020-11-26 06:18:47.358823563 Including finalize/GNU/Linux/240_reassign_luks_keyfiles.sh 393: 2020-11-26 06:18:47.363306977 Including finalize/GNU/Linux/250_migrate_disk_devices_layout.sh 393: 2020-11-26 06:18:47.366048817 Including finalize/GNU/Linux/250_migrate_lun_wwid.sh 393: 2020-11-26 06:18:47.368446690 Including finalize/GNU/Linux/260_rename_diskbyid.sh device node not found device node not found device node not found device node not found device node not found device node not found 393: 2020-11-26 06:18:47.407484275 Migrating disk-by-id mappings in certain restored files in /mnt/local to current disk-by-id mappings ... '/mnt/local//etc/fstab' -> '/mnt/local//etc/fstab.rearbak' '/mnt/local//boot/grub2/grub.cfg' -> '/mnt/local//boot/grub2/grub.cfg.rearbak' '/mnt/local//etc/lvm/lvm.conf' -> '/mnt/local//etc/lvm/lvm.conf.rearbak' 393: 2020-11-26 06:18:47.886606237 Including finalize/GNU/Linux/280_migrate_uuid_tags.sh 393: 2020-11-26 06:18:47.889024101 Including finalize/GNU/Linux/300_create_mac_mapping.sh 393: 2020-11-26 06:18:47.939072995 Including finalize/GNU/Linux/310_migrate_udev_rules.sh 393: 2020-11-26 06:18:47.941903670 Including finalize/GNU/Linux/320_migrate_network_configuration_files.sh 393: 2020-11-26 06:18:47.944068166 Patching /mnt/local/etc/sysconfig/network-scripts/ifcfg-enp0s3 393: 2020-11-26 06:18:47.945453200 Patching /mnt/local/etc/sysconfig/network-scripts/ifcfg-lo mkdir: created directory '/tmp/rear.9e6jf1d7uJRDoAN/tmp/mappings' 393: 2020-11-26 06:18:47.951676614 Migrating restored network configuration files according to the mapping files ... 393: 2020-11-26 06:18:47.954028879 Rewriting changed MAC addresses and network interfaces 393: 2020-11-26 06:18:47.983285815 Wrote new MAC addresses and network interfaces in /mnt/local/etc/sysconfig/network-scripts/ifcfg-enp0s3 393: 2020-11-26 06:18:47.985472851 Wrote new MAC addresses and network interfaces in /mnt/local/etc/sysconfig/network-scripts/ifcfg-lo 393: 2020-11-26 06:18:47.992665203 Including finalize/GNU/Linux/430_create_multipath_config.sh /usr/share/rear/finalize/GNU/Linux/430_create_multipath_config.sh: line 8: multipath: command not found 393: 2020-11-26 06:18:47.995326306 Including finalize/default/520_confirm_finalize.sh 393: 2020-11-26 06:18:47.998173003 Including finalize/Linux-i386/610_EFISTUB_run_efibootmgr.sh 393: 2020-11-26 06:18:48.001334395 Including finalize/Linux-i386/630_install_grub.sh /sbin/grub2-probe 393: 2020-11-26 06:18:48.002691943 Skip installing GRUB Legacy boot loader because GRUB 2 is installed (grub-probe or grub2-probe exist). 393: 2020-11-26 06:18:48.006071564 Including finalize/Linux-i386/640_install_lilo.sh 393: 2020-11-26 06:18:48.008518191 Including finalize/Linux-i386/650_install_elilo.sh 393: 2020-11-26 06:18:48.010859334 Including finalize/Linux-i386/660_install_grub2.sh /sbin/grub2-probe 393: 2020-11-26 06:18:48.012047898 Installing GRUB2 boot loader... Generating grub configuration file ... Found linux image: /boot/vmlinuz-3.10.0-1160.6.1.el7.centos.plus.i686 Found initrd image: /boot/initramfs-3.10.0-1160.6.1.el7.centos.plus.i686.img Found linux image: /boot/vmlinuz-3.10.0-1127.el7.centos.plus.i686 Found initrd image: /boot/initramfs-3.10.0-1127.el7.centos.plus.i686.img Found linux image: /boot/vmlinuz-0-rescue-f9e557d41f5f4381ac6b8171d4e901c8 Found initrd image: /boot/initramfs-0-rescue-f9e557d41f5f4381ac6b8171d4e901c8.img done 393: 2020-11-26 06:18:51.286096126 Determining where to install GRUB2 (no GRUB2_INSTALL_DEVICES specified) 393: 2020-11-26 06:18:51.309948254 Found possible boot disk /dev/sda - installing GRUB2 there Installing for i386-pc platform. Installation finished. No error reported. 393: 2020-11-26 06:18:52.588727625 Including finalize/Linux-i386/670_run_efibootmgr.sh 393: 2020-11-26 06:18:52.591552167 Including finalize/default/880_check_for_mount_by_id.sh 393: 2020-11-26 06:18:52.595551877 Including finalize/default/890_finish_checks.sh 393: 2020-11-26 06:18:52.600990842 Including finalize/default/900_remount_sync.sh 393: 2020-11-26 06:18:52.601931352 Finished running 'finalize' stage in 5 seconds 393: 2020-11-26 06:18:52.602734563 ====================== 393: 2020-11-26 06:18:52.603505312 Running 'wrapup' stage 393: 2020-11-26 06:18:52.604321825 ====================== 393: 2020-11-26 06:18:52.611525798 Including wrapup/default/500_post_recovery_script.sh 393: 2020-11-26 06:18:52.620621013 Including wrapup/default/980_good_bye.sh 393: 2020-11-26 06:18:52.640256657 Including wrapup/default/990_copy_logfile.sh '/mnt/local//root/rear-2020-11-26T06:18:52-0500.log' -> '/var/log/rear/recover/rear-snigdhacentos32.log' 393: 2020-11-26 06:18:52.654072249 Finished running 'wrapup' stage in 0 seconds 393: 2020-11-26 06:18:52.654895960 Finished running recover workflow 393: 2020-11-26 06:18:52.657761215 Exiting rear recover (PID 393) and its descendant processes ... 393: 2020-11-26 06:18:55.665549143 rear,393 /bin/rear -v recover `-rear,4756 /bin/rear -v recover `-pstree,4757 -Aplau 393 /usr/share/rear/lib/_input-output-functions.sh: line 151: kill: (4760) - No such process 393: 2020-11-26 06:18:55.676638280 Running exit tasks 393: 2020-11-26 06:18:55.686627883 Finished in 409 seconds 393: 2020-11-26 06:18:55.687609414 Removing build area /tmp/rear.9e6jf1d7uJRDoAN removed directory: '/tmp/rear.9e6jf1d7uJRDoAN' 393: 2020-11-26 06:18:55.694550705 End of program reached