IFW 2.80 occasionally leaves 2 processes running.
Posted: Tue Mar 26, 2013 2:44 am
I'm currently testing some changes I'm making to my IFW_Backup DOS
scripts. These tests involve taking full, differential, & incremental
backups of very small partitions. (The backups just take a few
seconds).
After one of many identical Diff image runs, my batch program hung,
using no CPU or Disk. The IFW window had closed, and later examination
of the log showed that the image had finished successfully.
Task manager showed 2 imagew.exe tasks still running, which I did 'end
process tree' on.
Below are the logs for the run. The batch script runs IFW 3 times on 3
different partitions using the DOS 'start /w ...' command for each
invocation.
As I said earlier, identical runs have worked fine, except for this
one. Looks like a subtle bug has crept into IFW?
The logs:-
>[26/03/2013 2:45:41 p.m] /b /base:E:\Test\Tom's Utility Backup\2013-03-26@144409_Full_A_0 /f:E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_A_0 /v /mf /logfile:E:\Test\Tom's Utility Backup\IFW.log
>[26/03/2013 2:45:41 p.m] Image for Windows 2.80 (GUI)
>[26/03/2013 2:45:41 p.m] Starting ...
>imagew.exe /b /base:"E:\Test\Tom's Utility Backup\2013-03-26@144409_Full_A_0" /f:"E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_A_0" /v
>[26/03/2013 2:45:41 p.m] PHYLock is waiting for drive writing to stop ...
>[26/03/2013 2:45:45 p.m] PHYLock Started
>[26/03/2013 2:45:45 p.m] PHYLock Using RAM
>[26/03/2013 2:45:45 p.m] PHYLock version 10
>[26/03/2013 2:45:45 p.m] Backup: Drive 0 Dummy Volume (8183) 8 MiB FAT-16 (0-32MB)
>[26/03/2013 2:45:45 p.m] To: E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_A_0.TBI
>[26/03/2013 2:45:45 p.m] INFO: Total Sectors:16002 Total Allocated:69
>[26/03/2013 2:45:45 p.m] INFO: 0 Sector(s) backed up
>[26/03/2013 2:45:45 p.m] Validating: Dummy Volume (8183) 8 MiB FAT-16 (0-32MB)
>[26/03/2013 2:45:45 p.m] From: E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_A_0.TBI
>[26/03/2013 2:45:45 p.m] Operation Completed with Error Code 0
>[26/03/2013 2:45:45 p.m] Stop
>--------------------------------------------------------------------------
>[26/03/2013 2:45:45 p.m] /b /base:E:\Test\Tom's Utility Backup\2013-03-26@144409_Full_A_1 /f:E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_A_1 /v /mf /logfile:E:\Test\Tom's Utility Backup\IFW.log
>[26/03/2013 2:45:45 p.m] Image for Windows 2.80 (GUI)
>[26/03/2013 2:45:45 p.m] Starting ...
>imagew.exe /b /base:"E:\Test\Tom's Utility Backup\2013-03-26@144409_Full_A_1" /f:"E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_A_1" /v
>[26/03/2013 2:45:45 p.m] PHYLock is waiting for drive writing to stop ...
>[26/03/2013 2:45:50 p.m] PHYLock Started
>[26/03/2013 2:45:50 p.m] PHYLock Using RAM
>[26/03/2013 2:45:50 p.m] PHYLock version 10
>[26/03/2013 2:45:50 p.m] Backup: Drive 0 BootIt EMBRM Partition (80) 8 MiB BootIt EMBRM
>[26/03/2013 2:45:50 p.m] To: E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_A_1.TBI
>[26/03/2013 2:45:50 p.m] INFO: Total Sectors:16065 Total Allocated:5453
>[26/03/2013 2:45:50 p.m] INFO: 0 Sector(s) backed up
>[26/03/2013 2:45:50 p.m] Validating: BootIt EMBRM Partition (80) 8 MiB BootIt EMBRM
>[26/03/2013 2:45:50 p.m] From: E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_A_1.TBI
>[26/03/2013 2:45:50 p.m] Operation Completed with Error Code 0
>[26/03/2013 2:45:50 p.m] Stop
>--------------------------------------------------------------------------
>[26/03/2013 2:45:50 p.m] /b /base:E:\Test\Tom's Utility Backup\2013-03-26@144409_Full_B /f:E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_B /v /mf /logfile:E:\Test\Tom's Utility Backup\IFW.log
>[26/03/2013 2:45:50 p.m] Image for Windows 2.80 (GUI)
>[26/03/2013 2:45:50 p.m] Starting ...
>imagew.exe /b /base:"E:\Test\Tom's Utility Backup\2013-03-26@144409_Full_B" /f:"E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_B" /v
>[26/03/2013 2:45:50 p.m] PHYLock is waiting for drive writing to stop ...
>[26/03/2013 2:45:55 p.m] PHYLock Started
>[26/03/2013 2:45:55 p.m] PHYLock Using RAM
>[26/03/2013 2:45:55 p.m] PHYLock version 10
>[26/03/2013 2:45:55 p.m] Backup: Drive 0 BootIt EMBRM Partition (80) 8 MiB BootIt EMBRM
>[26/03/2013 2:45:55 p.m] To: E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_B.TBI
>[26/03/2013 2:45:55 p.m] INFO: Total Sectors:16065 Total Allocated:5453
>[26/03/2013 2:45:55 p.m] INFO: 0 Sector(s) backed up
>[26/03/2013 2:45:55 p.m] Validating: BootIt EMBRM Partition (80) 8 MiB BootIt EMBRM
>[26/03/2013 2:45:55 p.m] From: E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_B.TBI
>[26/03/2013 2:45:55 p.m] Operation Completed with Error Code 0
>[26/03/2013 2:45:55 p.m] Stop
>--------------------------------------------------------------------------
scripts. These tests involve taking full, differential, & incremental
backups of very small partitions. (The backups just take a few
seconds).
After one of many identical Diff image runs, my batch program hung,
using no CPU or Disk. The IFW window had closed, and later examination
of the log showed that the image had finished successfully.
Task manager showed 2 imagew.exe tasks still running, which I did 'end
process tree' on.
Below are the logs for the run. The batch script runs IFW 3 times on 3
different partitions using the DOS 'start /w ...' command for each
invocation.
As I said earlier, identical runs have worked fine, except for this
one. Looks like a subtle bug has crept into IFW?
The logs:-
>[26/03/2013 2:45:41 p.m] /b /base:E:\Test\Tom's Utility Backup\2013-03-26@144409_Full_A_0 /f:E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_A_0 /v /mf /logfile:E:\Test\Tom's Utility Backup\IFW.log
>[26/03/2013 2:45:41 p.m] Image for Windows 2.80 (GUI)
>[26/03/2013 2:45:41 p.m] Starting ...
>imagew.exe /b /base:"E:\Test\Tom's Utility Backup\2013-03-26@144409_Full_A_0" /f:"E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_A_0" /v
>[26/03/2013 2:45:41 p.m] PHYLock is waiting for drive writing to stop ...
>[26/03/2013 2:45:45 p.m] PHYLock Started
>[26/03/2013 2:45:45 p.m] PHYLock Using RAM
>[26/03/2013 2:45:45 p.m] PHYLock version 10
>[26/03/2013 2:45:45 p.m] Backup: Drive 0 Dummy Volume (8183) 8 MiB FAT-16 (0-32MB)
>[26/03/2013 2:45:45 p.m] To: E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_A_0.TBI
>[26/03/2013 2:45:45 p.m] INFO: Total Sectors:16002 Total Allocated:69
>[26/03/2013 2:45:45 p.m] INFO: 0 Sector(s) backed up
>[26/03/2013 2:45:45 p.m] Validating: Dummy Volume (8183) 8 MiB FAT-16 (0-32MB)
>[26/03/2013 2:45:45 p.m] From: E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_A_0.TBI
>[26/03/2013 2:45:45 p.m] Operation Completed with Error Code 0
>[26/03/2013 2:45:45 p.m] Stop
>--------------------------------------------------------------------------
>[26/03/2013 2:45:45 p.m] /b /base:E:\Test\Tom's Utility Backup\2013-03-26@144409_Full_A_1 /f:E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_A_1 /v /mf /logfile:E:\Test\Tom's Utility Backup\IFW.log
>[26/03/2013 2:45:45 p.m] Image for Windows 2.80 (GUI)
>[26/03/2013 2:45:45 p.m] Starting ...
>imagew.exe /b /base:"E:\Test\Tom's Utility Backup\2013-03-26@144409_Full_A_1" /f:"E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_A_1" /v
>[26/03/2013 2:45:45 p.m] PHYLock is waiting for drive writing to stop ...
>[26/03/2013 2:45:50 p.m] PHYLock Started
>[26/03/2013 2:45:50 p.m] PHYLock Using RAM
>[26/03/2013 2:45:50 p.m] PHYLock version 10
>[26/03/2013 2:45:50 p.m] Backup: Drive 0 BootIt EMBRM Partition (80) 8 MiB BootIt EMBRM
>[26/03/2013 2:45:50 p.m] To: E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_A_1.TBI
>[26/03/2013 2:45:50 p.m] INFO: Total Sectors:16065 Total Allocated:5453
>[26/03/2013 2:45:50 p.m] INFO: 0 Sector(s) backed up
>[26/03/2013 2:45:50 p.m] Validating: BootIt EMBRM Partition (80) 8 MiB BootIt EMBRM
>[26/03/2013 2:45:50 p.m] From: E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_A_1.TBI
>[26/03/2013 2:45:50 p.m] Operation Completed with Error Code 0
>[26/03/2013 2:45:50 p.m] Stop
>--------------------------------------------------------------------------
>[26/03/2013 2:45:50 p.m] /b /base:E:\Test\Tom's Utility Backup\2013-03-26@144409_Full_B /f:E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_B /v /mf /logfile:E:\Test\Tom's Utility Backup\IFW.log
>[26/03/2013 2:45:50 p.m] Image for Windows 2.80 (GUI)
>[26/03/2013 2:45:50 p.m] Starting ...
>imagew.exe /b /base:"E:\Test\Tom's Utility Backup\2013-03-26@144409_Full_B" /f:"E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_B" /v
>[26/03/2013 2:45:50 p.m] PHYLock is waiting for drive writing to stop ...
>[26/03/2013 2:45:55 p.m] PHYLock Started
>[26/03/2013 2:45:55 p.m] PHYLock Using RAM
>[26/03/2013 2:45:55 p.m] PHYLock version 10
>[26/03/2013 2:45:55 p.m] Backup: Drive 0 BootIt EMBRM Partition (80) 8 MiB BootIt EMBRM
>[26/03/2013 2:45:55 p.m] To: E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_B.TBI
>[26/03/2013 2:45:55 p.m] INFO: Total Sectors:16065 Total Allocated:5453
>[26/03/2013 2:45:55 p.m] INFO: 0 Sector(s) backed up
>[26/03/2013 2:45:55 p.m] Validating: BootIt EMBRM Partition (80) 8 MiB BootIt EMBRM
>[26/03/2013 2:45:55 p.m] From: E:\Test\Tom's Utility Backup\2013-03-26@144540_Diff_B.TBI
>[26/03/2013 2:45:55 p.m] Operation Completed with Error Code 0
>[26/03/2013 2:45:55 p.m] Stop
>--------------------------------------------------------------------------